builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0240 starttime: 1487080520.23 results: success (0) buildid: 20170214043845 builduid: 79e4849908364f1fb924d5fa9f617830 revision: 47391e531350873bfccd576b689259ec249aede8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.228628) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.229085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.229361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.255907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.256311) ========= 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.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-14 05:55:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-02-14 05:55:20 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.402834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.403197) ========= 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.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.020666 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:20.453411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 05:55:20.454019) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47391e531350873bfccd576b689259ec249aede8 --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 47391e531350873bfccd576b689259ec249aede8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-14 05:55:20,542 truncating revision to first 12 chars 2017-02-14 05:55:20,542 Setting DEBUG logging. 2017-02-14 05:55:20,542 attempt 1/10 2017-02-14 05:55:20,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47391e531350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 05:55:21,777 unpacking tar archive at: mozilla-central-47391e531350/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 05:55:21.971525) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:21.971880) ========= script_repo_revision: 47391e531350873bfccd576b689259ec249aede8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:21.972420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:21.972818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:21.993213) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-14 05:55:21.993489) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:55:22 INFO - MultiFileLogger online at 20170214 05:55:22 in /builds/slave/test 05:55:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:55:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:55:22 INFO - {'append_to_log': False, 05:55:22 INFO - 'base_work_dir': '/builds/slave/test', 05:55:22 INFO - 'blob_upload_branch': 'Firefox', 05:55:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:55:22 INFO - 'branch': 'Firefox', 05:55:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:55:22 INFO - 'config_files': ('talos/mac_config.py',), 05:55:22 INFO - 'default_actions': ('clobber', 05:55:22 INFO - 'read-buildbot-config', 05:55:22 INFO - 'download-and-extract', 05:55:22 INFO - 'populate-webroot', 05:55:22 INFO - 'create-virtualenv', 05:55:22 INFO - 'install', 05:55:22 INFO - 'run-tests'), 05:55:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:55:22 INFO - 'download_minidump_stackwalk': True, 05:55:22 INFO - 'download_symbols': 'ondemand', 05:55:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:55:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:55:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:55:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:55:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:55:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:55:22 INFO - 'installer_path': 'installer.exe', 05:55:22 INFO - 'log_level': 'info', 05:55:22 INFO - 'log_name': 'talos', 05:55:22 INFO - 'log_to_console': True, 05:55:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:55:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:55:22 INFO - 'opt_config_files': (), 05:55:22 INFO - 'pip_index': False, 05:55:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:22 INFO - 'cmd': ('bash', 05:55:22 INFO - '-c', 05:55:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:22 INFO - 'enabled': True, 05:55:22 INFO - 'halt_on_failure': False, 05:55:22 INFO - 'name': 'check_screen_resolution'},), 05:55:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:22 INFO - 'cmd': ('bash', 05:55:22 INFO - '-c', 05:55:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:22 INFO - 'enabled': True, 05:55:22 INFO - 'halt_on_failure': False, 05:55:22 INFO - 'name': 'check_screen_resolution'},), 05:55:22 INFO - 'run_cmd_checks_enabled': True, 05:55:22 INFO - 'sps_profile': False, 05:55:22 INFO - 'sps_profile_interval': 0, 05:55:22 INFO - 'suite': 'dromaeojs-e10s', 05:55:22 INFO - 'system_bits': '32', 05:55:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:55:22 INFO - 'title': 't-yosemite-r7-0240', 05:55:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:55:22 INFO - 'use_talos_json': True, 05:55:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:55:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:55:22 INFO - 'work_dir': 'build'} 05:55:22 INFO - [mozharness: 2017-02-14 13:55:22.202438Z] Running clobber step. 05:55:22 INFO - Running pre-action listener: _resource_record_pre_action 05:55:22 INFO - Running main action method: clobber 05:55:22 INFO - rmtree: /builds/slave/test/build 05:55:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:55:24 INFO - Running post-action listener: _resource_record_post_action 05:55:24 INFO - [mozharness: 2017-02-14 13:55:24.090629Z] Finished clobber step (success) 05:55:24 INFO - [mozharness: 2017-02-14 13:55:24.090880Z] Running read-buildbot-config step. 05:55:24 INFO - Running pre-action listener: _resource_record_pre_action 05:55:24 INFO - Running main action method: read_buildbot_config 05:55:24 INFO - Using buildbot properties: 05:55:24 INFO - { 05:55:24 INFO - "project": "", 05:55:24 INFO - "product": "firefox", 05:55:24 INFO - "script_repo_revision": "production", 05:55:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:55:24 INFO - "repository": "", 05:55:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:55:24 INFO - "buildid": "20170214043845", 05:55:24 INFO - "pgo_build": "False", 05:55:24 INFO - "basedir": "/builds/slave/test", 05:55:24 INFO - "buildnumber": 139, 05:55:24 INFO - "slavename": "t-yosemite-r7-0240", 05:55:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:55:24 INFO - "platform": "yosemite_r7", 05:55:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:55:24 INFO - "branch": "mozilla-central", 05:55:24 INFO - "repo_path": "mozilla-central", 05:55:24 INFO - "revision": "47391e531350873bfccd576b689259ec249aede8", 05:55:24 INFO - "stage_platform": "macosx64", 05:55:24 INFO - "builduid": "79e4849908364f1fb924d5fa9f617830", 05:55:24 INFO - "slavebuilddir": "test" 05:55:24 INFO - } 05:55:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 05:55:24 INFO - Running post-action listener: _resource_record_post_action 05:55:24 INFO - [mozharness: 2017-02-14 13:55:24.096478Z] Finished read-buildbot-config step (success) 05:55:24 INFO - [mozharness: 2017-02-14 13:55:24.096680Z] Running download-and-extract step. 05:55:24 INFO - Running pre-action listener: _resource_record_pre_action 05:55:24 INFO - Running main action method: download_and_extract 05:55:24 INFO - mkdir: /builds/slave/test/build/tests 05:55:24 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')]} 05:55:24 INFO - trying https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 05:55:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:55:25 INFO - Downloaded 1199 bytes. 05:55:25 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:55:25 INFO - Using the following test package requirements: 05:55:25 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:55:25 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:55:25 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:55:25 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'jsshell-mac.zip'], 05:55:25 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:55:25 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:55:25 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:55:25 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:55:25 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:55:25 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:55:25 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:55:25 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:55:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:55:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:55:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:55:26 INFO - Expected file size: 51503961 05:55:26 INFO - Obtained file size: 51503961 05:55:42 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:55:44 INFO - Expected file size: 51503961 05:55:44 INFO - Obtained file size: 51503961 05:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 05:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:56:00 INFO - Expected file size: 14403647 05:56:00 INFO - Obtained file size: 14403647 05:56: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')]} 05:56:01 INFO - trying https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:56:03 INFO - Downloaded 70416439 bytes. 05:56:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:03 INFO - mkdir: /builds/slave/test/properties 05:56:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:03 INFO - Contents: 05:56:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:03 INFO - Running post-action listener: _resource_record_post_action 05:56:03 INFO - Running post-action listener: set_extra_try_arguments 05:56:03 INFO - [mozharness: 2017-02-14 13:56:03.953242Z] Finished download-and-extract step (success) 05:56:03 INFO - [mozharness: 2017-02-14 13:56:03.953386Z] Running populate-webroot step. 05:56:03 INFO - Running pre-action listener: _resource_record_pre_action 05:56:03 INFO - Running main action method: populate_webroot 05:56:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:03 INFO - '--tppagecycles', 05:56:03 INFO - '7'], 05:56:03 INFO - 'tests': ['tsvgm']}}, 05:56:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['damp', 'tps']}, 05:56:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'tests': ['damp', 'tps']}, 05:56:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['dromaeo_dom']}, 05:56:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['basic_compositor_video']}, 05:56:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:56:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['a11yr', 05:56:03 INFO - 'ts_paint', 05:56:03 INFO - 'tpaint', 05:56:03 INFO - 'sessionrestore', 05:56:03 INFO - 'sessionrestore_no_auto_restore', 05:56:03 INFO - 'tabpaint']}, 05:56:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['tsvgx', 05:56:03 INFO - 'tsvgr_opacity', 05:56:03 INFO - 'tart', 05:56:03 INFO - 'tscrollx', 05:56:03 INFO - 'cart', 05:56:03 INFO - 'tsvg_static']}, 05:56:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:03 INFO - 'tsvgr_opacity', 05:56:03 INFO - 'tart', 05:56:03 INFO - 'tscrollx', 05:56:03 INFO - 'cart', 05:56:03 INFO - 'tsvg_static']}, 05:56:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'talos_options': ['--disable-e10s'], 05:56:03 INFO - 'tests': ['tp5o']}, 05:56:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:56:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'talos_options': ['--disable-e10s', 05:56:03 INFO - '--xperf_path', 05:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:03 INFO - 'tests': ['tp5n']}, 05:56:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:56:03 INFO - 'talos_options': ['--xperf_path', 05:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:03 INFO - 'tests': ['tp5n']}}, 05:56:03 INFO - 'talos.zip': {'path': '', 05:56:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:03 INFO - Running post-action listener: _resource_record_post_action 05:56:03 INFO - [mozharness: 2017-02-14 13:56:03.971898Z] Finished populate-webroot step (success) 05:56:03 INFO - [mozharness: 2017-02-14 13:56:03.972031Z] Running create-virtualenv step. 05:56:03 INFO - Running pre-action listener: _resource_record_pre_action 05:56:03 INFO - Running main action method: create_virtualenv 05:56:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:03 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 05:56:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:04 INFO - Using real prefix '/tools/python27' 05:56:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:07 INFO - Installing pip.................done. 05:56:07 INFO - Return code: 0 05:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:56:07 INFO - Reading from file tmpfile_stdout 05:56:07 INFO - Output received: 05:56:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:56:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:07 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')]} 05:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:07 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')]} 05:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:07 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:07 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 05:56:07 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 05:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:07 INFO - 'HOME': '/Users/cltbld', 05:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:07 INFO - 'LOGNAME': 'cltbld', 05:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:07 INFO - 'MOZ_NO_REMOTE': '1', 05:56:07 INFO - 'NO_EM_RESTART': '1', 05:56:07 INFO - 'PAGER': '/bin/cat', 05:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:07 INFO - 'PWD': '/builds/slave/test', 05:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:07 INFO - 'SHELL': '/bin/bash', 05:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:07 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:07 INFO - 'USER': 'cltbld', 05:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:07 INFO - 'XPC_FLAGS': '0x0', 05:56:07 INFO - 'XPC_SERVICE_NAME': '0', 05:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:08 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 05:56:08 INFO - Cleaning up... 05:56:08 INFO - Return code: 0 05:56:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:08 INFO - 'HOME': '/Users/cltbld', 05:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:08 INFO - 'LOGNAME': 'cltbld', 05:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:08 INFO - 'MOZ_NO_REMOTE': '1', 05:56:08 INFO - 'NO_EM_RESTART': '1', 05:56:08 INFO - 'PAGER': '/bin/cat', 05:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:08 INFO - 'PWD': '/builds/slave/test', 05:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:08 INFO - 'SHELL': '/bin/bash', 05:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:08 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:08 INFO - 'USER': 'cltbld', 05:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:08 INFO - 'XPC_FLAGS': '0x0', 05:56:08 INFO - 'XPC_SERVICE_NAME': '0', 05:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:08 INFO - Downloading/unpacking psutil>=3.1.1 05:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:12 INFO - Installing collected packages: psutil 05:56:12 INFO - Running setup.py install for psutil 05:56:12 INFO - building 'psutil._psutil_osx' extension 05:56:12 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 05:56:12 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 05:56:12 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 05:56:12 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 05:56:12 INFO - building 'psutil._psutil_posix' extension 05:56:12 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 05:56:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:56:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:56:12 INFO - ^ 05:56:12 INFO - 1 warning generated. 05:56:12 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 05:56:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:13 INFO - Successfully installed psutil 05:56:13 INFO - Cleaning up... 05:56:13 INFO - Return code: 0 05:56:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:13 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:13 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 05:56:13 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 05:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:13 INFO - 'HOME': '/Users/cltbld', 05:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:13 INFO - 'LOGNAME': 'cltbld', 05:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:13 INFO - 'MOZ_NO_REMOTE': '1', 05:56:13 INFO - 'NO_EM_RESTART': '1', 05:56:13 INFO - 'PAGER': '/bin/cat', 05:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:13 INFO - 'PWD': '/builds/slave/test', 05:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:13 INFO - 'SHELL': '/bin/bash', 05:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:13 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:13 INFO - 'USER': 'cltbld', 05:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:13 INFO - 'XPC_FLAGS': '0x0', 05:56:13 INFO - 'XPC_SERVICE_NAME': '0', 05:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:56:13 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 05:56:13 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 05:56:13 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 05:56:13 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 05:56:13 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 05:56:13 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 05:56:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:56:15 INFO - Installing collected packages: mozsystemmonitor 05:56:15 INFO - Running setup.py install for mozsystemmonitor 05:56:16 INFO - Successfully installed mozsystemmonitor 05:56:16 INFO - Cleaning up... 05:56:16 INFO - Return code: 0 05:56:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:56:16 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')]} 05:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:17 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:17 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 05:56:17 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 05:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:17 INFO - 'HOME': '/Users/cltbld', 05:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:17 INFO - 'LOGNAME': 'cltbld', 05:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:17 INFO - 'MOZ_NO_REMOTE': '1', 05:56:17 INFO - 'NO_EM_RESTART': '1', 05:56:17 INFO - 'PAGER': '/bin/cat', 05:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:17 INFO - 'PWD': '/builds/slave/test', 05:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:17 INFO - 'SHELL': '/bin/bash', 05:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:17 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:17 INFO - 'USER': 'cltbld', 05:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:17 INFO - 'XPC_FLAGS': '0x0', 05:56:17 INFO - 'XPC_SERVICE_NAME': '0', 05:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:56:17 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 05:56:17 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 05:56:17 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 05:56:17 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 05:56:17 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 05:56:17 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 05:56:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:21 INFO - warning: no files found matching '*.txt' 05:56:21 INFO - no previously-included directories found matching 'build' 05:56:21 INFO - no previously-included directories found matching 'dist' 05:56:21 INFO - no previously-included directories found matching '.git*' 05:56:21 INFO - Installing collected packages: jsonschema, functools32 05:56:21 INFO - Running setup.py install for functools32 05:56:21 INFO - warning: no files found matching '*.txt' 05:56:21 INFO - no previously-included directories found matching 'build' 05:56:21 INFO - no previously-included directories found matching 'dist' 05:56:21 INFO - no previously-included directories found matching '.git*' 05:56:21 INFO - Successfully installed jsonschema functools32 05:56:21 INFO - Cleaning up... 05:56:21 INFO - Return code: 0 05:56:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', '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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:56: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 functools32==3.2.3-2 05:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:21 INFO - 'HOME': '/Users/cltbld', 05:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:21 INFO - 'LOGNAME': 'cltbld', 05:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:21 INFO - 'MOZ_NO_REMOTE': '1', 05:56:21 INFO - 'NO_EM_RESTART': '1', 05:56:21 INFO - 'PAGER': '/bin/cat', 05:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:21 INFO - 'PWD': '/builds/slave/test', 05:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:21 INFO - 'SHELL': '/bin/bash', 05:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:21 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:21 INFO - 'USER': 'cltbld', 05:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:21 INFO - 'XPC_FLAGS': '0x0', 05:56:21 INFO - 'XPC_SERVICE_NAME': '0', 05:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:56:22 INFO - Cleaning up... 05:56:22 INFO - Return code: 0 05:56:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:22 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 05:56:22 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 05:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:22 INFO - 'HOME': '/Users/cltbld', 05:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:22 INFO - 'LOGNAME': 'cltbld', 05:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:22 INFO - 'MOZ_NO_REMOTE': '1', 05:56:22 INFO - 'NO_EM_RESTART': '1', 05:56:22 INFO - 'PAGER': '/bin/cat', 05:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:22 INFO - 'PWD': '/builds/slave/test', 05:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:22 INFO - 'SHELL': '/bin/bash', 05:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:22 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:22 INFO - 'USER': 'cltbld', 05:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:22 INFO - 'XPC_FLAGS': '0x0', 05:56:22 INFO - 'XPC_SERVICE_NAME': '0', 05:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:56:22 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 05:56:22 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 05:56:22 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 05:56:22 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 05:56:22 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 05:56:22 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 05:56:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:24 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 05:56:24 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 05:56:24 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 05:56:24 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 05:56:24 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 05:56:24 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 05:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:26 INFO - Downloading docopt-0.6.1.tar.gz 05:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:26 INFO - Running setup.py install for blobuploader 05:56:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:26 INFO - Running setup.py install for requests 05:56:26 INFO - Running setup.py install for docopt 05:56:26 INFO - Successfully installed blobuploader requests docopt 05:56:26 INFO - Cleaning up... 05:56:27 INFO - Return code: 0 05:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:27 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:27 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 05:56:27 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 05:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:27 INFO - 'HOME': '/Users/cltbld', 05:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:27 INFO - 'LOGNAME': 'cltbld', 05:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:27 INFO - 'MOZ_NO_REMOTE': '1', 05:56:27 INFO - 'NO_EM_RESTART': '1', 05:56:27 INFO - 'PAGER': '/bin/cat', 05:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:27 INFO - 'PWD': '/builds/slave/test', 05:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:27 INFO - 'SHELL': '/bin/bash', 05:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:27 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:27 INFO - 'USER': 'cltbld', 05:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:27 INFO - 'XPC_FLAGS': '0x0', 05:56:27 INFO - 'XPC_SERVICE_NAME': '0', 05:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-p2Il6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-RFYgXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-0eLIR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4Z7zFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-XVbdRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9dnJWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:27 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-c6YU0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-6h4dkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-7yHdux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-H7IFrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-dz5QiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-v0VaA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-jd1Ajd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-_BNh_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-TaPb8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:28 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-OS1KUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:29 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-3oF44Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:56:29 INFO - Running setup.py install for manifestparser 05:56:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:56:29 INFO - Running setup.py install for mozcrash 05:56:29 INFO - Running setup.py install for mozdebug 05:56:29 INFO - Running setup.py install for mozdevice 05:56:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:56:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:56:29 INFO - Running setup.py install for mozfile 05:56:29 INFO - Running setup.py install for mozhttpd 05:56:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:56:29 INFO - Running setup.py install for mozinfo 05:56:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Running setup.py install for mozInstall 05:56:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Running setup.py install for mozleak 05:56:30 INFO - Running setup.py install for mozlog 05:56:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Running setup.py install for moznetwork 05:56:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:56:30 INFO - Running setup.py install for mozprocess 05:56:30 INFO - Running setup.py install for mozprofile 05:56:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:56:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:56:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:56:31 INFO - Running setup.py install for mozrunner 05:56:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:56:31 INFO - Running setup.py install for mozscreenshot 05:56:31 INFO - Running setup.py install for moztest 05:56:31 INFO - Running setup.py install for mozversion 05:56:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:56:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:56:31 INFO - Cleaning up... 05:56:31 INFO - Return code: 0 05:56:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:31 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:31 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 05:56:31 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 05:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:31 INFO - 'HOME': '/Users/cltbld', 05:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:31 INFO - 'LOGNAME': 'cltbld', 05:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:31 INFO - 'MOZ_NO_REMOTE': '1', 05:56:31 INFO - 'NO_EM_RESTART': '1', 05:56:31 INFO - 'PAGER': '/bin/cat', 05:56:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:31 INFO - 'PWD': '/builds/slave/test', 05:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:31 INFO - 'SHELL': '/bin/bash', 05:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:31 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:31 INFO - 'USER': 'cltbld', 05:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:31 INFO - 'XPC_FLAGS': '0x0', 05:56:31 INFO - 'XPC_SERVICE_NAME': '0', 05:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-dKvph5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-c_8xkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-2TpKNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-lmY9b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-dQ0ZGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-JfAX8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-rFNstG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mGoZlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QlMbdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:32 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)) 05:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:32 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-7b9hoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-HIyouf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:33 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)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-e_wwxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-2iWyrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:33 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)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZSNFVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-AW6lhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:33 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)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-rwVy0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:33 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-PLP0qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:33 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)) 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:56:33 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)) 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:56:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:36 INFO - Downloading blessings-1.6.tar.gz 05:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:56:36 INFO - Installing collected packages: blessings 05:56:36 INFO - Running setup.py install for blessings 05:56:36 INFO - Successfully installed blessings 05:56:36 INFO - Cleaning up... 05:56:36 INFO - Return code: 0 05:56:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:36 INFO - Reading from file tmpfile_stdout 05:56:36 INFO - Current package versions: 05:56:36 INFO - blessings == 1.6 05:56:36 INFO - blobuploader == 1.2.4 05:56:36 INFO - docopt == 0.6.1 05:56:36 INFO - functools32 == 3.2.3-2 05:56:36 INFO - jsonschema == 2.5.1 05:56:36 INFO - manifestparser == 1.1 05:56:36 INFO - mozInstall == 1.12 05:56:36 INFO - mozcrash == 1.0 05:56:36 INFO - mozdebug == 0.1 05:56:36 INFO - mozdevice == 0.49 05:56:36 INFO - mozfile == 1.2 05:56:36 INFO - mozhttpd == 0.7 05:56:36 INFO - mozinfo == 0.9 05:56:36 INFO - mozleak == 0.1 05:56:36 INFO - mozlog == 3.4 05:56:36 INFO - moznetwork == 0.27 05:56:36 INFO - mozprocess == 0.24 05:56:36 INFO - mozprofile == 0.28 05:56:36 INFO - mozrunner == 6.13 05:56:36 INFO - mozscreenshot == 0.1 05:56:36 INFO - mozsystemmonitor == 0.3 05:56:36 INFO - moztest == 0.8 05:56:36 INFO - mozversion == 1.4 05:56:36 INFO - psutil == 3.1.1 05:56:36 INFO - requests == 1.2.3 05:56:36 INFO - wsgiref == 0.1.2 05:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:36 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')]} 05:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:36 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')]} 05:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:36 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 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:36 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 05:56:36 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 05:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:36 INFO - 'HOME': '/Users/cltbld', 05:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:36 INFO - 'LOGNAME': 'cltbld', 05:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:36 INFO - 'MOZ_NO_REMOTE': '1', 05:56:36 INFO - 'NO_EM_RESTART': '1', 05:56:36 INFO - 'PAGER': '/bin/cat', 05:56:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:36 INFO - 'PWD': '/builds/slave/test', 05:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:36 INFO - 'SHELL': '/bin/bash', 05:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:36 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:36 INFO - 'USER': 'cltbld', 05:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:36 INFO - 'XPC_FLAGS': '0x0', 05:56:36 INFO - 'XPC_SERVICE_NAME': '0', 05:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 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)) 05:56:37 INFO - Cleaning up... 05:56:37 INFO - Return code: 0 05:56:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc621486df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, '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.Us1LxupYAC/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.JHjJGEJRCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:37 INFO - 'HOME': '/Users/cltbld', 05:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:37 INFO - 'LOGNAME': 'cltbld', 05:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:37 INFO - 'MOZ_NO_REMOTE': '1', 05:56:37 INFO - 'NO_EM_RESTART': '1', 05:56:37 INFO - 'PAGER': '/bin/cat', 05:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:37 INFO - 'PWD': '/builds/slave/test', 05:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:37 INFO - 'SHELL': '/bin/bash', 05:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:56:37 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:37 INFO - 'USER': 'cltbld', 05:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:37 INFO - 'XPC_FLAGS': '0x0', 05:56:37 INFO - 'XPC_SERVICE_NAME': '0', 05:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:56:37 INFO - Cleaning up... 05:56:37 INFO - Return code: 0 05:56:37 INFO - Running post-action listener: _resource_record_post_action 05:56:37 INFO - Running post-action listener: _start_resource_monitoring 05:56:37 INFO - Starting resource monitoring. 05:56:37 INFO - [mozharness: 2017-02-14 13:56:37.548523Z] Finished create-virtualenv step (success) 05:56:37 INFO - [mozharness: 2017-02-14 13:56:37.549546Z] Running install step. 05:56:37 INFO - Running pre-action listener: _resource_record_pre_action 05:56:37 INFO - Running main action method: install 05:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:37 INFO - Reading from file tmpfile_stdout 05:56:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:56:37 INFO - Reading from file tmpfile_stdout 05:56:37 INFO - Output received: 05:56:37 INFO - Usage: mozinstall [options] installer 05:56:37 INFO - Options: 05:56:37 INFO - -h, --help show this help message and exit 05:56:37 INFO - -d DEST, --destination=DEST 05:56:37 INFO - Directory to install application into. [default: 05:56:37 INFO - "/builds/slave/test"] 05:56:37 INFO - --app=APP Application being installed. [default: firefox] 05:56:37 INFO - mkdir: /builds/slave/test/build/application 05:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:57:00 INFO - Reading from file tmpfile_stdout 05:57:00 INFO - Output received: 05:57:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:57:00 INFO - Running post-action listener: _resource_record_post_action 05:57:00 INFO - [mozharness: 2017-02-14 13:57:00.194611Z] Finished install step (success) 05:57:00 INFO - [mozharness: 2017-02-14 13:57:00.194760Z] Running run-tests step. 05:57:00 INFO - Running pre-action listener: _resource_record_pre_action 05:57:00 INFO - Running main action method: run_tests 05:57:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:00 INFO - 2017-02-14 05:57:00.209 screenresolution[1895:17978] starting screenresolution argv=screenresolution get 05:57:00 INFO - 2017-02-14 05:57:00.212 screenresolution[1895:17978] Display 0: 1600x1200x32@60 05:57:00 INFO - 2017-02-14 05:57:00.218 screenresolution[1896:17980] starting screenresolution argv=screenresolution list 05:57:00 INFO - Available Modes on Display 0 05:57:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:00 INFO - Intel Iris: 05:57:00 INFO - Chipset Model: Intel Iris 05:57:00 INFO - Type: GPU 05:57:00 INFO - Bus: Built-In 05:57:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:00 INFO - Vendor: Intel (0x8086) 05:57:00 INFO - Device ID: 0x0a2e 05:57:00 INFO - Revision ID: 0x0009 05:57:00 INFO - Displays: 05:57:00 INFO - Display: 05:57:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:00 INFO - Display Serial Number: 1600x1200 60 05:57:00 INFO - Main Display: Yes 05:57:00 INFO - Mirror: Off 05:57:00 INFO - Online: Yes 05:57:00 INFO - Rotation: Supported 05:57:00 INFO - Return code: 0 05:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:00 INFO - Python 2.7.3 05:57:00 INFO - Return code: 0 05:57:00 INFO - grabbing minidump binary from tooltool 05:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:00 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 0x10f6cbd30>, '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 0x10f5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6c0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:00 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 05:57:00 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 05:57:00 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 05:57:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:00 INFO - Return code: 0 05:57:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:57:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:57:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Us1LxupYAC/Render', 05:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:00 INFO - 'HOME': '/Users/cltbld', 05:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:00 INFO - 'LOGNAME': 'cltbld', 05:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:00 INFO - 'MOZ_NO_REMOTE': '1', 05:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:00 INFO - 'NO_EM_RESTART': '1', 05:57:00 INFO - 'PAGER': '/bin/cat', 05:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:00 INFO - 'PWD': '/builds/slave/test', 05:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:00 INFO - 'SHELL': '/bin/bash', 05:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JHjJGEJRCl/Listeners', 05:57:00 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:00 INFO - 'USER': 'cltbld', 05:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:00 INFO - 'XPC_FLAGS': '0x0', 05:57:00 INFO - 'XPC_SERVICE_NAME': '0', 05:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:57:00 INFO - mozversion application_buildid: 20170214043845 05:57:00 INFO - mozversion application_changeset: 47391e531350873bfccd576b689259ec249aede8 05:57:00 INFO - mozversion application_display_name: Nightly 05:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:00 INFO - mozversion application_name: Firefox 05:57:00 INFO - mozversion application_remotingname: firefox 05:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:00 INFO - mozversion application_vendor: Mozilla 05:57:00 INFO - mozversion application_version: 54.0a1 05:57:00 INFO - mozversion platform_buildid: 20170214043845 05:57:00 INFO - mozversion platform_changeset: 47391e531350873bfccd576b689259ec249aede8 05:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:00 INFO - mozversion platform_version: 54.0a1 05:57:00 INFO - using testdate: 1487080620 05:57:00 INFO - actual date: 1487080620 05:57:00 INFO - starting webserver on 'localhost:54077' 05:57:00 INFO - SUITE-START | Running 2 tests 05:57:00 INFO - TEST-START | dromaeo_css 05:57:00 INFO - operating with platform_type : mac_ 05:57:00 INFO - Initialising browser for dromaeo_css test... 05:57:00 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpBnlRkt/profile http://localhost:54077/getInfo.html) 05:57:03 INFO - PROCESS | 1906 | 2017-02-14 05:57:03.685 plugin-container[1908:18134] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 05:57:03 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:03 INFO - PROCESS | 1906 | 2017-02-14 05:57:03.687 plugin-container[1908:18134] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 05:57:03 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:03 INFO - PROCESS | 1906 | 2017-02-14 05:57:03.687 plugin-container[1908:18134] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:57:03 INFO - PROCESS | 1906 | __metrics Screen width/height:1600/1200 05:57:03 INFO - PROCESS | 1906 | colorDepth:24 05:57:03 INFO - PROCESS | 1906 | Browser inner width/height: 1024/689 05:57:03 INFO - PROCESS | 1906 | __metrics 05:57:03 ERROR - PROCESS | 1906 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:57:04 INFO - TEST-INFO | 1906: exit 0 05:57:04 INFO - Browser initialized. 05:57:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:04 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpBnlRkt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:06 INFO - PROCESS | 1909 | 2017-02-14 05:57:06.878 plugin-container[1910:18260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 05:57:06 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:06 INFO - PROCESS | 1909 | 2017-02-14 05:57:06.879 plugin-container[1910:18260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.CFPasteboardClient' 05:57:06 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:57:06 INFO - PROCESS | 1909 | 2017-02-14 05:57:06.879 plugin-container[1910:18260] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:57:16 INFO - PROCESS | 1909 | RSS: Main: 233844736 05:57:16 INFO - PROCESS | 1909 | 06:00:20 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54077/tests/dromaeo/cssquery-ext.html) 06:00:22 INFO - PROCESS | 1909 | RSS: Main: 254894080 06:00:22 INFO - PROCESS | 1909 | 06:02:04 INFO - PROCESS | 1909 | ************************* 06:02:04 INFO - PROCESS | 1909 | A coding exception was thrown and uncaught in a Task. 06:02:04 INFO - PROCESS | 1909 | 06:02:04 ERROR - PROCESS | 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:02:04 INFO - PROCESS | 1909 | Full stack: 06:02:04 INFO - PROCESS | 1909 | ************************* 06:03:24 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-ext.html (next: http://localhost:54077/tests/dromaeo/cssquery-jquery.html) 06:03:25 INFO - PROCESS | 1909 | RSS: Main: 260087808 06:03:25 INFO - PROCESS | 1909 | 06:06:27 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54077/tests/dromaeo/cssquery-mootools.html) 06:06:27 INFO - PROCESS | 1909 | RSS: Main: 271044608 06:06:27 INFO - PROCESS | 1909 | 06:09:29 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54077/tests/dromaeo/cssquery-prototype.html) 06:09:30 INFO - PROCESS | 1909 | RSS: Main: 263335936 06:09:30 INFO - PROCESS | 1909 | 06:12:33 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54077/tests/dromaeo/cssquery-yui.html) 06:12:33 INFO - PROCESS | 1909 | RSS: Main: 267378688 06:12:33 INFO - PROCESS | 1909 | 06:15:36 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:54077/tests/dromaeo/cssquery-yui.html (next: http://localhost:54077/tests/dromaeo/cssquery-dojo.html) 06:15:37 INFO - PROCESS | 1909 | RSS: Main: 268603392 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | __start_tp_report 06:15:37 INFO - PROCESS | 1909 | _x_x_mozilla_page_load 06:15:37 INFO - PROCESS | 1909 | _x_x_mozilla_page_load_details 06:15:37 INFO - PROCESS | 1909 | |i|pagename|runs| 06:15:37 INFO - PROCESS | 1909 | |0;dojo.html;3032.6664066952635;3273.263515708967;3284.277458959028;3288.523164141201;3316.9668303316957;5318.6011049171275;5378.273933019042;5485.561155107592;5572.275604171457;5601.551875849932;5413.945860541394;5516.641418307807;5578;5630.071038278689;5657.23627310313;5031.52200540948;5084.542391184793;5088.92366614501;5123.180291153416;5150;4951.8266860659705;5115.923261151086;5173.327467429229;5177.171652535595;5250.186221135711;4940.777665005084;5148.3564554430695;5158.9484105158845;5164.535191832753;5188.221766735001;4957.504249575014;5019.52314530119;5074.59403247743;5118.769655365518;5189;5095.312132862054;5115.641905066647;5133.358330208724;5157.58739300855;5198.428172900978;4810.6151507879285;5343.812966546191;5524.66851988882;5561;5576.693281869496;5846.532277417797;5944.554158438134;5960.791372301992;6047.03247480401;6130.540209484307;6098.939010609882;6126.609281623701;6177.104319873593;6197.1324014637985;6218.875622487571;5739.339975902824;5747.885042299131;5753.424657534255;5759.971200144015;5765.077587585966;6085.391460853879;6111.174991376196;6218.906716399258;6221.844453888689;6304.306526282106;5878.941210587839;5885.588008839426;5901.557383196277;5979.760809567656;5993.310769261503;5282.784959459346;6190.41191086846;6195.535334849904;6215.34738852414;6217.316095229521;5489.670619762827;5817.894600025981;5927.288725352899;5961.701914904237;5972.283326000907;4993.775280112403;5028.296038554606;5998.070299103646;6128.8774224516155;6143.354947730424;4550.840720574764;4851.51484851512;4865.221564549655;4873.561379475864;4878.634102442331;3755.8732380285805;4233.238017156941;4289.849855255051;4295.248331541968;4326.545712700184;5718.285214348207;5738.770449181986;5742.339630942495;5755.99270127726;5800.1589769484035;5080.923786143211;6207.162033125561;6221.097940798559;6228.937710622927;6276.6547839869245;5470;5473.75368108436;5490.780368785284;5545.861353466115;5739.397363276879;5283.286756287929;5323.095073837457;5343.118385466354;5387.138057910715;5397.4062853086125;6200.844978875564;6222.595531290452;6279.183706118175;6279.529035322369;6284.654344010941;5867.501262392744;6213.471854892385;6238.719257633326;6243.937560624336;6270.905936411049;6133.701927635063;6210.285817130907;6214.40963108504;6216.627002379872;6266.937330626818;6133.417325354084;6142.201513803177;6142.938570614237;6143.047827586731;6159.4456498915315;5516.475934786189;6136.693165341804;6144.657134723962;6189.473894718999;6219.191505104308;5678;5772.307323121252;5789.623674461147;5883.794067207627;6045.667488288186;5905.704714764159;6019.247594050744;6024.036154215304;6042.939570604238;6065.302490213682;5388.649737767033;5611.80358687444;5711.086226203787;5762.164486149569;5874.148248503858;5940.019896716994;6000.489958353414;6009.098635204754;6009.819705408845;6025.909611355921;5612.989661860905;5637.323521177321;5649.745761440663;5828.300603927556;5864.882702346014 06:15:37 INFO - PROCESS | 1909 | |1;ext.html;476.8769547715131;497.7287378378783;519.9636025478217;547.244802173001;555.8415851482329;39202.80398598006;39604.801975990114;40267.19465610686;40884.79557602215;41062;42853.57146428535;43543.129137417236;43550.34674479885;43648.78175609125;43779.34330985038;9235.676751313722;11030.172737044713;11482.138839587022;11533.826992595117;11647.242929209575;11159.163062770325;11242.550297988111;11245.493952772104;11251.887481125206;11268.380239086848;11162.386068766215;11252.26860254085;11269.323840569592;11274.718132046683;11289;11192.66422007337;11239;11254.887451125465;11267.605633802777;11289.379084150369;11227.831582526187;11319.886801131966;11330.60342887995;11335.14986376025;11337.829932551018;37614.24771504582;37748.62251377478;38031.23937521234;38086.428703569465;38125.61874381248;3747.8586856674747;3749.1751814600743;3764.5294338207723;3778.7543809652284;3964.8810535683974;22165.113395464163;28223.294417639518;28800.135995919947;29613.70386296131;29709.70290297091;2948.2187220386613;3057.755379569629;3093.2576181716227;3097.1792474994145;3121.110483512211;449404;452014;452565;455638;456997.9999999967;37380.81309593435;47698.5230147701;56135;57182.85634287291;57616;60649.09026364608;61039.08441373383;61195.694021529605;61251.38748612546;61493.38506614877;14507.1295722257;14680.55958321252;14687.853121468648;14696.632584185481;14748.410063597335;10974.615888443866;11100.278481898813;11268.943655281835;11411.087113030937;11424.42877856104;17749.7337539937;17920.55198620019;17949;17978;18129.728054079198;6420.422162005442;7487.737929172453;7496.475246732676;7628.694852205849;7640.885386719204;712.8396110875011;833.5998720614139;844.5312851367427;852.1435956863437;861.4745005546612;22741.545169096855;25820.35449113787;29449.55825662617;30251.848740756595;30372.392552148835;1012.2205901455837;1019.2152042927053;1050.9369437833755;1062.4687656171914;1157.305616630032;15303.846961530242;15358;15398.922075454835;15435.845641543441;15806.36774529006;458754;460894;462277;464046;464165;59287.814243714885;59678.40321596815;60320.79358412807;60336.69831650814;60377.69811150916;1182.6924999500363;1348.8246527951303;1350.2303686898374;1389.958301250964;1403.4736973634888;28156.577651335658;28329.433411331247;28545.28636784097;28550.42899142047;28611.856940715163;51045;51071;51497.7425112887;51710.22434663558;52008.479915201875;464786.6760666175;467159.6272298276;467288;469144;469423;24947.376315592257;25388.111416100346;25472.490550189264;26423.943042278093;26873.731262687124;42401.36397953972;42563.57436425596;43283.35074973815;43777.34333984929;43849;30834.845825770728;31331.84334078315;34519.654803451645;34594.82702586471;35502.28995420129;34253.486197707556;34272.82863585666;35012;35268.823655881555;35866.28267434584;34285.82857085699;34781.65218347784;35034.64965350314;35132;35173.296534068664;29513.704862951956;30784.53823192609;30799.076027718307;31042.068737937898;31136;23339.416514587272;23570.292891213292;23590.938407771348;23944.760552394255;24869.751302486744 06:15:37 INFO - PROCESS | 1909 | |2;jquery.html;379.42138239185255;384.6006658757798;388.9572147063823;392.25667360352134;414.82162670051866;20253.17721405073;20596.279130230443;21124;21374.46563835907;21407.892960535195;12024.51901923922;12139.332336721476;12298.446569904354;12433.005359571236;12471;3842.212346468981;4658.720476771405;4751.596114330286;4882.267659851015;5072.4673909239555;5197.610179236553;5717.914231286534;5974.611650242742;6050.364711705273;6142.477889379408;5001.44984051754;5998.40015998401;6117.724702388403;6156;6156.2920264169525;4902.583280421169;5174.9223761643225;5727.627704199213;5975.804839032189;5985.25184351956;5716.771329146829;5861.2087368205175;5951.256092988377;5954.464098231137;5988;13648.727025459435;13716.902647788153;13802.447902083904;13990.930045349809;22579;2519.924402267935;2554.425254317782;2561.743825617423;2590.1323056776005;2631.7105118436957;8551.401401901869;9942.613772694574;10237.027482389161;10551.736206594896;10894.945525272324;1739.652069586088;1770.1857145712988;1781.0026385224317;1784.1703607822294;1784.3308759215295;125103;134748;136623;137742;138873.3056334722;9968.850467242997;10165.39007659528;11601;12009.699757505958;12185.207961482476;15604.531864044096;16334.428295009855;16338.918305408397;16349.42777002823;16350.591235219215;8506.659733610586;8634.309255259564;8749.868751968726;8787.736367908972;8829.514376709343;6638.834029149213;8039.316658084128;8135.633896474673;8354.874676879852;8491.660333586588;4844.733539655283;4918.213085906238;4924.482929292444;4940.925886111711;5042.924356134661;2048.2319130326127;2084.5830833833293;2102;2105.8631188972668;2112.514121752006;831.7296878514506;840.82342708032;845.8392905347964;863.4775960543781;885.4908427653996;20019.39941801748;20698.79301206999;21204.25785097514;21402.357929261834;21503.46241343979;846.6951897316961;865.8225063861893;875.5578432891349;895.167494230359;903.503073309677;8305.294050005696;9398.812023759487;10940.222139024087;11173.273737207055;11213;644913;653993;665272;666110;676994;108933.36599951008;110705;130044;140027;145346;975.6292608808608;1019.1337363241333;1053.836655318427;1055.8996895294936;1056.799208150449;20129.39611811648;20268.391948241577;20634.865082420612;20642.793572064085;20645.17419303271;58155.11363068204;58755.706221468616;58978.44812502249;59695.70152149211;59835.40164598298;85277;86424.56787716021;86768;86843.56578217068;87675;8259.545724985184;8450.66197352099;8523.232909038215;8595.226429621363;8636.611352489279;12517.74964500723;12875.420606072561;12964.222146670852;13505.594832155051;13517.797233041709;11049.668509944715;11226.887731122584;11389.943050284695;11470.541178352772;11511.021563167225;4454.3986561813745;8217.712380066669;11088.556457741923;11093.33439993603;11518.308901465938;9808.970058143792;10128.64549740785;11417.657470275904;11716.41417929083;11773.705657358634;7254.347108760237;7395.040314316603;7515.473916825769;7578.711619024889;7905.446618736633;10084.142847858015;11304.908591910524;11563.42182890869;11678.88321116778;11704.94147529257 06:15:37 INFO - PROCESS | 1909 | |3;mootools.html;1150.9654710358689;1177.7173478365196;1371.6845125621107;1412.7527682655539;1421.85540639785;8173.264406203441;8338.58307084645;8570.65717371306;8610.311175105991;8633.913660863398;8439.367047471449;8559.700410485635;8564.229219370256;8570.185832345933;8577.485350878951;2244.70818793557;2269.4439862233776;2281.5893139235013;2288.0504590594883;2296.7588403217674;2234.910603575855;2274.5792028474784;2277.1119263487253;2289.3933107726466;2301;2226.7216597925258;2228.097620463715;2246.550689862026;2255.4248666589997;2258.3450799268194;2174.467255522407;2251.122062395667;2269.092363054775;2269.7503274639857;2277.1119263487335;1907.122723547156;1990.7212990181386;2236.787505187021;2265.4676151104477;2270.6026445371995;8263.214994575506;8464.238218560358;8476.533790641512;8524.957375213084;8571.95714021426;5126.051680439131;5232.450592687789;5310.36275646921;5320.414754377054;5327.280817089682;3428.7428442866885;3460.480927860841;3491.807950562718;3505.5618047744033;3516.964830351689;1185.4309931233056;1190.7558950415143;1221.694576355911;1243.9129260951736;1244.2658831289582;10780.51487683056;10843.295185812976;10941.070009049241;10952.4523773811;10970.067544258747;4121.340585506365;4402.185595664812;4477.238869392211;4484.618807401343;4486.259767138451;8604.612792424356;8687.695930642523;8742.125787421333;8743.606537705818;8773.692920747742;5099.719515426687;5103.97448012765;5127.307813445137;5127.897442051138;5131.999260144236;3878.2631300053463;4585.656075794262;4609;4630.282306242538;4792.400949881265;3142.4186525492855;3642.9617558996088;3663.908402289964;3697.205100903319;3697.815109244527;967.6032826541084;970.9514524273758;1064.6539874540806;1136.8578927634046;1136.948322801422;734.9338559529562;745.5116898431536;758.8747856603599;763.7326935572505;802.1377019703842;5338.332708411449;5528.917066244009;5540.113581826969;5571.498565129077;5588.748506317144;544.6731960823474;547.4908335248177;566.8242844718151;571.2459553389486;574.5317566183547;3377.80088068737;3713.5543734752005;3776.7922764247683;3876.321643712339;3878.96121038786;9567.186789123003;10081.546330415149;10088.646897358558;10090.34412763168;10098.394096354243;10024.649137280161;10043.995600440043;10065.647702330383;10067.69796906094;10082.647107351208;7558.3953283738265;7669.233076692286;7724.806879828049;7858.253465920729;7872.488288261359;5371.301730774974;5374.838754837361;5442.605253688364;5487.6158668892795;5608.943910560843;9046.68336608242;9071.36500444989;9233.630654773733;9297.767555810888;9341.205997490018;9076.727698169065;9138.17756401927;9349.626014959325;9466.05339466048;9466.95266523663;6638.701258443478;6791.0153027811675;6803.455723542006;6812.693428795816;6820.454363650995;7711.807204819925;7772.145064043064;7889.487183333065;7904.525728456311;7924.683012679428;5855.414458554281;7068.974998625068;7079.68141433647;7153.427725781821;7212.74755383559;6878.69045892946;6965.373116419547;6990.545614535039;7036.683349249193;7058.200158959433;6255.9374406257175;6422.100905873088;6438.7102580384935;6440.4525615321345;6461.450776683847;3850.403187505941;4134.565870583546;4812.494688057844;4998.175301075427;5041.966396888703;4919.778609962489;4966.6771659842;5009.54914057722;5083.085044691991;5098.745062746922 06:15:37 INFO - PROCESS | 1909 | |4;prototype.html;350.49528678702666;360.94585812128196;363.37136753416587;364.790245608775;365.8536585365855;4594.701344412615;5282.788688452457;5417.891642167159;5426.728663566825;5493.285872836531;4087.734297270675;5281.603879709028;5372.495701203659;5378.435264297251;5396.136618141099;4076.673866090713;4092.1611069730634;4112.650424713903;4117.341225403936;4121.505419349683;3408.7443441741843;3947.960520394788;4017.2602109037075;4108.691848111389;4123.5876412358675;3472.583290005203;3527.3121741260466;3737.6262373762543;3984.2230765000836;4025.2754504189234;3513.279777645589;3994.820233089518;4015.6586690131376;4016.939745903799;4027.026756889103;3271.263965607743;3339.158220580144;3513;3520.5951315598522;3552.289542091566;4195.46865394129;4519.141363140992;4900.681455705368;5035.676453540682;5305.8938821223355;4650.325702773112;4652.976735116336;4658.534146585348;4659.32439796231;4694.460137084245;4585.656075794329;4626.375439315683;5722.084466485342;5750.964826331258;5841.153032810219;3595.406757884946;3740.251949610089;3884.009577557733;3884.7086468514976;3905.6915933162427;5684.431556844283;5881.765129107079;5946.821595352189;5991.460768530853;6028.577999540034;3336.849841757127;3638.799866007395;3665;3912.628300311466;3952.6442620164325;3979.6020397959974;3987.7407968481957;3991.341428664238;3998.640122388999;4008.3586626139677;4114.794260286973;4201.18076974987;4586.403767510203;4603.930941035887;4689.835855745033;4848.71509050102;5330.653507521999;5736.512396446349;5745.368009518949;5753.798617048383;1119.9384033878052;1177.4407156600546;1231.7844377234128;1268.9175203611735;1287.7810772168566;697.3375293471223;820.7073858672615;822.7778499805139;870.6212797433137;880.41892351048;4811.975940120277;4995.875103122378;5143.019937324082;5143.588512918957;5155.355580552431;5006.874828129253;5330.253764472977;5410.431904650034;5699.601027928005;5700;4463.843765468193;4681.81272749093;4839.806407743651;4955.803506738206;5112.233165025276;2607.4394005288955;2628.973710262911;2913.402752435788;2955.6305461817274;2972.286651203739;4989.775460104304;5316.680999140064;5347.3583170019065;5748.349797878293;5826.184334193216;4844.95155048445;4909.146320138674;4939.629527785431;5625.0187400677705;5749.626274292157;5256.001359741714;5263.657482576813;5387.865303367447;5423.674579525241;5736.368999410061;4752.217918280645;4968.27959945813;5606.439356064361;5702.37273899879;5708.914366284426;4971.477994810492;5186.844394668166;5517.186235020249;5633.8309850704545;5708.060348920227;5275.393329766973;5712;5908.438698323653;5933.317668468008;6124.5406594506485;3830;3854.8843534694006;4017.6942493689085;4216.91566168681;4294.9692073901415;5425.701586412785;5503;5957.6127551709;5962.821115366546;6002.789902353396;5031.012749963817;5399.759099973467;5722.484976352148;5747.683877386784;5749.051406518045;5270.8945821084135;5700.087985922232;5743;5761.884762304814;5800.883982320414;4876.024795041077;5257.474252574865;5316.6544174628525;5560.638558493685;5625.353084395347;5048.899022019613;5696.202531645656;5724.427557244242;5740.942590574041;5760.6255593386295;5140.3831540215415;5620.522255608319;5647.887042259214;5649.519790817662;5674.744636491285 06:15:37 INFO - PROCESS | 1909 | |5;yui.html;658.9703463344152;676.5725606736008;750.114864459937;790.2295262119434;791.9150763454069;14421.351039203235;14876.099160663674;15280.312385942632;15344.309506072226;15459.30433130509;14067.507637232673;14127.717445651106;14402.927985360086;14420.495282665082;14420.855791442082;802.6307898366729;877.7322916510461;884.9203571678547;905.307439808547;906.1753804038326;876.5967654878764;896.4531635702216;898.2409863665192;900.8648702694616;901.5537309032038;951.6526467839258;953.7615596100975;953.9427634341962;955.1022039283087;955.9665411710591;937.2267878999818;938.5213541094023;950.9191718703919;951.3816019587255;952.1383148250844;695.9977632209602;699.5837476701355;704.0565642039641;704.4681265644457;705.1432509500981;14770.409183632642;15258.160801155933;15316.081035137928;15362.615934601612;15487.303071361815;13331.600051998455;13346.933265333708;13880.917862320632;14201.431942722278;14232.715345693028;9028.50343231122;9280.211182049534;11243.943780281046;11618.244814087057;11680.883191168065;3057.281538838371;3351.9664803351898;3566.268914872445;3647.288778688157;3657.195417008254;80158.59920700417;105248;105778;106609.46695266552;107143.46428267886;10675.612170417797;10732.839007414896;10747.731306717238;10806.891931080745;11051.502682379312;22084;22208.777912220994;22421.215257465912;22429.214977476036;22438.10247590111;7466.402687784964;7496.887546686804;7507;7520.172780994087;7737.961310193413;4103.724209095443;4155.273924758045;4231.896419202721;4270.807813648394;4285.185814695198;3604.098975256186;3705.1107734144152;3713.702903767692;3714.9628503715157;3722.1253005543676;663.6184194088322;668.5620918298522;674.5345711459078;687.226869771507;693.6843736100062;605.5246631394334;636.2365161805851;674.7874419557824;686.1697346211041;698.8707089188516;8322.70870519529;9701.466419346863;9832.213422926148;9941.403515789076;10282.331648442827;638.5562034386057;667.1860330396908;676.7022510095542;701.8420855307515;722.2452537098744;4594.65540084495;4830.686005409637;4832.9850731346105;4840.782164802592;4852.708837469763;101424.49287753661;104031.4798426003;104525;104636;106200;62791.6860415695;73270.63364683143;74583.88124178142;76021;79368.74518860578;67997.3200268001;69582.65208674026;70510.94233586501;71319.2868071323;71349.6432517834;10401.219908507044;10515.57937682484;10525.210609204187;10620.628278010232;10640.467976601294;34704.65295347014;40035.799821000706;44599.77700111479;45089.64731058074;46849.53150468451;55131.44868551424;59768.70115649394;60158.79682406415;61003;61106;12145.878541214475;12577.559785407468;12618.305993170463;12727;13114;13457.865421346052;13759.500878908748;13864.722705545631;13867.445302188204;14075.436982520585;10245.84631230547;10555.52500137511;12885.871141288842;13284.933575332061;13417.798733019208;10485.346396220093;11984.801519847946;12342.568010119961;12960.35198240103;13001.609951701465;10439.94780026095;12503.87124489244;12663.430145643284;12808.359582021048;13337.466501340226;10566.947165264124;10608;10653.0810478635;10866.402347870942;10974.018564546865;9126.406783559047;9331.906680933103;9398.624055037995;9523.903810551568;9606.711798646053 06:15:37 INFO - PROCESS | 1909 | __end_tp_report 06:15:37 INFO - PROCESS | 1909 | __start_cc_report 06:15:37 INFO - PROCESS | 1909 | _x_x_mozilla_cycle_collect,425 06:15:37 INFO - PROCESS | 1909 | __end_cc_report 06:15:37 INFO - PROCESS | 1909 | __startTimestamp1487081737174__endTimestamp 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | ------- Summary: start ------- 06:15:37 INFO - PROCESS | 1909 | Number of tests: 6 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#0] dojo.html Cycles:165 Average:5587.86 Median:5747.89 stddev:652.83 (11.4%) stddev-sans-first:623.30 06:15:37 INFO - PROCESS | 1909 | Values: 3032.7 3273.3 3284.3 3288.5 3317.0 5318.6 5378.3 5485.6 5572.3 5601.6 5413.9 5516.6 5578.0 5630.1 5657.2 5031.5 5084.5 5088.9 5123.2 5150.0 4951.8 5115.9 5173.3 5177.2 5250.2 4940.8 5148.4 5158.9 5164.5 5188.2 4957.5 5019.5 5074.6 5118.8 5189.0 5095.3 5115.6 5133.4 5157.6 5198.4 4810.6 5343.8 5524.7 5561.0 5576.7 5846.5 5944.6 5960.8 6047.0 6130.5 6098.9 6126.6 6177.1 6197.1 6218.9 5739.3 5747.9 5753.4 5760.0 5765.1 6085.4 6111.2 6218.9 6221.8 6304.3 5878.9 5885.6 5901.6 5979.8 5993.3 5282.8 6190.4 6195.5 6215.3 6217.3 5489.7 5817.9 5927.3 5961.7 5972.3 4993.8 5028.3 5998.1 6128.9 6143.4 4550.8 4851.5 4865.2 4873.6 4878.6 3755.9 4233.2 4289.8 4295.2 4326.5 5718.3 5738.8 5742.3 5756.0 5800.2 5080.9 6207.2 6221.1 6228.9 6276.7 5470.0 5473.8 5490.8 5545.9 5739.4 5283.3 5323.1 5343.1 5387.1 5397.4 6200.8 6222.6 6279.2 6279.5 6284.7 5867.5 6213.5 6238.7 6243.9 6270.9 6133.7 6210.3 6214.4 6216.6 6266.9 6133.4 6142.2 6142.9 6143.0 6159.4 5516.5 6136.7 6144.7 6189.5 6219.2 5678.0 5772.3 5789.6 5883.8 6045.7 5905.7 6019.2 6024.0 6042.9 6065.3 5388.6 5611.8 5711.1 5762.2 5874.1 5940.0 6000.5 6009.1 6009.8 6025.9 5613.0 5637.3 5649.7 5828.3 5864.9 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#1] ext.html Cycles:180 Average:60336.98 Median:32792.66 stddev:122328.67 (373.0%) stddev-sans-first:122589.28 06:15:37 INFO - PROCESS | 1909 | Values: 476.9 497.7 520.0 547.2 555.8 39202.8 39604.8 40267.2 40884.8 41062.0 42853.6 43543.1 43550.3 43648.8 43779.3 9235.7 11030.2 11482.1 11533.8 11647.2 11159.2 11242.6 11245.5 11251.9 11268.4 11162.4 11252.3 11269.3 11274.7 11289.0 11192.7 11239.0 11254.9 11267.6 11289.4 11227.8 11319.9 11330.6 11335.1 11337.8 37614.2 37748.6 38031.2 38086.4 38125.6 3747.9 3749.2 3764.5 3778.8 3964.9 22165.1 28223.3 28800.1 29613.7 29709.7 2948.2 3057.8 3093.3 3097.2 3121.1 449404.0 452014.0 452565.0 455638.0 456998.0 37380.8 47698.5 56135.0 57182.9 57616.0 60649.1 61039.1 61195.7 61251.4 61493.4 14507.1 14680.6 14687.9 14696.6 14748.4 10974.6 11100.3 11268.9 11411.1 11424.4 17749.7 17920.6 17949.0 17978.0 18129.7 6420.4 7487.7 7496.5 7628.7 7640.9 712.8 833.6 844.5 852.1 861.5 22741.5 25820.4 29449.6 30251.8 30372.4 1012.2 1019.2 1050.9 1062.5 1157.3 15303.8 15358.0 15398.9 15435.8 15806.4 458754.0 460894.0 462277.0 464046.0 464165.0 59287.8 59678.4 60320.8 60336.7 60377.7 1182.7 1348.8 1350.2 1390.0 1403.5 28156.6 28329.4 28545.3 28550.4 28611.9 51045.0 51071.0 51497.7 51710.2 52008.5 464786.7 467159.6 467288.0 469144.0 469423.0 24947.4 25388.1 25472.5 26423.9 26873.7 42401.4 42563.6 43283.4 43777.3 43849.0 30834.8 31331.8 34519.7 34594.8 35502.3 34253.5 34272.8 35012.0 35268.8 35866.3 34285.8 34781.7 35034.6 35132.0 35173.3 29513.7 30784.5 30799.1 31042.1 31136.0 23339.4 23570.3 23590.9 23944.8 24869.8 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#2] jquery.html Cycles:180 Average:37152.23 Median:1505.57 stddev:110465.10 (7337.1%) stddev-sans-first:110740.47 06:15:37 INFO - PROCESS | 1909 | Values: 379.4 384.6 389.0 392.3 414.8 20253.2 20596.3 21124.0 21374.5 21407.9 12024.5 12139.3 12298.4 12433.0 12471.0 3842.2 4658.7 4751.6 4882.3 5072.5 5197.6 5717.9 5974.6 6050.4 6142.5 5001.4 5998.4 6117.7 6156.0 6156.3 4902.6 5174.9 5727.6 5975.8 5985.3 5716.8 5861.2 5951.3 5954.5 5988.0 13648.7 13716.9 13802.4 13990.9 22579.0 2519.9 2554.4 2561.7 2590.1 2631.7 8551.4 9942.6 10237.0 10551.7 10894.9 1739.7 1770.2 1781.0 1784.2 1784.3 125103.0 134748.0 136623.0 137742.0 138873.3 9968.9 10165.4 11601.0 12009.7 12185.2 15604.5 16334.4 16338.9 16349.4 16350.6 8506.7 8634.3 8749.9 8787.7 8829.5 6638.8 8039.3 8135.6 8354.9 8491.7 4844.7 4918.2 4924.5 4940.9 5042.9 2048.2 2084.6 2102.0 2105.9 2112.5 831.7 840.8 845.8 863.5 885.5 20019.4 20698.8 21204.3 21402.4 21503.5 846.7 865.8 875.6 895.2 903.5 8305.3 9398.8 10940.2 11173.3 11213.0 644913.0 653993.0 665272.0 666110.0 676994.0 108933.4 110705.0 130044.0 140027.0 145346.0 975.6 1019.1 1053.8 1055.9 1056.8 20129.4 20268.4 20634.9 20642.8 20645.2 58155.1 58755.7 58978.4 59695.7 59835.4 85277.0 86424.6 86768.0 86843.6 87675.0 8259.5 8450.7 8523.2 8595.2 8636.6 12517.7 12875.4 12964.2 13505.6 13517.8 11049.7 11226.9 11389.9 11470.5 11511.0 4454.4 8217.7 11088.6 11093.3 11518.3 9809.0 10128.6 11417.7 11716.4 11773.7 7254.3 7395.0 7515.5 7578.7 7905.4 10084.1 11304.9 11563.4 11678.9 11704.9 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#3] mootools.html Cycles:180 Average:5358.64 Median:5127.60 stddev:3002.84 (58.6%) stddev-sans-first:2994.61 06:15:37 INFO - PROCESS | 1909 | Values: 1151.0 1177.7 1371.7 1412.8 1421.9 8173.3 8338.6 8570.7 8610.3 8633.9 8439.4 8559.7 8564.2 8570.2 8577.5 2244.7 2269.4 2281.6 2288.1 2296.8 2234.9 2274.6 2277.1 2289.4 2301.0 2226.7 2228.1 2246.6 2255.4 2258.3 2174.5 2251.1 2269.1 2269.8 2277.1 1907.1 1990.7 2236.8 2265.5 2270.6 8263.2 8464.2 8476.5 8525.0 8572.0 5126.1 5232.5 5310.4 5320.4 5327.3 3428.7 3460.5 3491.8 3505.6 3517.0 1185.4 1190.8 1221.7 1243.9 1244.3 10780.5 10843.3 10941.1 10952.5 10970.1 4121.3 4402.2 4477.2 4484.6 4486.3 8604.6 8687.7 8742.1 8743.6 8773.7 5099.7 5104.0 5127.3 5127.9 5132.0 3878.3 4585.7 4609.0 4630.3 4792.4 3142.4 3643.0 3663.9 3697.2 3697.8 967.6 971.0 1064.7 1136.9 1136.9 734.9 745.5 758.9 763.7 802.1 5338.3 5528.9 5540.1 5571.5 5588.7 544.7 547.5 566.8 571.2 574.5 3377.8 3713.6 3776.8 3876.3 3879.0 9567.2 10081.5 10088.6 10090.3 10098.4 10024.6 10044.0 10065.6 10067.7 10082.6 7558.4 7669.2 7724.8 7858.3 7872.5 5371.3 5374.8 5442.6 5487.6 5608.9 9046.7 9071.4 9233.6 9297.8 9341.2 9076.7 9138.2 9349.6 9466.1 9467.0 6638.7 6791.0 6803.5 6812.7 6820.5 7711.8 7772.1 7889.5 7904.5 7924.7 5855.4 7069.0 7079.7 7153.4 7212.7 6878.7 6965.4 6990.5 7036.7 7058.2 6255.9 6422.1 6438.7 6440.5 6461.5 3850.4 4134.6 4812.5 4998.2 5042.0 4919.8 4966.7 5009.5 5083.1 5098.7 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#4] prototype.html Cycles:180 Average:4503.96 Median:4992.83 stddev:1390.16 (27.8%) stddev-sans-first:1358.66 06:15:37 INFO - PROCESS | 1909 | Values: 350.5 360.9 363.4 364.8 365.9 4594.7 5282.8 5417.9 5426.7 5493.3 4087.7 5281.6 5372.5 5378.4 5396.1 4076.7 4092.2 4112.7 4117.3 4121.5 3408.7 3948.0 4017.3 4108.7 4123.6 3472.6 3527.3 3737.6 3984.2 4025.3 3513.3 3994.8 4015.7 4016.9 4027.0 3271.3 3339.2 3513.0 3520.6 3552.3 4195.5 4519.1 4900.7 5035.7 5305.9 4650.3 4653.0 4658.5 4659.3 4694.5 4585.7 4626.4 5722.1 5751.0 5841.2 3595.4 3740.3 3884.0 3884.7 3905.7 5684.4 5881.8 5946.8 5991.5 6028.6 3336.8 3638.8 3665.0 3912.6 3952.6 3979.6 3987.7 3991.3 3998.6 4008.4 4114.8 4201.2 4586.4 4603.9 4689.8 4848.7 5330.7 5736.5 5745.4 5753.8 1119.9 1177.4 1231.8 1268.9 1287.8 697.3 820.7 822.8 870.6 880.4 4812.0 4995.9 5143.0 5143.6 5155.4 5006.9 5330.3 5410.4 5699.6 5700.0 4463.8 4681.8 4839.8 4955.8 5112.2 2607.4 2629.0 2913.4 2955.6 2972.3 4989.8 5316.7 5347.4 5748.3 5826.2 4845.0 4909.1 4939.6 5625.0 5749.6 5256.0 5263.7 5387.9 5423.7 5736.4 4752.2 4968.3 5606.4 5702.4 5708.9 4971.5 5186.8 5517.2 5633.8 5708.1 5275.4 5712.0 5908.4 5933.3 6124.5 3830.0 3854.9 4017.7 4216.9 4295.0 5425.7 5503.0 5957.6 5962.8 6002.8 5031.0 5399.8 5722.5 5747.7 5749.1 5270.9 5700.1 5743.0 5761.9 5800.9 4876.0 5257.5 5316.7 5560.6 5625.4 5048.9 5696.2 5724.4 5740.9 5760.6 5140.4 5620.5 5647.9 5649.5 5674.7 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - PROCESS | 1909 | [#5] yui.html Cycles:180 Average:19067.28 Median:4129.50 stddev:27282.08 (660.7%) stddev-sans-first:27323.60 06:15:37 INFO - PROCESS | 1909 | Values: 659.0 676.6 750.1 790.2 791.9 14421.4 14876.1 15280.3 15344.3 15459.3 14067.5 14127.7 14402.9 14420.5 14420.9 802.6 877.7 884.9 905.3 906.2 876.6 896.5 898.2 900.9 901.6 951.7 953.8 953.9 955.1 956.0 937.2 938.5 950.9 951.4 952.1 696.0 699.6 704.1 704.5 705.1 14770.4 15258.2 15316.1 15362.6 15487.3 13331.6 13346.9 13880.9 14201.4 14232.7 9028.5 9280.2 11243.9 11618.2 11680.9 3057.3 3352.0 3566.3 3647.3 3657.2 80158.6 105248.0 105778.0 106609.5 107143.5 10675.6 10732.8 10747.7 10806.9 11051.5 22084.0 22208.8 22421.2 22429.2 22438.1 7466.4 7496.9 7507.0 7520.2 7738.0 4103.7 4155.3 4231.9 4270.8 4285.2 3604.1 3705.1 3713.7 3715.0 3722.1 663.6 668.6 674.5 687.2 693.7 605.5 636.2 674.8 686.2 698.9 8322.7 9701.5 9832.2 9941.4 10282.3 638.6 667.2 676.7 701.8 722.2 4594.7 4830.7 4833.0 4840.8 4852.7 101424.5 104031.5 104525.0 104636.0 106200.0 62791.7 73270.6 74583.9 76021.0 79368.7 67997.3 69582.7 70510.9 71319.3 71349.6 10401.2 10515.6 10525.2 10620.6 10640.5 34704.7 40035.8 44599.8 45089.6 46849.5 55131.4 59768.7 60158.8 61003.0 61106.0 12145.9 12577.6 12618.3 12727.0 13114.0 13457.9 13759.5 13864.7 13867.4 14075.4 10245.8 10555.5 12885.9 13284.9 13417.8 10485.3 11984.8 12342.6 12960.4 13001.6 10439.9 12503.9 12663.4 12808.4 13337.5 10566.9 10608.0 10653.1 10866.4 10974.0 9126.4 9331.9 9398.6 9523.9 9606.7 06:15:37 INFO - PROCESS | 1909 | -------- Summary: end -------- 06:15:37 INFO - PROCESS | 1909 | 06:15:37 INFO - TEST-INFO | 1909: exit 0 06:15:37 INFO - TEST-OK | dromaeo_css | took 1117006ms 06:15:37 INFO - TEST-START | kraken 06:15:37 INFO - operating with platform_type : mac_ 06:15:37 INFO - Initialising browser for kraken test... 06:15:37 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpt_SCFr/profile http://localhost:54077/getInfo.html) 06:15:40 INFO - PROCESS | 1917 | 2017-02-14 06:15:40.464 plugin-container[1918:20353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892f, name = 'com.apple.tsm.portname' 06:15:40 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:40 INFO - PROCESS | 1917 | 2017-02-14 06:15:40.466 plugin-container[1918:20353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 06:15:40 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:40 INFO - PROCESS | 1917 | 2017-02-14 06:15:40.466 plugin-container[1918:20353] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:15:40 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 06:15:40 INFO - PROCESS | 1917 | colorDepth:24 06:15:40 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 06:15:40 INFO - PROCESS | 1917 | __metrics 06:15:40 ERROR - PROCESS | 1917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 06:15:41 INFO - TEST-INFO | 1917: exit 0 06:15:41 INFO - Browser initialized. 06:15:41 INFO - Running cycle 1/1 for kraken test... 06:15:41 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpt_SCFr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:43 INFO - PROCESS | 1919 | 2017-02-14 06:15:43.729 plugin-container[1920:20470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882f, name = 'com.apple.tsm.portname' 06:15:43 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:43 INFO - PROCESS | 1919 | 2017-02-14 06:15:43.729 plugin-container[1920:20470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 06:15:43 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:43 INFO - PROCESS | 1919 | 2017-02-14 06:15:43.730 plugin-container[1920:20470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:15:53 INFO - PROCESS | 1919 | RSS: Main: 233603072 06:15:53 INFO - PROCESS | 1919 | 06:15:56 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-beat-detection) 06:15:57 INFO - PROCESS | 1919 | RSS: Main: 247726080 06:15:57 INFO - PROCESS | 1919 | 06:15:59 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-dft) 06:16:00 INFO - PROCESS | 1919 | RSS: Main: 255619072 06:16:00 INFO - PROCESS | 1919 | 06:16:04 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-fft) 06:16:04 INFO - PROCESS | 1919 | RSS: Main: 258191360 06:16:04 INFO - PROCESS | 1919 | 06:16:06 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54077/tests/kraken/driver.html?testName=audio-oscillator) 06:16:07 INFO - PROCESS | 1919 | RSS: Main: 259448832 06:16:07 INFO - PROCESS | 1919 | 06:16:09 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:10 INFO - PROCESS | 1919 | RSS: Main: 261173248 06:16:10 INFO - PROCESS | 1919 | 06:16:13 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:13 INFO - PROCESS | 1919 | RSS: Main: 266616832 06:16:13 INFO - PROCESS | 1919 | 06:16:17 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54077/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:17 INFO - PROCESS | 1919 | RSS: Main: 266067968 06:16:17 INFO - PROCESS | 1919 | 06:16:20 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54077/tests/kraken/driver.html?testName=json-parse-financial) 06:16:21 INFO - PROCESS | 1919 | RSS: Main: 266117120 06:16:21 INFO - PROCESS | 1919 | 06:16:22 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:23 INFO - PROCESS | 1919 | RSS: Main: 265400320 06:16:23 INFO - PROCESS | 1919 | 06:16:25 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:26 INFO - PROCESS | 1919 | RSS: Main: 265445376 06:16:26 INFO - PROCESS | 1919 | 06:16:28 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:29 INFO - PROCESS | 1919 | RSS: Main: 265404416 06:16:29 INFO - PROCESS | 1919 | 06:16:32 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:32 INFO - PROCESS | 1919 | RSS: Main: 265732096 06:16:32 INFO - PROCESS | 1919 | 06:16:36 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:16:36 INFO - PROCESS | 1919 | RSS: Main: 265629696 06:16:36 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54077/tests/kraken/driver.html?testName=ai-astar) 06:16:38 INFO - PROCESS | 1919 | RSS: Main: 267550720 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | __start_tp_report 06:16:38 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 06:16:38 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 06:16:38 INFO - PROCESS | 1919 | |i|pagename|runs| 06:16:38 INFO - PROCESS | 1919 | |0;ai-astar;113;119;117;118;136;121;117;119;118;118 06:16:38 INFO - PROCESS | 1919 | |1;audio-beat-detection;148;114;115;168;114;118;112;113;147;149 06:16:38 INFO - PROCESS | 1919 | |2;audio-dft;204;207;207;246;271;198;260;277;199;278 06:16:38 INFO - PROCESS | 1919 | |3;audio-fft;86;60;63;94;84;87;90;67;77;59 06:16:38 INFO - PROCESS | 1919 | |4;audio-oscillator;90;69;87;73;72;72;102;96;88;83 06:16:38 INFO - PROCESS | 1919 | |5;imaging-gaussian-blur;93;94;93;93;97;94;96;94;93;93 06:16:38 INFO - PROCESS | 1919 | |6;imaging-darkroom;154;112;100;109;155;154;98;100;101;118 06:16:38 INFO - PROCESS | 1919 | |7;imaging-desaturate;95;97;87;93;94;91;117;115;93;93 06:16:38 INFO - PROCESS | 1919 | |8;json-parse-financial;66;64;64;64;67;68;67;66;66;66 06:16:38 INFO - PROCESS | 1919 | |9;json-stringify-tinderbox;75;77;71;86;74;83;109;107;109;71 06:16:38 INFO - PROCESS | 1919 | |10;stanford-crypto-aes;91;92;89;92;105;87;93;90;87;81 06:16:38 INFO - PROCESS | 1919 | |11;stanford-crypto-ccm;151;145;161;163;156;138;168;158;204;171 06:16:38 INFO - PROCESS | 1919 | |12;stanford-crypto-pbkdf2;177;180;186;190;175;174;221;160;236;242 06:16:38 INFO - PROCESS | 1919 | |13;stanford-crypto-sha256-iterative;71;70;70;68;69;68;69;69;69;71 06:16:38 INFO - PROCESS | 1919 | __end_tp_report 06:16:38 INFO - PROCESS | 1919 | __start_cc_report 06:16:38 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1005 06:16:38 INFO - PROCESS | 1919 | __end_cc_report 06:16:38 INFO - PROCESS | 1919 | __startTimestamp1487081798688__endTimestamp 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | ------- Summary: start ------- 06:16:38 INFO - PROCESS | 1919 | Number of tests: 14 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#0] ai-astar Cycles:10 Average:119.60 Median:118.50 stddev:6.11 (5.2%) stddev-sans-first:6.00 06:16:38 INFO - PROCESS | 1919 | Values: 113.0 119.0 117.0 118.0 136.0 121.0 117.0 119.0 118.0 118.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:132.50 stddev:20.85 (15.7%) stddev-sans-first:21.05 06:16:38 INFO - PROCESS | 1919 | Values: 148.0 114.0 115.0 168.0 114.0 118.0 112.0 113.0 147.0 149.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#2] audio-dft Cycles:10 Average:234.70 Median:253.00 stddev:34.72 (13.7%) stddev-sans-first:35.00 06:16:38 INFO - PROCESS | 1919 | Values: 204.0 207.0 207.0 246.0 271.0 198.0 260.0 277.0 199.0 278.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#3] audio-fft Cycles:10 Average:76.70 Median:85.00 stddev:13.32 (15.7%) stddev-sans-first:13.69 06:16:38 INFO - PROCESS | 1919 | Values: 86.0 60.0 63.0 94.0 84.0 87.0 90.0 67.0 77.0 59.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#4] audio-oscillator Cycles:10 Average:83.20 Median:85.00 stddev:11.34 (13.3%) stddev-sans-first:11.76 06:16:38 INFO - PROCESS | 1919 | Values: 90.0 69.0 87.0 73.0 72.0 72.0 102.0 96.0 88.0 83.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:94.00 stddev:1.41 (1.5%) stddev-sans-first:1.45 06:16:38 INFO - PROCESS | 1919 | Values: 93.0 94.0 93.0 93.0 97.0 94.0 96.0 94.0 93.0 93.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#6] imaging-darkroom Cycles:10 Average:120.10 Median:136.00 stddev:24.43 (18.0%) stddev-sans-first:22.62 06:16:38 INFO - PROCESS | 1919 | Values: 154.0 112.0 100.0 109.0 155.0 154.0 98.0 100.0 101.0 118.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:93.00 stddev:10.10 (10.9%) stddev-sans-first:10.67 06:16:38 INFO - PROCESS | 1919 | Values: 95.0 97.0 87.0 93.0 94.0 91.0 117.0 115.0 93.0 93.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 06:16:38 INFO - PROCESS | 1919 | Values: 66.0 64.0 64.0 64.0 67.0 68.0 67.0 66.0 66.0 66.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:74.50 stddev:16.00 (21.5%) stddev-sans-first:16.45 06:16:38 INFO - PROCESS | 1919 | Values: 75.0 77.0 71.0 86.0 74.0 83.0 109.0 107.0 109.0 71.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:90.50 stddev:6.13 (6.8%) stddev-sans-first:6.50 06:16:38 INFO - PROCESS | 1919 | Values: 91.0 92.0 89.0 92.0 105.0 87.0 93.0 90.0 87.0 81.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:161.50 Median:162.00 stddev:18.01 (11.1%) stddev-sans-first:18.69 06:16:38 INFO - PROCESS | 1919 | Values: 151.0 145.0 161.0 163.0 156.0 138.0 168.0 158.0 204.0 171.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:188.00 stddev:28.44 (15.1%) stddev-sans-first:29.48 06:16:38 INFO - PROCESS | 1919 | Values: 177.0 180.0 186.0 190.0 175.0 174.0 221.0 160.0 236.0 242.0 06:16:38 INFO - PROCESS | 1919 | 06:16:38 INFO - PROCESS | 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.07 (1.5%) stddev-sans-first:0.97 06:16:38 INFO - PROCESS | 1919 | Values: 71.0 70.0 70.0 68.0 69.0 68.0 69.0 69.0 69.0 71.0 06:16:38 INFO - PROCESS | 1919 | -------- Summary: end -------- 06:16:38 INFO - PROCESS | 1919 | 06:16:39 INFO - TEST-INFO | 1919: exit 0 06:16:39 INFO - TEST-OK | kraken | took 61883ms 06:16:39 INFO - SUITE-END | took 1178s 06:16:39 INFO - Completed test suite (00:19:39) 06:16:39 INFO - javascript benchmark 06:16:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7086.044983332855, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.6664066952635, 3273.263515708967, 3284.277458959028, 3288.523164141201, 3316.9668303316957, 5318.6011049171275, 5378.273933019042, 5485.561155107592, 5572.275604171457, 5601.551875849932, 5413.945860541394, 5516.641418307807, 5578.0, 5630.071038278689, 5657.23627310313, 5031.52200540948, 5084.542391184793, 5088.92366614501, 5123.180291153416, 5150.0, 4951.8266860659705, 5115.923261151086, 5173.327467429229, 5177.171652535595, 5250.186221135711, 4940.777665005084, 5148.3564554430695, 5158.9484105158845, 5164.535191832753, 5188.221766735001, 4957.504249575014, 5019.52314530119, 5074.59403247743, 5118.769655365518, 5189.0, 5095.312132862054, 5115.641905066647, 5133.358330208724, 5157.58739300855, 5198.428172900978, 4810.6151507879285, 5343.812966546191, 5524.66851988882, 5561.0, 5576.693281869496, 5846.532277417797, 5944.554158438134, 5960.791372301992, 6047.03247480401, 6130.540209484307, 6098.939010609882, 6126.609281623701, 6177.104319873593, 6197.1324014637985, 6218.875622487571, 5739.339975902824, 5747.885042299131, 5753.424657534255, 5759.971200144015, 5765.077587585966, 6085.391460853879, 6111.174991376196, 6218.906716399258, 6221.844453888689, 6304.306526282106, 5878.941210587839, 5885.588008839426, 5901.557383196277, 5979.760809567656, 5993.310769261503, 5282.784959459346, 6190.41191086846, 6195.535334849904, 6215.34738852414, 6217.316095229521, 5489.670619762827, 5817.894600025981, 5927.288725352899, 5961.701914904237, 5972.283326000907, 4993.775280112403, 5028.296038554606, 5998.070299103646, 6128.8774224516155, 6143.354947730424, 4550.840720574764, 4851.51484851512, 4865.221564549655, 4873.561379475864, 4878.634102442331, 3755.8732380285805, 4233.238017156941, 4289.849855255051, 4295.248331541968, 4326.545712700184, 5718.285214348207, 5738.770449181986, 5742.339630942495, 5755.99270127726, 5800.1589769484035, 5080.923786143211, 6207.162033125561, 6221.097940798559, 6228.937710622927, 6276.6547839869245, 5470.0, 5473.75368108436, 5490.780368785284, 5545.861353466115, 5739.397363276879, 5283.286756287929, 5323.095073837457, 5343.118385466354, 5387.138057910715, 5397.4062853086125, 6200.844978875564, 6222.595531290452, 6279.183706118175, 6279.529035322369, 6284.654344010941, 5867.501262392744, 6213.471854892385, 6238.719257633326, 6243.937560624336, 6270.905936411049, 6133.701927635063, 6210.285817130907, 6214.40963108504, 6216.627002379872, 6266.937330626818, 6133.417325354084, 6142.201513803177, 6142.938570614237, 6143.047827586731, 6159.4456498915315, 5516.475934786189, 6136.693165341804, 6144.657134723962, 6189.473894718999, 6219.191505104308, 5678.0, 5772.307323121252, 5789.623674461147, 5883.794067207627, 6045.667488288186, 5905.704714764159, 6019.247594050744, 6024.036154215304, 6042.939570604238, 6065.302490213682, 5388.649737767033, 5611.80358687444, 5711.086226203787, 5762.164486149569, 5874.148248503858, 5940.019896716994, 6000.489958353414, 6009.098635204754, 6009.819705408845, 6025.909611355921, 5612.989661860905, 5637.323521177321, 5649.745761440663, 5828.300603927556, 5864.882702346014], "value": 5545.849376679556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.8769547715131, 497.7287378378783, 519.9636025478217, 547.244802173001, 555.8415851482329, 39202.80398598006, 39604.801975990114, 40267.19465610686, 40884.79557602215, 41062.0, 42853.57146428535, 43543.129137417236, 43550.34674479885, 43648.78175609125, 43779.34330985038, 9235.676751313722, 11030.172737044713, 11482.138839587022, 11533.826992595117, 11647.242929209575, 11159.163062770325, 11242.550297988111, 11245.493952772104, 11251.887481125206, 11268.380239086848, 11162.386068766215, 11252.26860254085, 11269.323840569592, 11274.718132046683, 11289.0, 11192.66422007337, 11239.0, 11254.887451125465, 11267.605633802777, 11289.379084150369, 11227.831582526187, 11319.886801131966, 11330.60342887995, 11335.14986376025, 11337.829932551018, 37614.24771504582, 37748.62251377478, 38031.23937521234, 38086.428703569465, 38125.61874381248, 3747.8586856674747, 3749.1751814600743, 3764.5294338207723, 3778.7543809652284, 3964.8810535683974, 22165.113395464163, 28223.294417639518, 28800.135995919947, 29613.70386296131, 29709.70290297091, 2948.2187220386613, 3057.755379569629, 3093.2576181716227, 3097.1792474994145, 3121.110483512211, 449404.0, 452014.0, 452565.0, 455638.0, 456997.9999999967, 37380.81309593435, 47698.5230147701, 56135.0, 57182.85634287291, 57616.0, 60649.09026364608, 61039.08441373383, 61195.694021529605, 61251.38748612546, 61493.38506614877, 14507.1295722257, 14680.55958321252, 14687.853121468648, 14696.632584185481, 14748.410063597335, 10974.615888443866, 11100.278481898813, 11268.943655281835, 11411.087113030937, 11424.42877856104, 17749.7337539937, 17920.55198620019, 17949.0, 17978.0, 18129.728054079198, 6420.422162005442, 7487.737929172453, 7496.475246732676, 7628.694852205849, 7640.885386719204, 712.8396110875011, 833.5998720614139, 844.5312851367427, 852.1435956863437, 861.4745005546612, 22741.545169096855, 25820.35449113787, 29449.55825662617, 30251.848740756595, 30372.392552148835, 1012.2205901455837, 1019.2152042927053, 1050.9369437833755, 1062.4687656171914, 1157.305616630032, 15303.846961530242, 15358.0, 15398.922075454835, 15435.845641543441, 15806.36774529006, 458754.0, 460894.0, 462277.0, 464046.0, 464165.0, 59287.814243714885, 59678.40321596815, 60320.79358412807, 60336.69831650814, 60377.69811150916, 1182.6924999500363, 1348.8246527951303, 1350.2303686898374, 1389.958301250964, 1403.4736973634888, 28156.577651335658, 28329.433411331247, 28545.28636784097, 28550.42899142047, 28611.856940715163, 51045.0, 51071.0, 51497.7425112887, 51710.22434663558, 52008.479915201875, 464786.6760666175, 467159.6272298276, 467288.0, 469144.0, 469423.0, 24947.376315592257, 25388.111416100346, 25472.490550189264, 26423.943042278093, 26873.731262687124, 42401.36397953972, 42563.57436425596, 43283.35074973815, 43777.34333984929, 43849.0, 30834.845825770728, 31331.84334078315, 34519.654803451645, 34594.82702586471, 35502.28995420129, 34253.486197707556, 34272.82863585666, 35012.0, 35268.823655881555, 35866.28267434584, 34285.82857085699, 34781.65218347784, 35034.64965350314, 35132.0, 35173.296534068664, 29513.704862951956, 30784.53823192609, 30799.076027718307, 31042.068737937898, 31136.0, 23339.416514587272, 23570.292891213292, 23590.938407771348, 23944.760552394255, 24869.751302486744], "value": 19298.60080940672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.42138239185255, 384.6006658757798, 388.9572147063823, 392.25667360352134, 414.82162670051866, 20253.17721405073, 20596.279130230443, 21124.0, 21374.46563835907, 21407.892960535195, 12024.51901923922, 12139.332336721476, 12298.446569904354, 12433.005359571236, 12471.0, 3842.212346468981, 4658.720476771405, 4751.596114330286, 4882.267659851015, 5072.4673909239555, 5197.610179236553, 5717.914231286534, 5974.611650242742, 6050.364711705273, 6142.477889379408, 5001.44984051754, 5998.40015998401, 6117.724702388403, 6156.0, 6156.2920264169525, 4902.583280421169, 5174.9223761643225, 5727.627704199213, 5975.804839032189, 5985.25184351956, 5716.771329146829, 5861.2087368205175, 5951.256092988377, 5954.464098231137, 5988.0, 13648.727025459435, 13716.902647788153, 13802.447902083904, 13990.930045349809, 22579.0, 2519.924402267935, 2554.425254317782, 2561.743825617423, 2590.1323056776005, 2631.7105118436957, 8551.401401901869, 9942.613772694574, 10237.027482389161, 10551.736206594896, 10894.945525272324, 1739.652069586088, 1770.1857145712988, 1781.0026385224317, 1784.1703607822294, 1784.3308759215295, 125103.0, 134748.0, 136623.0, 137742.0, 138873.3056334722, 9968.850467242997, 10165.39007659528, 11601.0, 12009.699757505958, 12185.207961482476, 15604.531864044096, 16334.428295009855, 16338.918305408397, 16349.42777002823, 16350.591235219215, 8506.659733610586, 8634.309255259564, 8749.868751968726, 8787.736367908972, 8829.514376709343, 6638.834029149213, 8039.316658084128, 8135.633896474673, 8354.874676879852, 8491.660333586588, 4844.733539655283, 4918.213085906238, 4924.482929292444, 4940.925886111711, 5042.924356134661, 2048.2319130326127, 2084.5830833833293, 2102.0, 2105.8631188972668, 2112.514121752006, 831.7296878514506, 840.82342708032, 845.8392905347964, 863.4775960543781, 885.4908427653996, 20019.39941801748, 20698.79301206999, 21204.25785097514, 21402.357929261834, 21503.46241343979, 846.6951897316961, 865.8225063861893, 875.5578432891349, 895.167494230359, 903.503073309677, 8305.294050005696, 9398.812023759487, 10940.222139024087, 11173.273737207055, 11213.0, 644913.0, 653993.0, 665272.0, 666110.0, 676994.0, 108933.36599951008, 110705.0, 130044.0, 140027.0, 145346.0, 975.6292608808608, 1019.1337363241333, 1053.836655318427, 1055.8996895294936, 1056.799208150449, 20129.39611811648, 20268.391948241577, 20634.865082420612, 20642.793572064085, 20645.17419303271, 58155.11363068204, 58755.706221468616, 58978.44812502249, 59695.70152149211, 59835.40164598298, 85277.0, 86424.56787716021, 86768.0, 86843.56578217068, 87675.0, 8259.545724985184, 8450.66197352099, 8523.232909038215, 8595.226429621363, 8636.611352489279, 12517.74964500723, 12875.420606072561, 12964.222146670852, 13505.594832155051, 13517.797233041709, 11049.668509944715, 11226.887731122584, 11389.943050284695, 11470.541178352772, 11511.021563167225, 4454.3986561813745, 8217.712380066669, 11088.556457741923, 11093.33439993603, 11518.308901465938, 9808.970058143792, 10128.64549740785, 11417.657470275904, 11716.41417929083, 11773.705657358634, 7254.347108760237, 7395.040314316603, 7515.473916825769, 7578.711619024889, 7905.446618736633, 10084.142847858015, 11304.908591910524, 11563.42182890869, 11678.88321116778, 11704.94147529257], "value": 9387.87113752923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1150.9654710358689, 1177.7173478365196, 1371.6845125621107, 1412.7527682655539, 1421.85540639785, 8173.264406203441, 8338.58307084645, 8570.65717371306, 8610.311175105991, 8633.913660863398, 8439.367047471449, 8559.700410485635, 8564.229219370256, 8570.185832345933, 8577.485350878951, 2244.70818793557, 2269.4439862233776, 2281.5893139235013, 2288.0504590594883, 2296.7588403217674, 2234.910603575855, 2274.5792028474784, 2277.1119263487253, 2289.3933107726466, 2301.0, 2226.7216597925258, 2228.097620463715, 2246.550689862026, 2255.4248666589997, 2258.3450799268194, 2174.467255522407, 2251.122062395667, 2269.092363054775, 2269.7503274639857, 2277.1119263487335, 1907.122723547156, 1990.7212990181386, 2236.787505187021, 2265.4676151104477, 2270.6026445371995, 8263.214994575506, 8464.238218560358, 8476.533790641512, 8524.957375213084, 8571.95714021426, 5126.051680439131, 5232.450592687789, 5310.36275646921, 5320.414754377054, 5327.280817089682, 3428.7428442866885, 3460.480927860841, 3491.807950562718, 3505.5618047744033, 3516.964830351689, 1185.4309931233056, 1190.7558950415143, 1221.694576355911, 1243.9129260951736, 1244.2658831289582, 10780.51487683056, 10843.295185812976, 10941.070009049241, 10952.4523773811, 10970.067544258747, 4121.340585506365, 4402.185595664812, 4477.238869392211, 4484.618807401343, 4486.259767138451, 8604.612792424356, 8687.695930642523, 8742.125787421333, 8743.606537705818, 8773.692920747742, 5099.719515426687, 5103.97448012765, 5127.307813445137, 5127.897442051138, 5131.999260144236, 3878.2631300053463, 4585.656075794262, 4609.0, 4630.282306242538, 4792.400949881265, 3142.4186525492855, 3642.9617558996088, 3663.908402289964, 3697.205100903319, 3697.815109244527, 967.6032826541084, 970.9514524273758, 1064.6539874540806, 1136.8578927634046, 1136.948322801422, 734.9338559529562, 745.5116898431536, 758.8747856603599, 763.7326935572505, 802.1377019703842, 5338.332708411449, 5528.917066244009, 5540.113581826969, 5571.498565129077, 5588.748506317144, 544.6731960823474, 547.4908335248177, 566.8242844718151, 571.2459553389486, 574.5317566183547, 3377.80088068737, 3713.5543734752005, 3776.7922764247683, 3876.321643712339, 3878.96121038786, 9567.186789123003, 10081.546330415149, 10088.646897358558, 10090.34412763168, 10098.394096354243, 10024.649137280161, 10043.995600440043, 10065.647702330383, 10067.69796906094, 10082.647107351208, 7558.3953283738265, 7669.233076692286, 7724.806879828049, 7858.253465920729, 7872.488288261359, 5371.301730774974, 5374.838754837361, 5442.605253688364, 5487.6158668892795, 5608.943910560843, 9046.68336608242, 9071.36500444989, 9233.630654773733, 9297.767555810888, 9341.205997490018, 9076.727698169065, 9138.17756401927, 9349.626014959325, 9466.05339466048, 9466.95266523663, 6638.701258443478, 6791.0153027811675, 6803.455723542006, 6812.693428795816, 6820.454363650995, 7711.807204819925, 7772.145064043064, 7889.487183333065, 7904.525728456311, 7924.683012679428, 5855.414458554281, 7068.974998625068, 7079.68141433647, 7153.427725781821, 7212.74755383559, 6878.69045892946, 6965.373116419547, 6990.545614535039, 7036.683349249193, 7058.200158959433, 6255.9374406257175, 6422.100905873088, 6438.7102580384935, 6440.4525615321345, 6461.450776683847, 3850.403187505941, 4134.565870583546, 4812.494688057844, 4998.175301075427, 5041.966396888703, 4919.778609962489, 4966.6771659842, 5009.54914057722, 5083.085044691991, 5098.745062746922], "value": 4252.9163733680425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.49528678702666, 360.94585812128196, 363.37136753416587, 364.790245608775, 365.8536585365855, 4594.701344412615, 5282.788688452457, 5417.891642167159, 5426.728663566825, 5493.285872836531, 4087.734297270675, 5281.603879709028, 5372.495701203659, 5378.435264297251, 5396.136618141099, 4076.673866090713, 4092.1611069730634, 4112.650424713903, 4117.341225403936, 4121.505419349683, 3408.7443441741843, 3947.960520394788, 4017.2602109037075, 4108.691848111389, 4123.5876412358675, 3472.583290005203, 3527.3121741260466, 3737.6262373762543, 3984.2230765000836, 4025.2754504189234, 3513.279777645589, 3994.820233089518, 4015.6586690131376, 4016.939745903799, 4027.026756889103, 3271.263965607743, 3339.158220580144, 3513.0, 3520.5951315598522, 3552.289542091566, 4195.46865394129, 4519.141363140992, 4900.681455705368, 5035.676453540682, 5305.8938821223355, 4650.325702773112, 4652.976735116336, 4658.534146585348, 4659.32439796231, 4694.460137084245, 4585.656075794329, 4626.375439315683, 5722.084466485342, 5750.964826331258, 5841.153032810219, 3595.406757884946, 3740.251949610089, 3884.009577557733, 3884.7086468514976, 3905.6915933162427, 5684.431556844283, 5881.765129107079, 5946.821595352189, 5991.460768530853, 6028.577999540034, 3336.849841757127, 3638.799866007395, 3665.0, 3912.628300311466, 3952.6442620164325, 3979.6020397959974, 3987.7407968481957, 3991.341428664238, 3998.640122388999, 4008.3586626139677, 4114.794260286973, 4201.18076974987, 4586.403767510203, 4603.930941035887, 4689.835855745033, 4848.71509050102, 5330.653507521999, 5736.512396446349, 5745.368009518949, 5753.798617048383, 1119.9384033878052, 1177.4407156600546, 1231.7844377234128, 1268.9175203611735, 1287.7810772168566, 697.3375293471223, 820.7073858672615, 822.7778499805139, 870.6212797433137, 880.41892351048, 4811.975940120277, 4995.875103122378, 5143.019937324082, 5143.588512918957, 5155.355580552431, 5006.874828129253, 5330.253764472977, 5410.431904650034, 5699.601027928005, 5700.0, 4463.843765468193, 4681.81272749093, 4839.806407743651, 4955.803506738206, 5112.233165025276, 2607.4394005288955, 2628.973710262911, 2913.402752435788, 2955.6305461817274, 2972.286651203739, 4989.775460104304, 5316.680999140064, 5347.3583170019065, 5748.349797878293, 5826.184334193216, 4844.95155048445, 4909.146320138674, 4939.629527785431, 5625.0187400677705, 5749.626274292157, 5256.001359741714, 5263.657482576813, 5387.865303367447, 5423.674579525241, 5736.368999410061, 4752.217918280645, 4968.27959945813, 5606.439356064361, 5702.37273899879, 5708.914366284426, 4971.477994810492, 5186.844394668166, 5517.186235020249, 5633.8309850704545, 5708.060348920227, 5275.393329766973, 5712.0, 5908.438698323653, 5933.317668468008, 6124.5406594506485, 3830.0, 3854.8843534694006, 4017.6942493689085, 4216.91566168681, 4294.9692073901415, 5425.701586412785, 5503.0, 5957.6127551709, 5962.821115366546, 6002.789902353396, 5031.012749963817, 5399.759099973467, 5722.484976352148, 5747.683877386784, 5749.051406518045, 5270.8945821084135, 5700.087985922232, 5743.0, 5761.884762304814, 5800.883982320414, 4876.024795041077, 5257.474252574865, 5316.6544174628525, 5560.638558493685, 5625.353084395347, 5048.899022019613, 5696.202531645656, 5724.427557244242, 5740.942590574041, 5760.6255593386295, 5140.3831540215415, 5620.522255608319, 5647.887042259214, 5649.519790817662, 5674.744636491285], "value": 4067.7834091221644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.9703463344152, 676.5725606736008, 750.114864459937, 790.2295262119434, 791.9150763454069, 14421.351039203235, 14876.099160663674, 15280.312385942632, 15344.309506072226, 15459.30433130509, 14067.507637232673, 14127.717445651106, 14402.927985360086, 14420.495282665082, 14420.855791442082, 802.6307898366729, 877.7322916510461, 884.9203571678547, 905.307439808547, 906.1753804038326, 876.5967654878764, 896.4531635702216, 898.2409863665192, 900.8648702694616, 901.5537309032038, 951.6526467839258, 953.7615596100975, 953.9427634341962, 955.1022039283087, 955.9665411710591, 937.2267878999818, 938.5213541094023, 950.9191718703919, 951.3816019587255, 952.1383148250844, 695.9977632209602, 699.5837476701355, 704.0565642039641, 704.4681265644457, 705.1432509500981, 14770.409183632642, 15258.160801155933, 15316.081035137928, 15362.615934601612, 15487.303071361815, 13331.600051998455, 13346.933265333708, 13880.917862320632, 14201.431942722278, 14232.715345693028, 9028.50343231122, 9280.211182049534, 11243.943780281046, 11618.244814087057, 11680.883191168065, 3057.281538838371, 3351.9664803351898, 3566.268914872445, 3647.288778688157, 3657.195417008254, 80158.59920700417, 105248.0, 105778.0, 106609.46695266552, 107143.46428267886, 10675.612170417797, 10732.839007414896, 10747.731306717238, 10806.891931080745, 11051.502682379312, 22084.0, 22208.777912220994, 22421.215257465912, 22429.214977476036, 22438.10247590111, 7466.402687784964, 7496.887546686804, 7507.0, 7520.172780994087, 7737.961310193413, 4103.724209095443, 4155.273924758045, 4231.896419202721, 4270.807813648394, 4285.185814695198, 3604.098975256186, 3705.1107734144152, 3713.702903767692, 3714.9628503715157, 3722.1253005543676, 663.6184194088322, 668.5620918298522, 674.5345711459078, 687.226869771507, 693.6843736100062, 605.5246631394334, 636.2365161805851, 674.7874419557824, 686.1697346211041, 698.8707089188516, 8322.70870519529, 9701.466419346863, 9832.213422926148, 9941.403515789076, 10282.331648442827, 638.5562034386057, 667.1860330396908, 676.7022510095542, 701.8420855307515, 722.2452537098744, 4594.65540084495, 4830.686005409637, 4832.9850731346105, 4840.782164802592, 4852.708837469763, 101424.49287753661, 104031.4798426003, 104525.0, 104636.0, 106200.0, 62791.6860415695, 73270.63364683143, 74583.88124178142, 76021.0, 79368.74518860578, 67997.3200268001, 69582.65208674026, 70510.94233586501, 71319.2868071323, 71349.6432517834, 10401.219908507044, 10515.57937682484, 10525.210609204187, 10620.628278010232, 10640.467976601294, 34704.65295347014, 40035.799821000706, 44599.77700111479, 45089.64731058074, 46849.53150468451, 55131.44868551424, 59768.70115649394, 60158.79682406415, 61003.0, 61106.0, 12145.878541214475, 12577.559785407468, 12618.305993170463, 12727.0, 13114.0, 13457.865421346052, 13759.500878908748, 13864.722705545631, 13867.445302188204, 14075.436982520585, 10245.84631230547, 10555.52500137511, 12885.871141288842, 13284.933575332061, 13417.798733019208, 10485.346396220093, 11984.801519847946, 12342.568010119961, 12960.35198240103, 13001.609951701465, 10439.94780026095, 12503.87124489244, 12663.430145643284, 12808.359582021048, 13337.466501340226, 10566.947165264124, 10608.0, 10653.0810478635, 10866.402347870942, 10974.018564546865, 9126.406783559047, 9331.906680933103, 9398.624055037995, 9523.903810551568, 9606.711798646053], "value": 7282.3224679259865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 117.0, 118.0, 136.0, 121.0, 117.0, 119.0, 118.0, 118.0], "value": 119.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 114.0, 115.0, 168.0, 114.0, 118.0, 112.0, 113.0, 147.0, 149.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 207.0, 207.0, 246.0, 271.0, 198.0, 260.0, 277.0, 199.0, 278.0], "value": 234.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 63.0, 94.0, 84.0, 87.0, 90.0, 67.0, 77.0, 59.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 73.0, 72.0, 72.0, 102.0, 96.0, 88.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 97.0, 94.0, 96.0, 94.0, 93.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 112.0, 100.0, 109.0, 155.0, 154.0, 98.0, 100.0, 101.0, 118.0], "value": 120.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 87.0, 93.0, 94.0, 91.0, 117.0, 115.0, 93.0, 93.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 67.0, 68.0, 67.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 71.0, 86.0, 74.0, 83.0, 109.0, 107.0, 109.0, 71.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 89.0, 92.0, 105.0, 87.0, 93.0, 90.0, 87.0, 81.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 161.0, 163.0, 156.0, 138.0, 168.0, 158.0, 204.0, 171.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 186.0, 190.0, 175.0, 174.0, 221.0, 160.0, 236.0, 242.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 71.0], "value": 69.4, "unit": "score"}]}]} 06:16:39 INFO - Return code: 0 06:16:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:16:40 ERROR - # TBPL SUCCESS # 06:16:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:16:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:16:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:16:40 INFO - 2017-02-14 06:16:40.019 screenresolution[1924:20859] starting screenresolution argv=screenresolution get 06:16:40 INFO - 2017-02-14 06:16:40.022 screenresolution[1924:20859] Display 0: 1600x1200x32@60 06:16:40 INFO - 2017-02-14 06:16:40.028 screenresolution[1925:20862] starting screenresolution argv=screenresolution list 06:16:40 INFO - Available Modes on Display 0 06:16:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:16:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:16:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:16:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:16:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:16:40 INFO - Intel Iris: 06:16:40 INFO - Chipset Model: Intel Iris 06:16:40 INFO - Type: GPU 06:16:40 INFO - Bus: Built-In 06:16:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:16:40 INFO - Vendor: Intel (0x8086) 06:16:40 INFO - Device ID: 0x0a2e 06:16:40 INFO - Revision ID: 0x0009 06:16:40 INFO - Displays: 06:16:40 INFO - Display: 06:16:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:16:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:16:40 INFO - Display Serial Number: 1600x1200 60 06:16:40 INFO - Main Display: Yes 06:16:40 INFO - Mirror: Off 06:16:40 INFO - Online: Yes 06:16:40 INFO - Rotation: Supported 06:16:40 INFO - Return code: 0 06:16:40 INFO - Running post-action listener: _resource_record_post_action 06:16:40 INFO - [mozharness: 2017-02-14 14:16:40.269255Z] Finished run-tests step (success) 06:16:40 INFO - Running post-run listener: _resource_record_post_run 06:16:40 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 962560; Write bytes: 558189056; Read time: 13; Write time: 1702 06:16:40 INFO - TinderboxPrint: CPU usage
54.4% 06:16:40 INFO - TinderboxPrint: I/O read bytes / time
962,560 / 13 06:16:40 INFO - TinderboxPrint: I/O write bytes / time
558,189,056 / 1,702 06:16:40 INFO - TinderboxPrint: CPU idle
2,190.8 (45.6%) 06:16:40 INFO - TinderboxPrint: CPU system
967.7 (20.1%) 06:16:40 INFO - TinderboxPrint: CPU user
1,651.1 (34.3%) 06:16:40 INFO - TinderboxPrint: Swap in / out
254,136,320 / 0 06:16:40 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 240404992; Write bytes: 234960384; Read time: 17561; Write time: 506 06:16:40 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 962560; Write bytes: 301757440; Read time: 13; Write time: 1145 06:16:40 INFO - Running post-run listener: _upload_blobber_files 06:16:40 INFO - Blob upload gear active. 06:16:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:16:40 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 06:16:40 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'] 06:16:40 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 06:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:42 INFO - (blobuploader) - INFO - Done attempting. 06:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:43 INFO - (blobuploader) - INFO - Done attempting. 06:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:44 INFO - (blobuploader) - INFO - Done attempting. 06:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:48 INFO - (blobuploader) - INFO - Done attempting. 06:16:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:16:48 INFO - Return code: 0 06:16:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:16:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:16:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7705e2216c3fc2bd99d804659d6d1a4d4affd8887f531147bcb0b20fe02ef44c1e6856a8fd6a4401f60135892803dde05b2f9bcd37819013036141f398b5b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e57f5791511f3fca6f6c46e3a655abdc12712e8a2c080ba85216078bb5c7b8deb9f473e80082ff7cf1e9198df482be95fefb96039953a4541af1dccd47ad0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98499b78c133067557135a218be9e8999fc54027ba12a186c7cc6757b6d7edec601188f9ced7ef1ebed8a000b09711e0ca406abbf4f403a0ccd047f2022b70cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9dae723a25916c204df31a5ac7d6c52306c54c2e131cd764c4fc886e9c1d3924a96622d294bade82727ea1cd269d9f39dae54360577e95c0a11ad70ff59785a"} 06:16:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:16:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:16:48 INFO - Contents: 06:16:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7705e2216c3fc2bd99d804659d6d1a4d4affd8887f531147bcb0b20fe02ef44c1e6856a8fd6a4401f60135892803dde05b2f9bcd37819013036141f398b5b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e57f5791511f3fca6f6c46e3a655abdc12712e8a2c080ba85216078bb5c7b8deb9f473e80082ff7cf1e9198df482be95fefb96039953a4541af1dccd47ad0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98499b78c133067557135a218be9e8999fc54027ba12a186c7cc6757b6d7edec601188f9ced7ef1ebed8a000b09711e0ca406abbf4f403a0ccd047f2022b70cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9dae723a25916c204df31a5ac7d6c52306c54c2e131cd764c4fc886e9c1d3924a96622d294bade82727ea1cd269d9f39dae54360577e95c0a11ad70ff59785a"} 06:16:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:16:48 INFO - Copying logs to upload dir... 06:16:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:16:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.049211 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-14 06:16:48.081916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 06:16:48.085757) ========= 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.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7705e2216c3fc2bd99d804659d6d1a4d4affd8887f531147bcb0b20fe02ef44c1e6856a8fd6a4401f60135892803dde05b2f9bcd37819013036141f398b5b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e57f5791511f3fca6f6c46e3a655abdc12712e8a2c080ba85216078bb5c7b8deb9f473e80082ff7cf1e9198df482be95fefb96039953a4541af1dccd47ad0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98499b78c133067557135a218be9e8999fc54027ba12a186c7cc6757b6d7edec601188f9ced7ef1ebed8a000b09711e0ca406abbf4f403a0ccd047f2022b70cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9dae723a25916c204df31a5ac7d6c52306c54c2e131cd764c4fc886e9c1d3924a96622d294bade82727ea1cd269d9f39dae54360577e95c0a11ad70ff59785a"} build_url:https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf7705e2216c3fc2bd99d804659d6d1a4d4affd8887f531147bcb0b20fe02ef44c1e6856a8fd6a4401f60135892803dde05b2f9bcd37819013036141f398b5b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e57f5791511f3fca6f6c46e3a655abdc12712e8a2c080ba85216078bb5c7b8deb9f473e80082ff7cf1e9198df482be95fefb96039953a4541af1dccd47ad0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98499b78c133067557135a218be9e8999fc54027ba12a186c7cc6757b6d7edec601188f9ced7ef1ebed8a000b09711e0ca406abbf4f403a0ccd047f2022b70cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9dae723a25916c204df31a5ac7d6c52306c54c2e131cd764c4fc886e9c1d3924a96622d294bade82727ea1cd269d9f39dae54360577e95c0a11ad70ff59785a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 06:16:48.126873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:16:48.127450) ========= 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.Us1LxupYAC/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.JHjJGEJRCl/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:16:48.176910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 06:16:48.177240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 06:16:48.177566) ========= ========= Total master_lag: 0.19 =========