builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0008 starttime: 1484335307.38 results: success (0) buildid: 20170113092130 builduid: fd0fcf31c4504f78b325f2758b387be1 revision: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:47.379129) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:47.379660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:47.380078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:47.554623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:47.555273) ========= 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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-01-13 11:21:47-- 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% 164M=0s 2017-01-13 11:21:48 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.547896 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:48.141563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:48.141909) ========= 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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.029224 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:48.195624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 11:21:48.195923) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-01-13 11:21:48,292 truncating revision to first 12 chars 2017-01-13 11:21:48,292 Setting DEBUG logging. 2017-01-13 11:21:48,292 attempt 1/10 2017-01-13 11:21:48,292 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/6cdd4bd2998d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 11:21:49,366 unpacking tar archive at: graphics-6cdd4bd2998d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348118 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 11:21:49.569675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:49.569943) ========= script_repo_revision: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:49.570303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:49.570580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 11:21:49.590004) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-13 11:21:49.590267) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:21:49 INFO - MultiFileLogger online at 20170113 11:21:49 in /builds/slave/test 11:21:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 11:21:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:49 INFO - {'append_to_log': False, 11:21:49 INFO - 'base_work_dir': '/builds/slave/test', 11:21:49 INFO - 'blob_upload_branch': 'Graphics', 11:21:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:49 INFO - 'branch': 'Graphics', 11:21:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:49 INFO - 'config_files': ('talos/mac_config.py',), 11:21:49 INFO - 'default_actions': ('clobber', 11:21:49 INFO - 'read-buildbot-config', 11:21:49 INFO - 'download-and-extract', 11:21:49 INFO - 'populate-webroot', 11:21:49 INFO - 'create-virtualenv', 11:21:49 INFO - 'install', 11:21:49 INFO - 'run-tests'), 11:21:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:49 INFO - 'download_minidump_stackwalk': True, 11:21:49 INFO - 'download_symbols': 'ondemand', 11:21:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:49 INFO - 'installer_path': 'installer.exe', 11:21:49 INFO - 'log_level': 'info', 11:21:49 INFO - 'log_name': 'talos', 11:21:49 INFO - 'log_to_console': True, 11:21:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:21:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:21:49 INFO - 'opt_config_files': (), 11:21:49 INFO - 'pip_index': False, 11:21:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:21:49 INFO - 'cmd': ('bash', 11:21:49 INFO - '-c', 11:21:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:21:49 INFO - 'enabled': True, 11:21:49 INFO - 'halt_on_failure': False, 11:21:49 INFO - 'name': 'check_screen_resolution'},), 11:21:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:21:49 INFO - 'cmd': ('bash', 11:21:49 INFO - '-c', 11:21:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:21:49 INFO - 'enabled': True, 11:21:49 INFO - 'halt_on_failure': False, 11:21:49 INFO - 'name': 'check_screen_resolution'},), 11:21:49 INFO - 'run_cmd_checks_enabled': True, 11:21:49 INFO - 'sps_profile': False, 11:21:49 INFO - 'sps_profile_interval': 0, 11:21:49 INFO - 'suite': 'dromaeojs-e10s', 11:21:49 INFO - 'system_bits': '32', 11:21:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:49 INFO - 'title': 't-yosemite-r7-0008', 11:21:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:49 INFO - 'use_talos_json': True, 11:21:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:49 INFO - 'work_dir': 'build'} 11:21:49 INFO - [mozharness: 2017-01-13 19:21:49.799676Z] Running clobber step. 11:21:49 INFO - Running pre-action listener: _resource_record_pre_action 11:21:49 INFO - Running main action method: clobber 11:21:49 INFO - rmtree: /builds/slave/test/build 11:21:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:52 INFO - Running post-action listener: _resource_record_post_action 11:21:52 INFO - [mozharness: 2017-01-13 19:21:52.289794Z] Finished clobber step (success) 11:21:52 INFO - [mozharness: 2017-01-13 19:21:52.290055Z] Running read-buildbot-config step. 11:21:52 INFO - Running pre-action listener: _resource_record_pre_action 11:21:52 INFO - Running main action method: read_buildbot_config 11:21:52 INFO - Using buildbot properties: 11:21:52 INFO - { 11:21:52 INFO - "project": "", 11:21:52 INFO - "product": "firefox", 11:21:52 INFO - "script_repo_revision": "default", 11:21:52 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 11:21:52 INFO - "repository": "", 11:21:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 11:21:52 INFO - "buildid": "20170113092130", 11:21:52 INFO - "pgo_build": "False", 11:21:52 INFO - "basedir": "/builds/slave/test", 11:21:52 INFO - "buildnumber": 20, 11:21:52 INFO - "slavename": "t-yosemite-r7-0008", 11:21:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:21:52 INFO - "platform": "yosemite_r7", 11:21:52 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 11:21:52 INFO - "branch": "graphics", 11:21:52 INFO - "repo_path": "projects/graphics", 11:21:52 INFO - "revision": "6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a", 11:21:52 INFO - "stage_platform": "macosx64", 11:21:52 INFO - "builduid": "fd0fcf31c4504f78b325f2758b387be1", 11:21:52 INFO - "slavebuilddir": "test" 11:21:52 INFO - } 11:21:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:21:52 INFO - Running post-action listener: _resource_record_post_action 11:21:52 INFO - [mozharness: 2017-01-13 19:21:52.295773Z] Finished read-buildbot-config step (success) 11:21:52 INFO - [mozharness: 2017-01-13 19:21:52.295983Z] Running download-and-extract step. 11:21:52 INFO - Running pre-action listener: _resource_record_pre_action 11:21:52 INFO - Running main action method: download_and_extract 11:21:52 INFO - mkdir: /builds/slave/test/build/tests 11:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:52 INFO - trying https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:21:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 11:21:53 INFO - Downloaded 1199 bytes. 11:21:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:21:53 INFO - Using the following test package requirements: 11:21:53 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:21:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:21:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:21:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'jsshell-mac.zip'], 11:21:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:21:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:21:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:21:53 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:21:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:21:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:21:53 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:21:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:21:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:21:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:21:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:21:54 INFO - Expected file size: 16316854 11:21:54 INFO - Obtained file size: 16316854 11:22:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:22:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:22:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:22:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:22:02 INFO - Expected file size: 16316854 11:22:02 INFO - Obtained file size: 16316854 11:22:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:22:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:22:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:22:10 INFO - Expected file size: 14403555 11:22:10 INFO - Obtained file size: 14403555 11:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:10 INFO - trying https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:22:10 INFO - Downloading https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 11:22:12 INFO - Downloaded 70217479 bytes. 11:22:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:22:12 INFO - mkdir: /builds/slave/test/properties 11:22:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:12 INFO - Contents: 11:22:12 INFO - build_url:https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:22:13 INFO - Running post-action listener: _resource_record_post_action 11:22:13 INFO - Running post-action listener: set_extra_try_arguments 11:22:13 INFO - [mozharness: 2017-01-13 19:22:13.166874Z] Finished download-and-extract step (success) 11:22:13 INFO - [mozharness: 2017-01-13 19:22:13.166976Z] Running populate-webroot step. 11:22:13 INFO - Running pre-action listener: _resource_record_pre_action 11:22:13 INFO - Running main action method: populate_webroot 11:22:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:13 INFO - '--tppagecycles', 11:22:13 INFO - '7'], 11:22:13 INFO - 'tests': ['tsvgm']}}, 11:22:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['damp', 'tps']}, 11:22:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'tests': ['damp', 'tps']}, 11:22:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['dromaeo_dom']}, 11:22:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['basic_compositor_video']}, 11:22:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['a11yr', 11:22:13 INFO - 'ts_paint', 11:22:13 INFO - 'tpaint', 11:22:13 INFO - 'sessionrestore', 11:22:13 INFO - 'sessionrestore_no_auto_restore', 11:22:13 INFO - 'tabpaint']}, 11:22:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['tsvgx', 11:22:13 INFO - 'tsvgr_opacity', 11:22:13 INFO - 'tart', 11:22:13 INFO - 'tscrollx', 11:22:13 INFO - 'cart', 11:22:13 INFO - 'tsvg_static']}, 11:22:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:13 INFO - 'tsvgr_opacity', 11:22:13 INFO - 'tart', 11:22:13 INFO - 'tscrollx', 11:22:13 INFO - 'cart', 11:22:13 INFO - 'tsvg_static']}, 11:22:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'talos_options': ['--disable-e10s'], 11:22:13 INFO - 'tests': ['tp5o']}, 11:22:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:22:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'talos_options': ['--disable-e10s', 11:22:13 INFO - '--xperf_path', 11:22:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:13 INFO - 'tests': ['tp5n']}, 11:22:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:22:13 INFO - 'talos_options': ['--xperf_path', 11:22:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:13 INFO - 'tests': ['tp5n']}}, 11:22:13 INFO - 'talos.zip': {'path': '', 11:22:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:13 INFO - Running post-action listener: _resource_record_post_action 11:22:13 INFO - [mozharness: 2017-01-13 19:22:13.183501Z] Finished populate-webroot step (success) 11:22:13 INFO - [mozharness: 2017-01-13 19:22:13.183654Z] Running create-virtualenv step. 11:22:13 INFO - Running pre-action listener: _resource_record_pre_action 11:22:13 INFO - Running main action method: create_virtualenv 11:22:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:22:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:13 INFO - Using real prefix '/tools/python27' 11:22:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:16 INFO - Installing pip.................done. 11:22:16 INFO - Return code: 0 11:22:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:22:17 INFO - Reading from file tmpfile_stdout 11:22:17 INFO - Output received: 11:22:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:22:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22: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', 'pip>=1.5'] in /builds/slave/test/build 11:22: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 pip>=1.5 11:22:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:17 INFO - 'HOME': '/Users/cltbld', 11:22:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:17 INFO - 'LOGNAME': 'cltbld', 11:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:17 INFO - 'MOZ_NO_REMOTE': '1', 11:22:17 INFO - 'NO_EM_RESTART': '1', 11:22:17 INFO - 'PAGER': '/bin/cat', 11:22:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:17 INFO - 'PWD': '/builds/slave/test', 11:22:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:17 INFO - 'SHELL': '/bin/bash', 11:22:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:17 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:17 INFO - 'USER': 'cltbld', 11:22:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:17 INFO - 'XPC_FLAGS': '0x0', 11:22:17 INFO - 'XPC_SERVICE_NAME': '0', 11:22:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:22:17 INFO - Cleaning up... 11:22:17 INFO - Return code: 0 11:22:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', '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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22: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 psutil>=3.1.1 11:22:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:17 INFO - 'HOME': '/Users/cltbld', 11:22:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:17 INFO - 'LOGNAME': 'cltbld', 11:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:17 INFO - 'MOZ_NO_REMOTE': '1', 11:22:17 INFO - 'NO_EM_RESTART': '1', 11:22:17 INFO - 'PAGER': '/bin/cat', 11:22:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:17 INFO - 'PWD': '/builds/slave/test', 11:22:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:17 INFO - 'SHELL': '/bin/bash', 11:22:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:17 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:17 INFO - 'USER': 'cltbld', 11:22:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:17 INFO - 'XPC_FLAGS': '0x0', 11:22:17 INFO - 'XPC_SERVICE_NAME': '0', 11:22:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Downloading/unpacking psutil>=3.1.1 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:21 INFO - Installing collected packages: psutil 11:22:21 INFO - Running setup.py install for psutil 11:22:21 INFO - building 'psutil._psutil_osx' extension 11:22:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:22:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:22:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:22:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:22:22 INFO - building 'psutil._psutil_posix' extension 11:22:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:22:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:22:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:22:22 INFO - ^ 11:22:22 INFO - 1 warning generated. 11:22:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Successfully installed psutil 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22: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 mozsystemmonitor==0.3 11:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:22 INFO - 'HOME': '/Users/cltbld', 11:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:22 INFO - 'LOGNAME': 'cltbld', 11:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:22 INFO - 'MOZ_NO_REMOTE': '1', 11:22:22 INFO - 'NO_EM_RESTART': '1', 11:22:22 INFO - 'PAGER': '/bin/cat', 11:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:22 INFO - 'PWD': '/builds/slave/test', 11:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:22 INFO - 'SHELL': '/bin/bash', 11:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:22 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:22 INFO - 'USER': 'cltbld', 11:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:22 INFO - 'XPC_FLAGS': '0x0', 11:22:22 INFO - 'XPC_SERVICE_NAME': '0', 11:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:25 INFO - Installing collected packages: mozsystemmonitor 11:22:25 INFO - Running setup.py install for mozsystemmonitor 11:22:25 INFO - Successfully installed mozsystemmonitor 11:22:25 INFO - Cleaning up... 11:22:26 INFO - Return code: 0 11:22:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:26 INFO - 'HOME': '/Users/cltbld', 11:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:26 INFO - 'LOGNAME': 'cltbld', 11:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:26 INFO - 'MOZ_NO_REMOTE': '1', 11:22:26 INFO - 'NO_EM_RESTART': '1', 11:22:26 INFO - 'PAGER': '/bin/cat', 11:22:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:26 INFO - 'PWD': '/builds/slave/test', 11:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:26 INFO - 'SHELL': '/bin/bash', 11:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:26 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:26 INFO - 'USER': 'cltbld', 11:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:26 INFO - 'XPC_FLAGS': '0x0', 11:22:26 INFO - 'XPC_SERVICE_NAME': '0', 11:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:29 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:29 INFO - warning: no files found matching '*.txt' 11:22:29 INFO - no previously-included directories found matching 'build' 11:22:29 INFO - no previously-included directories found matching 'dist' 11:22:29 INFO - no previously-included directories found matching '.git*' 11:22:29 INFO - Installing collected packages: jsonschema, functools32 11:22:29 INFO - Running setup.py install for functools32 11:22:29 INFO - warning: no files found matching '*.txt' 11:22:29 INFO - no previously-included directories found matching 'build' 11:22:29 INFO - no previously-included directories found matching 'dist' 11:22:29 INFO - no previously-included directories found matching '.git*' 11:22:29 INFO - Successfully installed jsonschema functools32 11:22:29 INFO - Cleaning up... 11:22:29 INFO - Return code: 0 11:22:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:29 INFO - 'HOME': '/Users/cltbld', 11:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:29 INFO - 'LOGNAME': 'cltbld', 11:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:29 INFO - 'MOZ_NO_REMOTE': '1', 11:22:29 INFO - 'NO_EM_RESTART': '1', 11:22:29 INFO - 'PAGER': '/bin/cat', 11:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:29 INFO - 'PWD': '/builds/slave/test', 11:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:29 INFO - 'SHELL': '/bin/bash', 11:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:29 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:29 INFO - 'USER': 'cltbld', 11:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:29 INFO - 'XPC_FLAGS': '0x0', 11:22:29 INFO - 'XPC_SERVICE_NAME': '0', 11:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:29 INFO - Cleaning up... 11:22:29 INFO - Return code: 0 11:22:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:29 INFO - 'HOME': '/Users/cltbld', 11:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:29 INFO - 'LOGNAME': 'cltbld', 11:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:29 INFO - 'MOZ_NO_REMOTE': '1', 11:22:29 INFO - 'NO_EM_RESTART': '1', 11:22:29 INFO - 'PAGER': '/bin/cat', 11:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:29 INFO - 'PWD': '/builds/slave/test', 11:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:29 INFO - 'SHELL': '/bin/bash', 11:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:29 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:29 INFO - 'USER': 'cltbld', 11:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:29 INFO - 'XPC_FLAGS': '0x0', 11:22:29 INFO - 'XPC_SERVICE_NAME': '0', 11:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:33 INFO - Downloading docopt-0.6.1.tar.gz 11:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:34 INFO - Running setup.py install for blobuploader 11:22:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:34 INFO - Running setup.py install for requests 11:22:34 INFO - Running setup.py install for docopt 11:22:34 INFO - Successfully installed blobuploader requests docopt 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:34 INFO - 'HOME': '/Users/cltbld', 11:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PAGER': '/bin/cat', 11:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test', 11:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:34 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - 'XPC_FLAGS': '0x0', 11:22:34 INFO - 'XPC_SERVICE_NAME': '0', 11:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JN9Gl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-pXm8pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-QI4mAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-mDQywp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-c7uT7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-LB3SQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-8jXDii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-9PP4lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-NczRV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zRIPai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Z1yEw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-pz1VP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-X0j86v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UC1OIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-LH80QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-lT95sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-fahw1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:37 INFO - Running setup.py install for manifestparser 11:22:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:37 INFO - Running setup.py install for mozcrash 11:22:37 INFO - Running setup.py install for mozdebug 11:22:37 INFO - Running setup.py install for mozdevice 11:22:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:37 INFO - Running setup.py install for mozfile 11:22:37 INFO - Running setup.py install for mozhttpd 11:22:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:37 INFO - Running setup.py install for mozinfo 11:22:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Running setup.py install for mozInstall 11:22:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Running setup.py install for mozleak 11:22:38 INFO - Running setup.py install for mozlog 11:22:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Running setup.py install for moznetwork 11:22:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Running setup.py install for mozprocess 11:22:38 INFO - Running setup.py install for mozprofile 11:22:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:38 INFO - Running setup.py install for mozrunner 11:22:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:39 INFO - Running setup.py install for mozscreenshot 11:22:39 INFO - Running setup.py install for moztest 11:22:39 INFO - Running setup.py install for mozversion 11:22:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:39 INFO - Cleaning up... 11:22:39 INFO - Return code: 0 11:22:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:39 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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:39 INFO - 'HOME': '/Users/cltbld', 11:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:39 INFO - 'LOGNAME': 'cltbld', 11:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:39 INFO - 'MOZ_NO_REMOTE': '1', 11:22:39 INFO - 'NO_EM_RESTART': '1', 11:22:39 INFO - 'PAGER': '/bin/cat', 11:22:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:39 INFO - 'PWD': '/builds/slave/test', 11:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:39 INFO - 'SHELL': '/bin/bash', 11:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:39 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:39 INFO - 'USER': 'cltbld', 11:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:39 INFO - 'XPC_FLAGS': '0x0', 11:22:39 INFO - 'XPC_SERVICE_NAME': '0', 11:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zpaPoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UgOH7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zCejT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-acQwkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-7P_NY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-N73gdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-3KVS5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-nClSlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZQi_zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Irb8_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-eDw8G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-M0s2Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:41 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)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-6Wo0CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ey4ZlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WdDMYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ypqiBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Wrr8fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:44 INFO - Downloading blessings-1.6.tar.gz 11:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:44 INFO - Installing collected packages: blessings 11:22:44 INFO - Running setup.py install for blessings 11:22:44 INFO - Successfully installed blessings 11:22:44 INFO - Cleaning up... 11:22:44 INFO - Return code: 0 11:22:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:44 INFO - Reading from file tmpfile_stdout 11:22:44 INFO - Current package versions: 11:22:44 INFO - blessings == 1.6 11:22:44 INFO - blobuploader == 1.2.4 11:22:44 INFO - docopt == 0.6.1 11:22:44 INFO - functools32 == 3.2.3-2 11:22:44 INFO - jsonschema == 2.5.1 11:22:44 INFO - manifestparser == 1.1 11:22:44 INFO - mozInstall == 1.12 11:22:44 INFO - mozcrash == 1.0 11:22:44 INFO - mozdebug == 0.1 11:22:44 INFO - mozdevice == 0.49 11:22:44 INFO - mozfile == 1.2 11:22:44 INFO - mozhttpd == 0.7 11:22:44 INFO - mozinfo == 0.9 11:22:44 INFO - mozleak == 0.1 11:22:44 INFO - mozlog == 3.4 11:22:44 INFO - moznetwork == 0.27 11:22:44 INFO - mozprocess == 0.24 11:22:44 INFO - mozprofile == 0.28 11:22:44 INFO - mozrunner == 6.13 11:22:44 INFO - mozscreenshot == 0.1 11:22:44 INFO - mozsystemmonitor == 0.3 11:22:44 INFO - moztest == 0.8 11:22:44 INFO - mozversion == 1.4 11:22:44 INFO - psutil == 3.1.1 11:22:44 INFO - requests == 1.2.3 11:22:44 INFO - wsgiref == 0.1.2 11:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:44 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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:44 INFO - 'HOME': '/Users/cltbld', 11:22:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:44 INFO - 'LOGNAME': 'cltbld', 11:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:44 INFO - 'MOZ_NO_REMOTE': '1', 11:22:44 INFO - 'NO_EM_RESTART': '1', 11:22:44 INFO - 'PAGER': '/bin/cat', 11:22:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:44 INFO - 'PWD': '/builds/slave/test', 11:22:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:44 INFO - 'SHELL': '/bin/bash', 11:22:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:44 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:44 INFO - 'USER': 'cltbld', 11:22:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:44 INFO - 'XPC_FLAGS': '0x0', 11:22:44 INFO - 'XPC_SERVICE_NAME': '0', 11:22:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:22:45 INFO - Cleaning up... 11:22:45 INFO - Return code: 0 11:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:45 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 0x10e9ceb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfbaddbe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, '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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:45 INFO - 'HOME': '/Users/cltbld', 11:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:45 INFO - 'LOGNAME': 'cltbld', 11:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:45 INFO - 'MOZ_NO_REMOTE': '1', 11:22:45 INFO - 'NO_EM_RESTART': '1', 11:22:45 INFO - 'PAGER': '/bin/cat', 11:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:45 INFO - 'PWD': '/builds/slave/test', 11:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:45 INFO - 'SHELL': '/bin/bash', 11:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:22:45 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:45 INFO - 'USER': 'cltbld', 11:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:45 INFO - 'XPC_FLAGS': '0x0', 11:22:45 INFO - 'XPC_SERVICE_NAME': '0', 11:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:45 INFO - Cleaning up... 11:22:45 INFO - Return code: 0 11:22:45 INFO - Running post-action listener: _resource_record_post_action 11:22:45 INFO - Running post-action listener: _start_resource_monitoring 11:22:45 INFO - Starting resource monitoring. 11:22:45 INFO - [mozharness: 2017-01-13 19:22:45.490203Z] Finished create-virtualenv step (success) 11:22:45 INFO - [mozharness: 2017-01-13 19:22:45.491157Z] Running install step. 11:22:45 INFO - Running pre-action listener: _resource_record_pre_action 11:22:45 INFO - Running main action method: install 11:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:45 INFO - Reading from file tmpfile_stdout 11:22:45 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:45 INFO - Reading from file tmpfile_stdout 11:22:45 INFO - Output received: 11:22:45 INFO - Usage: mozinstall [options] installer 11:22:45 INFO - Options: 11:22:45 INFO - -h, --help show this help message and exit 11:22:45 INFO - -d DEST, --destination=DEST 11:22:45 INFO - Directory to install application into. [default: 11:22:45 INFO - "/builds/slave/test"] 11:22:45 INFO - --app=APP Application being installed. [default: firefox] 11:22:45 INFO - mkdir: /builds/slave/test/build/application 11:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:23:07 INFO - Reading from file tmpfile_stdout 11:23:07 INFO - Output received: 11:23:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:23:07 INFO - Running post-action listener: _resource_record_post_action 11:23:07 INFO - [mozharness: 2017-01-13 19:23:07.444549Z] Finished install step (success) 11:23:07 INFO - [mozharness: 2017-01-13 19:23:07.444683Z] Running run-tests step. 11:23:07 INFO - Running pre-action listener: _resource_record_pre_action 11:23:07 INFO - Running main action method: run_tests 11:23:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:23:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:23:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:23:07 INFO - 2017-01-13 11:23:07.457 screenresolution[1631:7767] starting screenresolution argv=screenresolution get 11:23:07 INFO - 2017-01-13 11:23:07.460 screenresolution[1631:7767] Display 0: 1600x1200x32@60 11:23:07 INFO - 2017-01-13 11:23:07.465 screenresolution[1632:7769] starting screenresolution argv=screenresolution list 11:23:07 INFO - Available Modes on Display 0 11:23:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:23:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:23:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:23:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:23:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:23:07 INFO - Intel Iris: 11:23:07 INFO - Chipset Model: Intel Iris 11:23:07 INFO - Type: GPU 11:23:07 INFO - Bus: Built-In 11:23:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:23:07 INFO - Vendor: Intel (0x8086) 11:23:07 INFO - Device ID: 0x0a2e 11:23:07 INFO - Revision ID: 0x0009 11:23:07 INFO - Displays: 11:23:07 INFO - Display: 11:23:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:23:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:23:07 INFO - Display Serial Number: 1600x1200 60 11:23:07 INFO - Main Display: Yes 11:23:07 INFO - Mirror: Off 11:23:07 INFO - Online: Yes 11:23:07 INFO - Rotation: Supported 11:23:07 INFO - Return code: 0 11:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:07 INFO - Python 2.7.3 11:23:07 INFO - Return code: 0 11:23:07 INFO - grabbing minidump binary from tooltool 11:23: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')]} 11:23:07 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 0x10e7acd30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e7a1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:23:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:23:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:23:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:07 INFO - Return code: 0 11:23:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:23:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:23:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7FtM5kEaBY/Render', 11:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:07 INFO - 'HOME': '/Users/cltbld', 11:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:07 INFO - 'LOGNAME': 'cltbld', 11:23:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:07 INFO - 'MOZ_NO_REMOTE': '1', 11:23:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:07 INFO - 'NO_EM_RESTART': '1', 11:23:07 INFO - 'PAGER': '/bin/cat', 11:23:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:07 INFO - 'PWD': '/builds/slave/test', 11:23:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:07 INFO - 'SHELL': '/bin/bash', 11:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZBsYPigh2W/Listeners', 11:23:07 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 11:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:07 INFO - 'USER': 'cltbld', 11:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:07 INFO - 'XPC_FLAGS': '0x0', 11:23:07 INFO - 'XPC_SERVICE_NAME': '0', 11:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:23:08 INFO - mozversion application_buildid: 20170113092130 11:23:08 INFO - mozversion application_changeset: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a 11:23:08 INFO - mozversion application_display_name: Nightly 11:23:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:08 INFO - mozversion application_name: Firefox 11:23:08 INFO - mozversion application_remotingname: firefox 11:23:08 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:23:08 INFO - mozversion application_vendor: Mozilla 11:23:08 INFO - mozversion application_version: 53.0a1 11:23:08 INFO - mozversion platform_buildid: 20170113092130 11:23:08 INFO - mozversion platform_changeset: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a 11:23:08 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:23:08 INFO - mozversion platform_version: 53.0a1 11:23:08 INFO - using testdate: 1484335388 11:23:08 INFO - actual date: 1484335388 11:23:08 INFO - starting webserver on 'localhost:49239' 11:23:08 INFO - SUITE-START | Running 2 tests 11:23:08 INFO - TEST-START | dromaeo_css 11:23:08 INFO - operating with platform_type : mac_ 11:23:08 INFO - Initialising browser for dromaeo_css test... 11:23:08 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpZ3av_u/profile http://localhost:49239/getInfo.html) 11:23:10 INFO - PROCESS | 1642 | 2017-01-13 11:23:10.982 plugin-container[1645:7943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 11:23:10 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:10 INFO - PROCESS | 1642 | 2017-01-13 11:23:10.985 plugin-container[1645:7943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1f, name = 'com.apple.CFPasteboardClient' 11:23:10 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:10 INFO - PROCESS | 1642 | 2017-01-13 11:23:10.985 plugin-container[1645:7943] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:23:11 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 11:23:11 INFO - PROCESS | 1642 | colorDepth:24 11:23:11 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 11:23:11 INFO - PROCESS | 1642 | __metrics 11:23:11 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 11:23:11 INFO - TEST-INFO | 1642: exit 0 11:23:11 INFO - Browser initialized. 11:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:11 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpZ3av_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:14 INFO - PROCESS | 1646 | 2017-01-13 11:23:14.266 plugin-container[1647:8062] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 11:23:14 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:14 INFO - PROCESS | 1646 | 2017-01-13 11:23:14.266 plugin-container[1647:8062] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 11:23:14 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:14 INFO - PROCESS | 1646 | 2017-01-13 11:23:14.266 plugin-container[1647:8062] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:23:24 INFO - PROCESS | 1646 | RSS: Main: 233762816 11:23:24 INFO - PROCESS | 1646 | 11:26:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 11:26:27 INFO - PROCESS | 1646 | RSS: Main: 260644864 11:26:27 INFO - PROCESS | 1646 | 11:28:12 INFO - PROCESS | 1646 | ************************* 11:28:12 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 11:28:12 INFO - PROCESS | 1646 | 11:28:12 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:28:12 INFO - PROCESS | 1646 | Full stack: 11:28:12 INFO - PROCESS | 1646 | ************************* 11:29:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 11:29:30 INFO - PROCESS | 1646 | RSS: Main: 261533696 11:29:30 INFO - PROCESS | 1646 | 11:32:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 11:32:33 INFO - PROCESS | 1646 | RSS: Main: 271110144 11:32:33 INFO - PROCESS | 1646 | 11:35:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 11:35:35 INFO - PROCESS | 1646 | RSS: Main: 267395072 11:35:35 INFO - PROCESS | 1646 | 11:38:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 11:38:39 INFO - PROCESS | 1646 | RSS: Main: 272351232 11:38:39 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 11:41:42 INFO - PROCESS | 1646 | RSS: Main: 274661376 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | __start_tp_report 11:41:42 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 11:41:42 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 11:41:42 INFO - PROCESS | 1646 | |i|pagename|runs| 11:41:42 INFO - PROCESS | 1646 | |0;dojo.html;2867.7992540522173;3370.7022796223446;3379.61134469536;3402.370561446133;3405.5402520659736;5614.803481878125;5680.034394152994;5722.1988921550965;5741.511971482429;5779.162021506879;4623.514530974249;5427.213054107162;5475.753591088401;5476.2333273341765;5518.2826232589705;4149.937750933738;5016.7742451589675;5246.711430871301;5251.212318152288;5294.602904782138;5180.844574662766;5229.843104706846;5263.236830659552;5284.233786101013;5330.893382132355;5233.842984710464;5277.102892508283;5293.15309550472;5301.469853014687;5306.893862122755;5123.538881500645;5153.433122356538;5156.432792392834;5180.912008478224;5245.895082098375;5131.640785145004;5155.355580552431;5200.5059519345605;5201.505856943584;5239.973800131013;4791.616670666338;5635.239242702224;5675.772969081232;5688.004599195125;5730.169125476824;6053.061775424816;6095.878082438327;6119.418655227791;6158.599691020069;6191.442770150663;6118.83238421412;6159.414855588712;6178.783742569033;6181.96909015452;6233.3143354231;5700.857478563069;5845.532357411439;5857.26784151981;5858.2677165354335;5891.941080589182;5663.490285874291;6147.631142131487;6210.4100110489435;6227.221597300338;6236.844078898064;6032.4570788629235;6053.727582258809;6099.146119543268;6111.84720381994;6113.02191649334;6114.4190257321325;6173.9073913891325;6207.751689932443;6217.253929528486;6224.719887605069;6061.636301821816;6093.360197179321;6135.202423684982;6216.378362163748;6229.719662615194;6133.242854861876;6194.969025154845;6217.844553886189;6233.189685340877;6251.843703907439;4761.333413322138;4809.038192361541;4951.504849515091;4993.675411098267;5018.4981501849525;4328.9134217316105;4443.955670417449;4472.351509031238;4501.212287849678;4534.501204867462;5917.31950825652;5963.880722385528;5985.760569577168;5988.251468566429;5988.9101663475085;6130.9179418630665;6190.0405437157315;6209.316975132731;6213.440790328802;6217.191765070603;5812.9709351452975;5897.410258974154;5920.644761314335;5931.110333450017;6038.849028774316;5448.945510544923;5456.945430545723;5466.890662186734;5467.043267428184;5486.259354987025;5150.330457040561;6257.9687101564205;6305.306416294204;6309.085182648582;6334.081558174039;6127.403330890726;6133.334663918993;6136.846578835565;6136.938630613815;6152.138700581832;6312.400321969406;6344.9048264277;6345.682715864281;6352;6372.58578192416;5713.885722285448;6114.113453549299;6164;6191.969040154951;6194.0708893666315;5195.870103247449;6024.427679370453;6126.578745377076;6139.246828488627;6145.432914606747;6052.848678783065;6131.693415329305;6139.001538246313;6139.921477736919;6192.380761923771;5130.640855140105;5975.43233392827;6076.661563848124;6083.148359229623;6154.353792851686;5748.252727145445;5848.883022339614;5879.647221166743;5933.3769954154195;5993.981023225975;6108.908366374419;6111.930412177762;6114.785982490592;6117.296510901126;6144.385561443999;5909.172715819703;5945.167676525203;5951.523878089656;5958.285005799332;5996.220491336273 11:41:42 INFO - PROCESS | 1646 | |1;ext.html;445.352012821345;509.23614578132793;509.54904909155385;520.7604501929112;521.3639359980823;39407.60592394079;41537.58462415379;41700.58299417009;41753.373699394455;43446;42178;42554.787226063905;42747.93130171747;42771;42793.78603106988;8380.161983801601;9162.81674366514;9355.204807591363;9386.108319709616;9394.201492873113;8008.319292860114;11110.666679999613;11381.886181138165;11383.317000979927;11542.711432214177;11257.493412796444;11266.549338026469;11281.717957051098;11293.717657058558;11303.152263580223;11214.10287177024;11246.606368777053;11300;11310.208285420023;11372;10985.835212471819;11140.442977851157;11226.775464490745;11242.662720118327;11298.491567879382;31917.361652766816;35784.82107589472;39691.809245722674;39895.20209595821;39896.40155397671;3995.2808494470983;4030.234255491447;4032.7983600819844;4066.5730098339545;4181.770002649853;24364;29654.70345296541;30192.24519387011;30198.84900575505;30303.545446818316;3123.1255248530447;3154.463741164008;3256.2836176041233;3305.3554556861422;3322.900312990614;452530;454914;457969.7101514504;458402;459748;58521.414785852445;58872;59404.10893836596;59593.106103408485;59593.70203149043;62895.74208515804;63005.68497157485;63215;63390.68304658447;63525.72948541003;15723.113226412903;16224.432144874872;16242.51272461828;16285;16286.918565407097;11339.546418143347;11612.187146899805;12351.567695130627;12600.243985360908;12615.990720742318;15793.131377774103;15856.920715396349;16064;16075.115868627337;16352.672946541003;6924.272951340137;6983.301669832976;6995.691421830886;7034.296570343027;7053.224145344008;823.4482896459386;855.619249433996;862.4652715316419;862.8835107260566;885.5173930208052;29957.251068723457;30132.698673013427;30162.84918575393;30290.69709302923;30611.540826887616;926.7080869526212;981.1856159387692;1044.5038606661774;1081.302559848893;1213.4296880466168;13412.798808017887;15114.773278400833;15634.765478517831;15695.764563531557;16002.599935001717;608068;610022;610174;610410;611457;58333.708331458074;58629.12056319159;58951.41048589545;59165;59195;1390.986090139106;1429.2139323372103;1439.4026479011302;1445.3279225160352;1455.4105587237398;24066.9169887359;26842.463150737265;27615.72384276212;28829;29879.701202987693;48170.27744583904;49936;50652.74673626756;50681.49318506915;50788.74605626948;565603;566818;572864;573429;573593;24127;24167;24555.754442455345;24671.629925550773;24777.87611061933;40799.77600671985;41089.58910410858;41852;42197.789011054745;42312;34940.82529587336;35254.94235172949;35263;35697.643023569435;36076.8196159028;34796.478052829734;34807.47788783221;35674.28651427009;35949;36043.459348109274;33574.82488112905;33842.3231535363;34065.48901766426;34321.65678343185;34591.654083458845;29327.85336073306;30953.845230773702;31029.534556981213;31236;31289.06132816019;23365.76634233704;23477.805224942258;23496.060157594187;23687.05251789909;23948.760512394652 11:41:42 INFO - PROCESS | 1646 | |2;jquery.html;378.1567105355058;388.16738096782404;392.1118666221008;399.63633093884573;421.9935453942347;15793.84206157938;16828.57928551787;19616.509587260327;20947.790522094776;20963.266285679983;20547.897260513677;20644.587108257827;20803.791962080373;21430.678539821914;21551.461213469633;5438.7280635968245;5755.6258843175265;5813.6221145625395;5827.737751801158;5836.6789826559525;5592.07730724432;5740.54075673945;5784.1034639630925;5785;5837;5676.347220069683;5751.654900705971;5765.855853603673;5769.278840144982;5783.421657834204;4989.727619457051;5347.4919882611475;5733.455321744427;5757.021306377905;5759.251297331362;4974.90050198994;5081.466446023152;5089.796408143669;5091.0581542414775;5107;23841.165559205518;24329.391765205834;24963.5007299853;25026.1240856571;25718.228453146436;2580.5226033183735;2591.572390555556;2647.9602805957925;2683.1413947536794;2785.456835916997;9507.714768556954;10122.392656440637;10212.897871021269;10271.79456410875;10337.483125843753;1794.7397627343962;1836.9448916532526;1873.8500919926373;1873.878197917131;1874.2690350763214;141474.2926285362;141798;142013;142834.99999999895;145328;11377.2604780689;11480.138989575815;11620.6513804586;11865.228760130563;11920.165588408729;13508.729825403438;14158.504452344325;15120.470783522524;15149.015314004555;15152.01511901723;8180.141085186089;8465.492070475791;8543.40196186261;8568.485890846569;8697.521636309937;8361.456505327134;8362.331013518904;8367.916320836835;8520.74437766868;8538.316934645214;3933.9606603934167;4666.160091183619;4668.789904454307;4784.138855006063;4872.538238528427;1998.2306811877531;2020.1919232307196;2037.7147199392098;2044.877307361563;2047.754269487671;734.7061175529831;854.2999431132126;895.6954635423857;905.1717678324391;918.0681608167715;17905.552361190814;18039.458816235532;18978.766380185243;20489;21281.89359053195;879.2702057292432;938.9201917836924;947.3463310315998;953.7949340891741;960.6973803251954;5470.835874923759;5558.749856256478;6472.449841763409;6720.395164435126;6757.526973111933;423472;425744;483701;723096;729959;148191;157790;160773.39226607585;163142.1842890778;165624;1035.9896401036044;1065.6217042949797;1081.4808891732014;1091.7871015151968;1092.7650555130526;11982;12092.032637389164;12160.939195303967;12189.451474683483;12327.815082773586;53197;53263.733681331345;54407;54609.72695136499;54988.72505637446;83573.58213208895;84588.63156216279;84809.72785408347;84975.57512212399;85471.5726421364;7809.33620642229;8148.918510814816;8340.916590834015;8372.037215720271;8468.407211495383;9007.63969441215;11373.54505819758;12291.446884890023;12975.805362919375;13065.673358166121;10243;11439.256448330832;11595.362255076052;11761.294322340687;11767.588134415255;9906.356086854332;10096.646617368357;11045.723856903642;11504.482298296429;11629.88370116288;10134.391936483835;10831.729206769895;11221.438928053401;11400.48697808584;11739.413029348669;8202.58987050657;8300.12848650883;8308.33533317321;8376.413651044368;8471.745847624581;9328.486933218466;9751.56117974707;11545.711357216136;11589.24669896454;11711.648650540497 11:41:42 INFO - PROCESS | 1646 | |3;mootools.html;1162.8313894485304;1317.216256327485;1451.3904160252694;1453.1499073042269;1464.6997365540064;7256.528325658842;7484.363829074521;7692.807679808007;7976.9202307976975;8072.636731347089;7973.40199485038;8270.255676989069;8296.460730052542;8363.665453381858;8391.874121888177;2208.9116435342607;2227.721534808149;2235.2176738141684;2239.4177513846353;2247.797698207161;2044.9182032718672;2320.373499155227;2355.222776483756;2358.681577986967;2366.8816559171973;2078.4388215181893;2238.653008783633;2327.057541695616;2335.182686059874;2340.9297721068397;2277.9772202278014;2315.3401280635107;2333.614953532665;2343.4375749820006;2343.4492894169857;2274.124462082094;2299.1837897546466;2314.6990891184205;2368.1829768729763;2370.0875163062174;8364.832703345959;8380.24577787996;8415.83168336636;8424.620892059873;8430.620622072021;5034.974825125851;5146.871328216787;5181.948180518184;5182.222666600002;5196.168613021936;3245.5618491503583;3355.027042157771;3359.0930448778695;3420.1791570023265;3430.1767575781632;1147.1568397228032;1174.74155685749;1192.749522600255;1196.0312147160828;1219.6706889139882;10606.9469652652;10624.787504249949;10789.460526973699;10817.242793004492;10830.458477076114;3878.185581028016;4458.458678553258;4680;4728.219843725747;4752.95247047532;9433.528323583794;9485.336026478219;9490.383125096847;9497.762555936019;9505.524723763923;5212.4266330703595;5217.921731174036;5225.085610018232;5233.790648374023;5240.764165612557;4650.95349046512;4663.417072865892;4693.014466961976;4742.980259244279;4757.119932812441;3794.9241015180096;3836.712246581518;3869.903252418712;3909.5113110861143;3954.7542524104815;1167.9941600292113;1180.055955235808;1184.6327638432113;1215.8480189976253;1227.2329793878826;638.6264035539261;758.4577027425418;788.7318311774025;812.0620683111016;819.2544784246307;5270.868228294324;5308.840734777963;5408.242846001563;5476.424975377608;5563.693996830132;773.3542492019114;918.3342076994126;970.1656575345197;981.40134517944;997.1524204426324;3445.9483107753404;3616.8372423241017;3683.7605555638797;3772.2455508897783;3777.5089238399382;8104.756857294291;9303.023182565868;9765.02349765032;9794.706158815246;9824.607015719434;9673.322867399214;9707.854382184272;9717.465539395402;9746.269029822792;9798.26513011527;6170.722317495633;7702.845943081219;7737.690492380354;7776.377889768805;7812.453128280966;4706.305729937289;5567.582431317586;5650.915236271541;5773.884522309614;5819.79630712923;9018.143276388733;9110.9977902432;9141;9184.954075229582;9197.712320275301;7717.996660434108;8883.33374996865;9332.066793320613;9372.062793720574;9473.66842160521;6917.308269173042;6966.651667416508;6977.406920411822;6982.79051628452;7044.084269044992;7518.248175182438;7557.584332861746;7609.619519024137;7611.467197296136;7671.923280767121;6819.079424277659;6877.346652068046;6925.342092501204;6946.9652651736415;7027.9297207027275;6794.83012924661;6829.385355318045;6835.58986460814;6880.65596720172;6882.655867206719;6029.4874935629205;6114.0828875669;6146.477549408351;6153.230846144232;6198.907016394848;4832.202686556679;4853.975730121327;4887.242477416006;4897.975510122569;4980.477049909708;4769.76151192432;4855.028994201244;4925.753712314298;4953.108440480748;4956.430010548833 11:41:42 INFO - PROCESS | 1646 | |4;prototype.html;334.26628550332;355.671004321003;359.7409864897274;367.72788136778775;372.0661140537251;5200.541639809531;5266.7629956651945;5408;5452.754626041828;5526.723663816803;5126.436092029883;5301.0121204548295;5315.654482458647;5324.65389749666;5334.786608535654;3263.738900887935;4089.713720039591;4225.788710564475;4239.236937351276;4248.7481634733485;3309.635940046593;3747.1381582236104;4221.683373746966;4261.509926358462;4267.359896015591;3953.861614843481;4120.134771697947;4133.016152246923;4143.19207754488;4162.271602469571;4156.5635608261;4159.2721273777115;4162.771047592381;4172.958270417287;4207.410962465257;3691.8065873019646;3691.984704206338;3702.148505843644;3720.962790372089;3722.40441529354;4395.835103697523;4669.696469729491;4942.406911170682;5168.302279192299;5231.424543300234;4645.4694432231745;4766.189747742892;4778.331033655291;4810.735409552473;4880.267959806022;4649.744264065475;4715.858524244278;4792.634099281688;5683.715814209314;5874.50066744323;3948.6841052716;4044.3933409988445;4069.409935559327;4088.3049881520215;4091.4067460218102;5476.507114359727;5915.497182739472;5916.497097746696;5926.496247818941;5970.373110823344;3961.9405708914387;4007.8396864125693;4078.775667338325;4151.46031015966;4155.688323375698;3583.8924832255075;4011.8165141282807;4171.83312667496;4179.9791001045405;4205.789710514462;4794.376731024944;4798.272621856129;4831.855044348676;4840.878978025577;4863.367762190893;5276.36683597963;5486.2419242818;5725.341585717612;5768.2501274834;5769.451902069297;1128.700894263021;1296.8508621508647;1309.6005718256024;1366.8154799101994;1382.4815694114707;928.967486137982;959.3811991265594;959.7072892767773;966.4056605187759;971.0920289529313;4364.607185353333;4741.336212930192;4958.281049247911;5105.519399374214;5244.370675518962;5114.258432527263;5179.145441002268;5209.6874187548865;5342.969671524796;5395.028894798896;4848.903021939542;5030.4215015272985;5032.591023671354;5063.291139240436;5112.590992720573;2422.733499315074;2544.605586134152;2775.916722498288;2801.6918139004692;2900.9564856527168;4819.807207711652;5103.642745007888;5266.92099618506;5291.772019068365;5824.970875145597;4472.651857774629;5240.6069544784295;5642.6614403135945;5659.886802263932;5708.658465260661;5277;5435.836924892181;5535.750891209906;5892.322382926019;5963.880722385441;4841.854744357534;5163.870903227449;5493.802479008428;5512.283403157564;5620.133731796731;5080.441151473409;5286.920696189483;5748.798792042258;5816.563757718103;5899.292084949833;5060.721660308718;5393.595480338912;5433.565314774887;5442.183672449164;6136.048912418582;3714.888553343404;3908.3160446921106;3916.138449541096;3929.8428062877165;3933.5083114610675;5109.821156259513;5663.263775709296;5787.826365209051;5866.941330586639;5890.322612899571;5261.605379596469;5581.330240371019;5726.282115365457;5738;5843.649381037151;5587.69267690281;5787.710614469344;5794.62334948227;5797.623154494944;5806.9419305806405;4702.542211914318;4775.880602984953;4956.900861982668;5531.972340138434;5621.831345059655;5330.653507521999;5752.942470575241;5763.962486752257;5779.508741756829;5803.245578074992;4571.360009598592;4766.733773272832;4883.755812209446;4891.853244402673;5592.356878958972 11:41:42 INFO - PROCESS | 1646 | |5;yui.html;708.2244941788742;751.9887201691974;777.5645638442469;813.178689523581;840.3907167303705;12775.872241277584;16073.437429689948;16074.276657550408;16084.517464476055;16158.434454794084;11949;14241.287935603204;14336.784948225784;14366.640833979156;14414.423423063065;655.1973832055729;673.9595624262536;856.6016802186982;875.5753459572103;876.2376732242926;880.4013270975765;883.8630012348096;885.2342723544152;885.5616469847434;886.6409104312763;888.524639317965;937.7421209167466;945.3193700535637;949.9882625004349;956;936.4240991790068;936.9437833729964;938.6245501799301;941.7692665297012;945.182417209116;679.7111227728195;698.0889938630086;699.1156187422914;699.5907394174415;703.1386551474454;14969.401223951028;15216.163111028889;15313;15595.220238988006;15862.048277103295;12168;14229.501967431193;14353.497627582985;14365.62344759066;14422.783658245135;11480.655580332603;11581.942090289578;11736.35450050247;11771.823422648582;11985.820212696817;3713.424419215026;3735.122246272124;3760.736748427611;3771.754835935683;3772.5095737553943;99015;100278.49582256272;102412.48793756058;102953;103208.48395758124;11012.50443730034;11090.112790976702;11119.166062545342;11262.887371126348;11273.436328183558;23173.304800856;23290.65064024041;23308.417289567897;23319.18382856626;23327;7726.922730772732;7869.685212591547;7909.9209007909185;7912.525248485109;7996.720114795954;4118.91762164755;4186.288330983679;4198.496180458304;4231.767252801125;4248.9787551062045;3471.5834099908175;3518;3530.135116896377;3548.6273941236313;3570.6786389225094;626.9090981807612;632.4940047961612;640.7565125252374;642.4667525953447;648.6626953983996;668.1614573709962;682.6620822692798;696.6656005117572;705.5061456980135;708.7483943200193;10207.387556746618;10404.375737455777;10414.791704165875;10431.68704938853;10484.842727359095;589.0927970924813;589.3016775121495;608.342989571262;636.3509220594967;652.2727159217533;4408.743692534758;5061.9187347690295;5063.770615178345;5092.541671249605;5106.259592359087;69892.650536747;75235.62382188054;84739;85252;90978.09021909829;81583.18416815756;82394;83586.58206708927;83615;83643.58178209192;70897.6455117721;73350.63324683343;73936.63031684914;73950.52098958098;75319.62340188374;8952.776180595538;9254.907450925673;10983.61557345521;11133.332000079698;11190.272632278877;46351.76824115858;47016.529834701214;47130.528694712615;50460.747696261285;51411.915285083014;66545;67990.66004669946;68001.65999169972;69569;69836.65081674763;12811.615651530468;13248.933755331162;13295.069345145746;13416.597502074954;13522.661933451742;14715.55853324402;14728.484503042342;14928.477503287768;14936.029158104688;15444.768328474856;13701.520446784314;13836.446542138201;13858.16850988944;14136.575902722934;14319.28403579796;13426.395812188279;13630.454781808616;13699.589012329647;13748.063758557018;14044;13272.469101235842;13319.134256273312;13511.391987360788;13738.519151829638;13936.372863220977;11018.669439916815;11115.11079113685;11275.50411645387;11304.208705390543;11710.063194944214;8432.536210508235;10110.191184705352;10731.356118632906;11080;11100.666979990614 11:41:42 INFO - PROCESS | 1646 | __end_tp_report 11:41:42 INFO - PROCESS | 1646 | __start_cc_report 11:41:42 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,388 11:41:42 INFO - PROCESS | 1646 | __end_cc_report 11:41:42 INFO - PROCESS | 1646 | __startTimestamp1484336502410__endTimestamp 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | ------- Summary: start ------- 11:41:42 INFO - PROCESS | 1646 | Number of tests: 6 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5696.16 Median:5958.29 stddev:653.16 (11.0%) stddev-sans-first:616.33 11:41:42 INFO - PROCESS | 1646 | Values: 2867.8 3370.7 3379.6 3402.4 3405.5 5614.8 5680.0 5722.2 5741.5 5779.2 4623.5 5427.2 5475.8 5476.2 5518.3 4149.9 5016.8 5246.7 5251.2 5294.6 5180.8 5229.8 5263.2 5284.2 5330.9 5233.8 5277.1 5293.2 5301.5 5306.9 5123.5 5153.4 5156.4 5180.9 5245.9 5131.6 5155.4 5200.5 5201.5 5240.0 4791.6 5635.2 5675.8 5688.0 5730.2 6053.1 6095.9 6119.4 6158.6 6191.4 6118.8 6159.4 6178.8 6182.0 6233.3 5700.9 5845.5 5857.3 5858.3 5891.9 5663.5 6147.6 6210.4 6227.2 6236.8 6032.5 6053.7 6099.1 6111.8 6113.0 6114.4 6173.9 6207.8 6217.3 6224.7 6061.6 6093.4 6135.2 6216.4 6229.7 6133.2 6195.0 6217.8 6233.2 6251.8 4761.3 4809.0 4951.5 4993.7 5018.5 4328.9 4444.0 4472.4 4501.2 4534.5 5917.3 5963.9 5985.8 5988.3 5988.9 6130.9 6190.0 6209.3 6213.4 6217.2 5813.0 5897.4 5920.6 5931.1 6038.8 5448.9 5456.9 5466.9 5467.0 5486.3 5150.3 6258.0 6305.3 6309.1 6334.1 6127.4 6133.3 6136.8 6136.9 6152.1 6312.4 6344.9 6345.7 6352.0 6372.6 5713.9 6114.1 6164.0 6192.0 6194.1 5195.9 6024.4 6126.6 6139.2 6145.4 6052.8 6131.7 6139.0 6139.9 6192.4 5130.6 5975.4 6076.7 6083.1 6154.4 5748.3 5848.9 5879.6 5933.4 5994.0 6108.9 6111.9 6114.8 6117.3 6144.4 5909.2 5945.2 5951.5 5958.3 5996.2 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:67593.08 Median:35097.88 stddev:146818.72 (418.3%) stddev-sans-first:147144.03 11:41:42 INFO - PROCESS | 1646 | Values: 445.4 509.2 509.5 520.8 521.4 39407.6 41537.6 41700.6 41753.4 43446.0 42178.0 42554.8 42747.9 42771.0 42793.8 8380.2 9162.8 9355.2 9386.1 9394.2 8008.3 11110.7 11381.9 11383.3 11542.7 11257.5 11266.5 11281.7 11293.7 11303.2 11214.1 11246.6 11300.0 11310.2 11372.0 10985.8 11140.4 11226.8 11242.7 11298.5 31917.4 35784.8 39691.8 39895.2 39896.4 3995.3 4030.2 4032.8 4066.6 4181.8 24364.0 29654.7 30192.2 30198.8 30303.5 3123.1 3154.5 3256.3 3305.4 3322.9 452530.0 454914.0 457969.7 458402.0 459748.0 58521.4 58872.0 59404.1 59593.1 59593.7 62895.7 63005.7 63215.0 63390.7 63525.7 15723.1 16224.4 16242.5 16285.0 16286.9 11339.5 11612.2 12351.6 12600.2 12616.0 15793.1 15856.9 16064.0 16075.1 16352.7 6924.3 6983.3 6995.7 7034.3 7053.2 823.4 855.6 862.5 862.9 885.5 29957.3 30132.7 30162.8 30290.7 30611.5 926.7 981.2 1044.5 1081.3 1213.4 13412.8 15114.8 15634.8 15695.8 16002.6 608068.0 610022.0 610174.0 610410.0 611457.0 58333.7 58629.1 58951.4 59165.0 59195.0 1391.0 1429.2 1439.4 1445.3 1455.4 24066.9 26842.5 27615.7 28829.0 29879.7 48170.3 49936.0 50652.7 50681.5 50788.7 565603.0 566818.0 572864.0 573429.0 573593.0 24127.0 24167.0 24555.8 24671.6 24777.9 40799.8 41089.6 41852.0 42197.8 42312.0 34940.8 35254.9 35263.0 35697.6 36076.8 34796.5 34807.5 35674.3 35949.0 36043.5 33574.8 33842.3 34065.5 34321.7 34591.7 29327.9 30953.8 31029.5 31236.0 31289.1 23365.8 23477.8 23496.1 23687.1 23948.8 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:35219.27 Median:383.16 stddev:98130.50 (25610.7%) stddev-sans-first:98370.91 11:41:42 INFO - PROCESS | 1646 | Values: 378.2 388.2 392.1 399.6 422.0 15793.8 16828.6 19616.5 20947.8 20963.3 20547.9 20644.6 20803.8 21430.7 21551.5 5438.7 5755.6 5813.6 5827.7 5836.7 5592.1 5740.5 5784.1 5785.0 5837.0 5676.3 5751.7 5765.9 5769.3 5783.4 4989.7 5347.5 5733.5 5757.0 5759.3 4974.9 5081.5 5089.8 5091.1 5107.0 23841.2 24329.4 24963.5 25026.1 25718.2 2580.5 2591.6 2648.0 2683.1 2785.5 9507.7 10122.4 10212.9 10271.8 10337.5 1794.7 1836.9 1873.9 1873.9 1874.3 141474.3 141798.0 142013.0 142835.0 145328.0 11377.3 11480.1 11620.7 11865.2 11920.2 13508.7 14158.5 15120.5 15149.0 15152.0 8180.1 8465.5 8543.4 8568.5 8697.5 8361.5 8362.3 8367.9 8520.7 8538.3 3934.0 4666.2 4668.8 4784.1 4872.5 1998.2 2020.2 2037.7 2044.9 2047.8 734.7 854.3 895.7 905.2 918.1 17905.6 18039.5 18978.8 20489.0 21281.9 879.3 938.9 947.3 953.8 960.7 5470.8 5558.7 6472.4 6720.4 6757.5 423472.0 425744.0 483701.0 723096.0 729959.0 148191.0 157790.0 160773.4 163142.2 165624.0 1036.0 1065.6 1081.5 1091.8 1092.8 11982.0 12092.0 12160.9 12189.5 12327.8 53197.0 53263.7 54407.0 54609.7 54988.7 83573.6 84588.6 84809.7 84975.6 85471.6 7809.3 8148.9 8340.9 8372.0 8468.4 9007.6 11373.5 12291.4 12975.8 13065.7 10243.0 11439.3 11595.4 11761.3 11767.6 9906.4 10096.6 11045.7 11504.5 11629.9 10134.4 10831.7 11221.4 11400.5 11739.4 8202.6 8300.1 8308.3 8376.4 8471.7 9328.5 9751.6 11545.7 11589.2 11711.6 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5324.72 Median:5255.82 stddev:2892.86 (55.0%) stddev-sans-first:2884.06 11:41:42 INFO - PROCESS | 1646 | Values: 1162.8 1317.2 1451.4 1453.1 1464.7 7256.5 7484.4 7692.8 7976.9 8072.6 7973.4 8270.3 8296.5 8363.7 8391.9 2208.9 2227.7 2235.2 2239.4 2247.8 2044.9 2320.4 2355.2 2358.7 2366.9 2078.4 2238.7 2327.1 2335.2 2340.9 2278.0 2315.3 2333.6 2343.4 2343.4 2274.1 2299.2 2314.7 2368.2 2370.1 8364.8 8380.2 8415.8 8424.6 8430.6 5035.0 5146.9 5181.9 5182.2 5196.2 3245.6 3355.0 3359.1 3420.2 3430.2 1147.2 1174.7 1192.7 1196.0 1219.7 10606.9 10624.8 10789.5 10817.2 10830.5 3878.2 4458.5 4680.0 4728.2 4753.0 9433.5 9485.3 9490.4 9497.8 9505.5 5212.4 5217.9 5225.1 5233.8 5240.8 4651.0 4663.4 4693.0 4743.0 4757.1 3794.9 3836.7 3869.9 3909.5 3954.8 1168.0 1180.1 1184.6 1215.8 1227.2 638.6 758.5 788.7 812.1 819.3 5270.9 5308.8 5408.2 5476.4 5563.7 773.4 918.3 970.2 981.4 997.2 3445.9 3616.8 3683.8 3772.2 3777.5 8104.8 9303.0 9765.0 9794.7 9824.6 9673.3 9707.9 9717.5 9746.3 9798.3 6170.7 7702.8 7737.7 7776.4 7812.5 4706.3 5567.6 5650.9 5773.9 5819.8 9018.1 9111.0 9141.0 9185.0 9197.7 7718.0 8883.3 9332.1 9372.1 9473.7 6917.3 6966.7 6977.4 6982.8 7044.1 7518.2 7557.6 7609.6 7611.5 7671.9 6819.1 6877.3 6925.3 6947.0 7027.9 6794.8 6829.4 6835.6 6880.7 6882.7 6029.5 6114.1 6146.5 6153.2 6198.9 4832.2 4854.0 4887.2 4898.0 4980.5 4769.8 4855.0 4925.8 4953.1 4956.4 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4543.53 Median:5031.51 stddev:1351.30 (26.9%) stddev-sans-first:1317.64 11:41:42 INFO - PROCESS | 1646 | Values: 334.3 355.7 359.7 367.7 372.1 5200.5 5266.8 5408.0 5452.8 5526.7 5126.4 5301.0 5315.7 5324.7 5334.8 3263.7 4089.7 4225.8 4239.2 4248.7 3309.6 3747.1 4221.7 4261.5 4267.4 3953.9 4120.1 4133.0 4143.2 4162.3 4156.6 4159.3 4162.8 4173.0 4207.4 3691.8 3692.0 3702.1 3721.0 3722.4 4395.8 4669.7 4942.4 5168.3 5231.4 4645.5 4766.2 4778.3 4810.7 4880.3 4649.7 4715.9 4792.6 5683.7 5874.5 3948.7 4044.4 4069.4 4088.3 4091.4 5476.5 5915.5 5916.5 5926.5 5970.4 3961.9 4007.8 4078.8 4151.5 4155.7 3583.9 4011.8 4171.8 4180.0 4205.8 4794.4 4798.3 4831.9 4840.9 4863.4 5276.4 5486.2 5725.3 5768.3 5769.5 1128.7 1296.9 1309.6 1366.8 1382.5 929.0 959.4 959.7 966.4 971.1 4364.6 4741.3 4958.3 5105.5 5244.4 5114.3 5179.1 5209.7 5343.0 5395.0 4848.9 5030.4 5032.6 5063.3 5112.6 2422.7 2544.6 2775.9 2801.7 2901.0 4819.8 5103.6 5266.9 5291.8 5825.0 4472.7 5240.6 5642.7 5659.9 5708.7 5277.0 5435.8 5535.8 5892.3 5963.9 4841.9 5163.9 5493.8 5512.3 5620.1 5080.4 5286.9 5748.8 5816.6 5899.3 5060.7 5393.6 5433.6 5442.2 6136.0 3714.9 3908.3 3916.1 3929.8 3933.5 5109.8 5663.3 5787.8 5866.9 5890.3 5261.6 5581.3 5726.3 5738.0 5843.6 5587.7 5787.7 5794.6 5797.6 5806.9 4702.5 4775.9 4956.9 5532.0 5621.8 5330.7 5752.9 5764.0 5779.5 5803.2 4571.4 4766.7 4883.8 4891.9 5592.4 11:41:42 INFO - PROCESS | 1646 | 11:41:42 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19551.02 Median:3945.71 stddev:26820.66 (679.7%) stddev-sans-first:26858.58 11:41:42 INFO - PROCESS | 1646 | Values: 708.2 752.0 777.6 813.2 840.4 12775.9 16073.4 16074.3 16084.5 16158.4 11949.0 14241.3 14336.8 14366.6 14414.4 655.2 674.0 856.6 875.6 876.2 880.4 883.9 885.2 885.6 886.6 888.5 937.7 945.3 950.0 956.0 936.4 936.9 938.6 941.8 945.2 679.7 698.1 699.1 699.6 703.1 14969.4 15216.2 15313.0 15595.2 15862.0 12168.0 14229.5 14353.5 14365.6 14422.8 11480.7 11581.9 11736.4 11771.8 11985.8 3713.4 3735.1 3760.7 3771.8 3772.5 99015.0 100278.5 102412.5 102953.0 103208.5 11012.5 11090.1 11119.2 11262.9 11273.4 23173.3 23290.7 23308.4 23319.2 23327.0 7726.9 7869.7 7909.9 7912.5 7996.7 4118.9 4186.3 4198.5 4231.8 4249.0 3471.6 3518.0 3530.1 3548.6 3570.7 626.9 632.5 640.8 642.5 648.7 668.2 682.7 696.7 705.5 708.7 10207.4 10404.4 10414.8 10431.7 10484.8 589.1 589.3 608.3 636.4 652.3 4408.7 5061.9 5063.8 5092.5 5106.3 69892.7 75235.6 84739.0 85252.0 90978.1 81583.2 82394.0 83586.6 83615.0 83643.6 70897.6 73350.6 73936.6 73950.5 75319.6 8952.8 9254.9 10983.6 11133.3 11190.3 46351.8 47016.5 47130.5 50460.7 51411.9 66545.0 67990.7 68001.7 69569.0 69836.7 12811.6 13248.9 13295.1 13416.6 13522.7 14715.6 14728.5 14928.5 14936.0 15444.8 13701.5 13836.4 13858.2 14136.6 14319.3 13426.4 13630.5 13699.6 13748.1 14044.0 13272.5 13319.1 13511.4 13738.5 13936.4 11018.7 11115.1 11275.5 11304.2 11710.1 8432.5 10110.2 10731.4 11080.0 11100.7 11:41:42 INFO - PROCESS | 1646 | -------- Summary: end -------- 11:41:42 INFO - PROCESS | 1646 | 11:41:43 INFO - TEST-INFO | 1646: exit 0 11:41:43 INFO - TEST-OK | dromaeo_css | took 1115015ms 11:41:43 INFO - TEST-START | kraken 11:41:43 INFO - operating with platform_type : mac_ 11:41:43 INFO - Initialising browser for kraken test... 11:41:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpXpeHTW/profile http://localhost:49239/getInfo.html) 11:41:45 INFO - PROCESS | 1654 | 2017-01-13 11:41:45.846 plugin-container[1655:10178] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 11:41:45 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:41:45 INFO - PROCESS | 1654 | 2017-01-13 11:41:45.849 plugin-container[1655:10178] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 11:41:45 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:41:45 INFO - PROCESS | 1654 | 2017-01-13 11:41:45.849 plugin-container[1655:10178] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:41:45 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 11:41:45 INFO - PROCESS | 1654 | colorDepth:24 11:41:45 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 11:41:45 INFO - PROCESS | 1654 | __metrics 11:41:46 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 11:41:46 INFO - TEST-INFO | 1654: exit 0 11:41:46 INFO - Browser initialized. 11:41:46 INFO - Running cycle 1/1 for kraken test... 11:41:46 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpXpeHTW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:49 INFO - PROCESS | 1656 | 2017-01-13 11:41:49.044 plugin-container[1657:10297] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 11:41:49 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:41:49 INFO - PROCESS | 1656 | 2017-01-13 11:41:49.045 plugin-container[1657:10297] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 11:41:49 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:41:49 INFO - PROCESS | 1656 | 2017-01-13 11:41:49.045 plugin-container[1657:10297] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:41:58 INFO - PROCESS | 1656 | RSS: Main: 233189376 11:41:58 INFO - PROCESS | 1656 | 11:42:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:02 INFO - PROCESS | 1656 | RSS: Main: 246079488 11:42:02 INFO - PROCESS | 1656 | 11:42:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 11:42:05 INFO - PROCESS | 1656 | RSS: Main: 254087168 11:42:05 INFO - PROCESS | 1656 | 11:42:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 11:42:10 INFO - PROCESS | 1656 | RSS: Main: 256786432 11:42:10 INFO - PROCESS | 1656 | 11:42:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 11:42:12 INFO - PROCESS | 1656 | RSS: Main: 257998848 11:42:12 INFO - PROCESS | 1656 | 11:42:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:15 INFO - PROCESS | 1656 | RSS: Main: 258277376 11:42:15 INFO - PROCESS | 1656 | 11:42:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:18 INFO - PROCESS | 1656 | RSS: Main: 263794688 11:42:18 INFO - PROCESS | 1656 | 11:42:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:22 INFO - PROCESS | 1656 | RSS: Main: 264540160 11:42:22 INFO - PROCESS | 1656 | 11:42:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 11:42:26 INFO - PROCESS | 1656 | RSS: Main: 264204288 11:42:26 INFO - PROCESS | 1656 | 11:42:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:28 INFO - PROCESS | 1656 | RSS: Main: 264187904 11:42:28 INFO - PROCESS | 1656 | 11:42:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:31 INFO - PROCESS | 1656 | RSS: Main: 264208384 11:42:31 INFO - PROCESS | 1656 | 11:42:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:33 INFO - PROCESS | 1656 | RSS: Main: 263749632 11:42:33 INFO - PROCESS | 1656 | 11:42:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:37 INFO - PROCESS | 1656 | RSS: Main: 264073216 11:42:37 INFO - PROCESS | 1656 | 11:42:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:41 INFO - PROCESS | 1656 | RSS: Main: 263905280 11:42:41 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 11:42:43 INFO - PROCESS | 1656 | RSS: Main: 265744384 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | __start_tp_report 11:42:43 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 11:42:43 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 11:42:43 INFO - PROCESS | 1656 | |i|pagename|runs| 11:42:43 INFO - PROCESS | 1656 | |0;ai-astar;106;122;119;119;118;136;174;152;120;119 11:42:43 INFO - PROCESS | 1656 | |1;audio-beat-detection;144;116;115;149;113;115;117;112;144;143 11:42:43 INFO - PROCESS | 1656 | |2;audio-dft;236;270;231;269;243;195;196;259;267;193 11:42:43 INFO - PROCESS | 1656 | |3;audio-fft;83;58;59;83;79;81;59;63;95;84 11:42:43 INFO - PROCESS | 1656 | |4;audio-oscillator;87;71;84;74;71;100;108;101;82;81 11:42:43 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;87;87;84;103;90;88;86;90;96 11:42:43 INFO - PROCESS | 1656 | |6;imaging-darkroom;100;100;131;103;101;114;125;99;99;113 11:42:43 INFO - PROCESS | 1656 | |7;imaging-desaturate;93;132;103;82;77;142;144;136;93;96 11:42:43 INFO - PROCESS | 1656 | |8;json-parse-financial;63;61;62;62;62;62;63;62;62;63 11:42:43 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;71;74;67;80;75;74;70;70;84;104 11:42:43 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;90;84;109;89;86;89;93;92;88;99 11:42:43 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;162;165;158;142;145;143;145;134;210;175 11:42:43 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;175;243;221;170;174;171;173;174;172;176 11:42:43 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;70;73;84;89;68;68;69;69;70;68 11:42:43 INFO - PROCESS | 1656 | __end_tp_report 11:42:43 INFO - PROCESS | 1656 | __start_cc_report 11:42:43 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,906 11:42:43 INFO - PROCESS | 1656 | __end_cc_report 11:42:43 INFO - PROCESS | 1656 | __startTimestamp1484336563418__endTimestamp 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | ------- Summary: start ------- 11:42:43 INFO - PROCESS | 1656 | Number of tests: 14 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:128.50 Median:121.00 stddev:20.22 (16.7%) stddev-sans-first:19.74 11:42:43 INFO - PROCESS | 1656 | Values: 106.0 122.0 119.0 119.0 118.0 136.0 174.0 152.0 120.0 119.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:130.00 stddev:15.80 (12.2%) stddev-sans-first:15.49 11:42:43 INFO - PROCESS | 1656 | Values: 144.0 116.0 115.0 149.0 113.0 115.0 117.0 112.0 144.0 143.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:235.90 Median:251.00 stddev:31.52 (12.6%) stddev-sans-first:33.43 11:42:43 INFO - PROCESS | 1656 | Values: 236.0 270.0 231.0 269.0 243.0 195.0 196.0 259.0 267.0 193.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:74.40 Median:82.00 stddev:13.34 (16.3%) stddev-sans-first:13.79 11:42:43 INFO - PROCESS | 1656 | Values: 83.0 58.0 59.0 83.0 79.0 81.0 59.0 63.0 95.0 84.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:77.50 stddev:13.10 (16.9%) stddev-sans-first:13.89 11:42:43 INFO - PROCESS | 1656 | Values: 87.0 71.0 84.0 74.0 71.0 100.0 108.0 101.0 82.0 81.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:88.50 stddev:5.58 (6.3%) stddev-sans-first:5.90 11:42:43 INFO - PROCESS | 1656 | Values: 89.0 87.0 87.0 84.0 103.0 90.0 88.0 86.0 90.0 96.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:119.50 stddev:11.74 (9.8%) stddev-sans-first:12.04 11:42:43 INFO - PROCESS | 1656 | Values: 100.0 100.0 131.0 103.0 101.0 114.0 125.0 99.0 99.0 113.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:109.80 Median:79.50 stddev:25.90 (32.6%) stddev-sans-first:26.74 11:42:43 INFO - PROCESS | 1656 | Values: 93.0 132.0 103.0 82.0 77.0 142.0 144.0 136.0 93.0 96.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 11:42:43 INFO - PROCESS | 1656 | Values: 63.0 61.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:74.00 stddev:10.76 (14.5%) stddev-sans-first:11.20 11:42:43 INFO - PROCESS | 1656 | Values: 71.0 74.0 67.0 80.0 75.0 74.0 70.0 70.0 84.0 104.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:89.50 stddev:7.28 (8.1%) stddev-sans-first:7.69 11:42:43 INFO - PROCESS | 1656 | Values: 90.0 84.0 109.0 89.0 86.0 89.0 93.0 92.0 88.0 99.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:160.00 stddev:22.24 (13.9%) stddev-sans-first:23.54 11:42:43 INFO - PROCESS | 1656 | Values: 162.0 165.0 158.0 142.0 145.0 143.0 145.0 134.0 210.0 175.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:174.50 stddev:25.42 (14.6%) stddev-sans-first:26.71 11:42:43 INFO - PROCESS | 1656 | Values: 175.0 243.0 221.0 170.0 174.0 171.0 173.0 174.0 172.0 176.0 11:42:43 INFO - PROCESS | 1656 | 11:42:43 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:70.00 stddev:7.47 (10.7%) stddev-sans-first:7.85 11:42:43 INFO - PROCESS | 1656 | Values: 70.0 73.0 84.0 89.0 68.0 68.0 69.0 69.0 70.0 68.0 11:42:43 INFO - PROCESS | 1656 | -------- Summary: end -------- 11:42:43 INFO - PROCESS | 1656 | 11:42:44 INFO - TEST-INFO | 1656: exit 0 11:42:44 INFO - TEST-OK | kraken | took 61434ms 11:42:44 INFO - SUITE-END | took 1176s 11:42:44 INFO - Completed test suite (00:19:36) 11:42:44 INFO - javascript benchmark 11:42:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7197.536444953, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2867.7992540522173, 3370.7022796223446, 3379.61134469536, 3402.370561446133, 3405.5402520659736, 5614.803481878125, 5680.034394152994, 5722.1988921550965, 5741.511971482429, 5779.162021506879, 4623.514530974249, 5427.213054107162, 5475.753591088401, 5476.2333273341765, 5518.2826232589705, 4149.937750933738, 5016.7742451589675, 5246.711430871301, 5251.212318152288, 5294.602904782138, 5180.844574662766, 5229.843104706846, 5263.236830659552, 5284.233786101013, 5330.893382132355, 5233.842984710464, 5277.102892508283, 5293.15309550472, 5301.469853014687, 5306.893862122755, 5123.538881500645, 5153.433122356538, 5156.432792392834, 5180.912008478224, 5245.895082098375, 5131.640785145004, 5155.355580552431, 5200.5059519345605, 5201.505856943584, 5239.973800131013, 4791.616670666338, 5635.239242702224, 5675.772969081232, 5688.004599195125, 5730.169125476824, 6053.061775424816, 6095.878082438327, 6119.418655227791, 6158.599691020069, 6191.442770150663, 6118.83238421412, 6159.414855588712, 6178.783742569033, 6181.96909015452, 6233.3143354231, 5700.857478563069, 5845.532357411439, 5857.26784151981, 5858.2677165354335, 5891.941080589182, 5663.490285874291, 6147.631142131487, 6210.4100110489435, 6227.221597300338, 6236.844078898064, 6032.4570788629235, 6053.727582258809, 6099.146119543268, 6111.84720381994, 6113.02191649334, 6114.4190257321325, 6173.9073913891325, 6207.751689932443, 6217.253929528486, 6224.719887605069, 6061.636301821816, 6093.360197179321, 6135.202423684982, 6216.378362163748, 6229.719662615194, 6133.242854861876, 6194.969025154845, 6217.844553886189, 6233.189685340877, 6251.843703907439, 4761.333413322138, 4809.038192361541, 4951.504849515091, 4993.675411098267, 5018.4981501849525, 4328.9134217316105, 4443.955670417449, 4472.351509031238, 4501.212287849678, 4534.501204867462, 5917.31950825652, 5963.880722385528, 5985.760569577168, 5988.251468566429, 5988.9101663475085, 6130.9179418630665, 6190.0405437157315, 6209.316975132731, 6213.440790328802, 6217.191765070603, 5812.9709351452975, 5897.410258974154, 5920.644761314335, 5931.110333450017, 6038.849028774316, 5448.945510544923, 5456.945430545723, 5466.890662186734, 5467.043267428184, 5486.259354987025, 5150.330457040561, 6257.9687101564205, 6305.306416294204, 6309.085182648582, 6334.081558174039, 6127.403330890726, 6133.334663918993, 6136.846578835565, 6136.938630613815, 6152.138700581832, 6312.400321969406, 6344.9048264277, 6345.682715864281, 6352.0, 6372.58578192416, 5713.885722285448, 6114.113453549299, 6164.0, 6191.969040154951, 6194.0708893666315, 5195.870103247449, 6024.427679370453, 6126.578745377076, 6139.246828488627, 6145.432914606747, 6052.848678783065, 6131.693415329305, 6139.001538246313, 6139.921477736919, 6192.380761923771, 5130.640855140105, 5975.43233392827, 6076.661563848124, 6083.148359229623, 6154.353792851686, 5748.252727145445, 5848.883022339614, 5879.647221166743, 5933.3769954154195, 5993.981023225975, 6108.908366374419, 6111.930412177762, 6114.785982490592, 6117.296510901126, 6144.385561443999, 5909.172715819703, 5945.167676525203, 5951.523878089656, 5958.285005799332, 5996.220491336273], "value": 5654.83420729092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.352012821345, 509.23614578132793, 509.54904909155385, 520.7604501929112, 521.3639359980823, 39407.60592394079, 41537.58462415379, 41700.58299417009, 41753.373699394455, 43446.0, 42178.0, 42554.787226063905, 42747.93130171747, 42771.0, 42793.78603106988, 8380.161983801601, 9162.81674366514, 9355.204807591363, 9386.108319709616, 9394.201492873113, 8008.319292860114, 11110.666679999613, 11381.886181138165, 11383.317000979927, 11542.711432214177, 11257.493412796444, 11266.549338026469, 11281.717957051098, 11293.717657058558, 11303.152263580223, 11214.10287177024, 11246.606368777053, 11300.0, 11310.208285420023, 11372.0, 10985.835212471819, 11140.442977851157, 11226.775464490745, 11242.662720118327, 11298.491567879382, 31917.361652766816, 35784.82107589472, 39691.809245722674, 39895.20209595821, 39896.40155397671, 3995.2808494470983, 4030.234255491447, 4032.7983600819844, 4066.5730098339545, 4181.770002649853, 24364.0, 29654.70345296541, 30192.24519387011, 30198.84900575505, 30303.545446818316, 3123.1255248530447, 3154.463741164008, 3256.2836176041233, 3305.3554556861422, 3322.900312990614, 452530.0, 454914.0, 457969.7101514504, 458402.0, 459748.0, 58521.414785852445, 58872.0, 59404.10893836596, 59593.106103408485, 59593.70203149043, 62895.74208515804, 63005.68497157485, 63215.0, 63390.68304658447, 63525.72948541003, 15723.113226412903, 16224.432144874872, 16242.51272461828, 16285.0, 16286.918565407097, 11339.546418143347, 11612.187146899805, 12351.567695130627, 12600.243985360908, 12615.990720742318, 15793.131377774103, 15856.920715396349, 16064.0, 16075.115868627337, 16352.672946541003, 6924.272951340137, 6983.301669832976, 6995.691421830886, 7034.296570343027, 7053.224145344008, 823.4482896459386, 855.619249433996, 862.4652715316419, 862.8835107260566, 885.5173930208052, 29957.251068723457, 30132.698673013427, 30162.84918575393, 30290.69709302923, 30611.540826887616, 926.7080869526212, 981.1856159387692, 1044.5038606661774, 1081.302559848893, 1213.4296880466168, 13412.798808017887, 15114.773278400833, 15634.765478517831, 15695.764563531557, 16002.599935001717, 608068.0, 610022.0, 610174.0, 610410.0, 611457.0, 58333.708331458074, 58629.12056319159, 58951.41048589545, 59165.0, 59195.0, 1390.986090139106, 1429.2139323372103, 1439.4026479011302, 1445.3279225160352, 1455.4105587237398, 24066.9169887359, 26842.463150737265, 27615.72384276212, 28829.0, 29879.701202987693, 48170.27744583904, 49936.0, 50652.74673626756, 50681.49318506915, 50788.74605626948, 565603.0, 566818.0, 572864.0, 573429.0, 573593.0, 24127.0, 24167.0, 24555.754442455345, 24671.629925550773, 24777.87611061933, 40799.77600671985, 41089.58910410858, 41852.0, 42197.789011054745, 42312.0, 34940.82529587336, 35254.94235172949, 35263.0, 35697.643023569435, 36076.8196159028, 34796.478052829734, 34807.47788783221, 35674.28651427009, 35949.0, 36043.459348109274, 33574.82488112905, 33842.3231535363, 34065.48901766426, 34321.65678343185, 34591.654083458845, 29327.85336073306, 30953.845230773702, 31029.534556981213, 31236.0, 31289.06132816019, 23365.76634233704, 23477.805224942258, 23496.060157594187, 23687.05251789909, 23948.760512394652], "value": 19626.011581900926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1567105355058, 388.16738096782404, 392.1118666221008, 399.63633093884573, 421.9935453942347, 15793.84206157938, 16828.57928551787, 19616.509587260327, 20947.790522094776, 20963.266285679983, 20547.897260513677, 20644.587108257827, 20803.791962080373, 21430.678539821914, 21551.461213469633, 5438.7280635968245, 5755.6258843175265, 5813.6221145625395, 5827.737751801158, 5836.6789826559525, 5592.07730724432, 5740.54075673945, 5784.1034639630925, 5785.0, 5837.0, 5676.347220069683, 5751.654900705971, 5765.855853603673, 5769.278840144982, 5783.421657834204, 4989.727619457051, 5347.4919882611475, 5733.455321744427, 5757.021306377905, 5759.251297331362, 4974.90050198994, 5081.466446023152, 5089.796408143669, 5091.0581542414775, 5107.0, 23841.165559205518, 24329.391765205834, 24963.5007299853, 25026.1240856571, 25718.228453146436, 2580.5226033183735, 2591.572390555556, 2647.9602805957925, 2683.1413947536794, 2785.456835916997, 9507.714768556954, 10122.392656440637, 10212.897871021269, 10271.79456410875, 10337.483125843753, 1794.7397627343962, 1836.9448916532526, 1873.8500919926373, 1873.878197917131, 1874.2690350763214, 141474.2926285362, 141798.0, 142013.0, 142834.99999999895, 145328.0, 11377.2604780689, 11480.138989575815, 11620.6513804586, 11865.228760130563, 11920.165588408729, 13508.729825403438, 14158.504452344325, 15120.470783522524, 15149.015314004555, 15152.01511901723, 8180.141085186089, 8465.492070475791, 8543.40196186261, 8568.485890846569, 8697.521636309937, 8361.456505327134, 8362.331013518904, 8367.916320836835, 8520.74437766868, 8538.316934645214, 3933.9606603934167, 4666.160091183619, 4668.789904454307, 4784.138855006063, 4872.538238528427, 1998.2306811877531, 2020.1919232307196, 2037.7147199392098, 2044.877307361563, 2047.754269487671, 734.7061175529831, 854.2999431132126, 895.6954635423857, 905.1717678324391, 918.0681608167715, 17905.552361190814, 18039.458816235532, 18978.766380185243, 20489.0, 21281.89359053195, 879.2702057292432, 938.9201917836924, 947.3463310315998, 953.7949340891741, 960.6973803251954, 5470.835874923759, 5558.749856256478, 6472.449841763409, 6720.395164435126, 6757.526973111933, 423472.0, 425744.0, 483701.0, 723096.0, 729959.0, 148191.0, 157790.0, 160773.39226607585, 163142.1842890778, 165624.0, 1035.9896401036044, 1065.6217042949797, 1081.4808891732014, 1091.7871015151968, 1092.7650555130526, 11982.0, 12092.032637389164, 12160.939195303967, 12189.451474683483, 12327.815082773586, 53197.0, 53263.733681331345, 54407.0, 54609.72695136499, 54988.72505637446, 83573.58213208895, 84588.63156216279, 84809.72785408347, 84975.57512212399, 85471.5726421364, 7809.33620642229, 8148.918510814816, 8340.916590834015, 8372.037215720271, 8468.407211495383, 9007.63969441215, 11373.54505819758, 12291.446884890023, 12975.805362919375, 13065.673358166121, 10243.0, 11439.256448330832, 11595.362255076052, 11761.294322340687, 11767.588134415255, 9906.356086854332, 10096.646617368357, 11045.723856903642, 11504.482298296429, 11629.88370116288, 10134.391936483835, 10831.729206769895, 11221.438928053401, 11400.48697808584, 11739.413029348669, 8202.58987050657, 8300.12848650883, 8308.33533317321, 8376.413651044368, 8471.745847624581, 9328.486933218466, 9751.56117974707, 11545.711357216136, 11589.24669896454, 11711.648650540497], "value": 9382.055936181929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.8313894485304, 1317.216256327485, 1451.3904160252694, 1453.1499073042269, 1464.6997365540064, 7256.528325658842, 7484.363829074521, 7692.807679808007, 7976.9202307976975, 8072.636731347089, 7973.40199485038, 8270.255676989069, 8296.460730052542, 8363.665453381858, 8391.874121888177, 2208.9116435342607, 2227.721534808149, 2235.2176738141684, 2239.4177513846353, 2247.797698207161, 2044.9182032718672, 2320.373499155227, 2355.222776483756, 2358.681577986967, 2366.8816559171973, 2078.4388215181893, 2238.653008783633, 2327.057541695616, 2335.182686059874, 2340.9297721068397, 2277.9772202278014, 2315.3401280635107, 2333.614953532665, 2343.4375749820006, 2343.4492894169857, 2274.124462082094, 2299.1837897546466, 2314.6990891184205, 2368.1829768729763, 2370.0875163062174, 8364.832703345959, 8380.24577787996, 8415.83168336636, 8424.620892059873, 8430.620622072021, 5034.974825125851, 5146.871328216787, 5181.948180518184, 5182.222666600002, 5196.168613021936, 3245.5618491503583, 3355.027042157771, 3359.0930448778695, 3420.1791570023265, 3430.1767575781632, 1147.1568397228032, 1174.74155685749, 1192.749522600255, 1196.0312147160828, 1219.6706889139882, 10606.9469652652, 10624.787504249949, 10789.460526973699, 10817.242793004492, 10830.458477076114, 3878.185581028016, 4458.458678553258, 4680.0, 4728.219843725747, 4752.95247047532, 9433.528323583794, 9485.336026478219, 9490.383125096847, 9497.762555936019, 9505.524723763923, 5212.4266330703595, 5217.921731174036, 5225.085610018232, 5233.790648374023, 5240.764165612557, 4650.95349046512, 4663.417072865892, 4693.014466961976, 4742.980259244279, 4757.119932812441, 3794.9241015180096, 3836.712246581518, 3869.903252418712, 3909.5113110861143, 3954.7542524104815, 1167.9941600292113, 1180.055955235808, 1184.6327638432113, 1215.8480189976253, 1227.2329793878826, 638.6264035539261, 758.4577027425418, 788.7318311774025, 812.0620683111016, 819.2544784246307, 5270.868228294324, 5308.840734777963, 5408.242846001563, 5476.424975377608, 5563.693996830132, 773.3542492019114, 918.3342076994126, 970.1656575345197, 981.40134517944, 997.1524204426324, 3445.9483107753404, 3616.8372423241017, 3683.7605555638797, 3772.2455508897783, 3777.5089238399382, 8104.756857294291, 9303.023182565868, 9765.02349765032, 9794.706158815246, 9824.607015719434, 9673.322867399214, 9707.854382184272, 9717.465539395402, 9746.269029822792, 9798.26513011527, 6170.722317495633, 7702.845943081219, 7737.690492380354, 7776.377889768805, 7812.453128280966, 4706.305729937289, 5567.582431317586, 5650.915236271541, 5773.884522309614, 5819.79630712923, 9018.143276388733, 9110.9977902432, 9141.0, 9184.954075229582, 9197.712320275301, 7717.996660434108, 8883.33374996865, 9332.066793320613, 9372.062793720574, 9473.66842160521, 6917.308269173042, 6966.651667416508, 6977.406920411822, 6982.79051628452, 7044.084269044992, 7518.248175182438, 7557.584332861746, 7609.619519024137, 7611.467197296136, 7671.923280767121, 6819.079424277659, 6877.346652068046, 6925.342092501204, 6946.9652651736415, 7027.9297207027275, 6794.83012924661, 6829.385355318045, 6835.58986460814, 6880.65596720172, 6882.655867206719, 6029.4874935629205, 6114.0828875669, 6146.477549408351, 6153.230846144232, 6198.907016394848, 4832.202686556679, 4853.975730121327, 4887.242477416006, 4897.975510122569, 4980.477049909708, 4769.76151192432, 4855.028994201244, 4925.753712314298, 4953.108440480748, 4956.430010548833], "value": 4322.623004260753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.26628550332, 355.671004321003, 359.7409864897274, 367.72788136778775, 372.0661140537251, 5200.541639809531, 5266.7629956651945, 5408.0, 5452.754626041828, 5526.723663816803, 5126.436092029883, 5301.0121204548295, 5315.654482458647, 5324.65389749666, 5334.786608535654, 3263.738900887935, 4089.713720039591, 4225.788710564475, 4239.236937351276, 4248.7481634733485, 3309.635940046593, 3747.1381582236104, 4221.683373746966, 4261.509926358462, 4267.359896015591, 3953.861614843481, 4120.134771697947, 4133.016152246923, 4143.19207754488, 4162.271602469571, 4156.5635608261, 4159.2721273777115, 4162.771047592381, 4172.958270417287, 4207.410962465257, 3691.8065873019646, 3691.984704206338, 3702.148505843644, 3720.962790372089, 3722.40441529354, 4395.835103697523, 4669.696469729491, 4942.406911170682, 5168.302279192299, 5231.424543300234, 4645.4694432231745, 4766.189747742892, 4778.331033655291, 4810.735409552473, 4880.267959806022, 4649.744264065475, 4715.858524244278, 4792.634099281688, 5683.715814209314, 5874.50066744323, 3948.6841052716, 4044.3933409988445, 4069.409935559327, 4088.3049881520215, 4091.4067460218102, 5476.507114359727, 5915.497182739472, 5916.497097746696, 5926.496247818941, 5970.373110823344, 3961.9405708914387, 4007.8396864125693, 4078.775667338325, 4151.46031015966, 4155.688323375698, 3583.8924832255075, 4011.8165141282807, 4171.83312667496, 4179.9791001045405, 4205.789710514462, 4794.376731024944, 4798.272621856129, 4831.855044348676, 4840.878978025577, 4863.367762190893, 5276.36683597963, 5486.2419242818, 5725.341585717612, 5768.2501274834, 5769.451902069297, 1128.700894263021, 1296.8508621508647, 1309.6005718256024, 1366.8154799101994, 1382.4815694114707, 928.967486137982, 959.3811991265594, 959.7072892767773, 966.4056605187759, 971.0920289529313, 4364.607185353333, 4741.336212930192, 4958.281049247911, 5105.519399374214, 5244.370675518962, 5114.258432527263, 5179.145441002268, 5209.6874187548865, 5342.969671524796, 5395.028894798896, 4848.903021939542, 5030.4215015272985, 5032.591023671354, 5063.291139240436, 5112.590992720573, 2422.733499315074, 2544.605586134152, 2775.916722498288, 2801.6918139004692, 2900.9564856527168, 4819.807207711652, 5103.642745007888, 5266.92099618506, 5291.772019068365, 5824.970875145597, 4472.651857774629, 5240.6069544784295, 5642.6614403135945, 5659.886802263932, 5708.658465260661, 5277.0, 5435.836924892181, 5535.750891209906, 5892.322382926019, 5963.880722385441, 4841.854744357534, 5163.870903227449, 5493.802479008428, 5512.283403157564, 5620.133731796731, 5080.441151473409, 5286.920696189483, 5748.798792042258, 5816.563757718103, 5899.292084949833, 5060.721660308718, 5393.595480338912, 5433.565314774887, 5442.183672449164, 6136.048912418582, 3714.888553343404, 3908.3160446921106, 3916.138449541096, 3929.8428062877165, 3933.5083114610675, 5109.821156259513, 5663.263775709296, 5787.826365209051, 5866.941330586639, 5890.322612899571, 5261.605379596469, 5581.330240371019, 5726.282115365457, 5738.0, 5843.649381037151, 5587.69267690281, 5787.710614469344, 5794.62334948227, 5797.623154494944, 5806.9419305806405, 4702.542211914318, 4775.880602984953, 4956.900861982668, 5531.972340138434, 5621.831345059655, 5330.653507521999, 5752.942470575241, 5763.962486752257, 5779.508741756829, 5803.245578074992, 4571.360009598592, 4766.733773272832, 4883.755812209446, 4891.853244402673, 5592.356878958972], "value": 4127.5393185209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2244941788742, 751.9887201691974, 777.5645638442469, 813.178689523581, 840.3907167303705, 12775.872241277584, 16073.437429689948, 16074.276657550408, 16084.517464476055, 16158.434454794084, 11949.0, 14241.287935603204, 14336.784948225784, 14366.640833979156, 14414.423423063065, 655.1973832055729, 673.9595624262536, 856.6016802186982, 875.5753459572103, 876.2376732242926, 880.4013270975765, 883.8630012348096, 885.2342723544152, 885.5616469847434, 886.6409104312763, 888.524639317965, 937.7421209167466, 945.3193700535637, 949.9882625004349, 956.0, 936.4240991790068, 936.9437833729964, 938.6245501799301, 941.7692665297012, 945.182417209116, 679.7111227728195, 698.0889938630086, 699.1156187422914, 699.5907394174415, 703.1386551474454, 14969.401223951028, 15216.163111028889, 15313.0, 15595.220238988006, 15862.048277103295, 12168.0, 14229.501967431193, 14353.497627582985, 14365.62344759066, 14422.783658245135, 11480.655580332603, 11581.942090289578, 11736.35450050247, 11771.823422648582, 11985.820212696817, 3713.424419215026, 3735.122246272124, 3760.736748427611, 3771.754835935683, 3772.5095737553943, 99015.0, 100278.49582256272, 102412.48793756058, 102953.0, 103208.48395758124, 11012.50443730034, 11090.112790976702, 11119.166062545342, 11262.887371126348, 11273.436328183558, 23173.304800856, 23290.65064024041, 23308.417289567897, 23319.18382856626, 23327.0, 7726.922730772732, 7869.685212591547, 7909.9209007909185, 7912.525248485109, 7996.720114795954, 4118.91762164755, 4186.288330983679, 4198.496180458304, 4231.767252801125, 4248.9787551062045, 3471.5834099908175, 3518.0, 3530.135116896377, 3548.6273941236313, 3570.6786389225094, 626.9090981807612, 632.4940047961612, 640.7565125252374, 642.4667525953447, 648.6626953983996, 668.1614573709962, 682.6620822692798, 696.6656005117572, 705.5061456980135, 708.7483943200193, 10207.387556746618, 10404.375737455777, 10414.791704165875, 10431.68704938853, 10484.842727359095, 589.0927970924813, 589.3016775121495, 608.342989571262, 636.3509220594967, 652.2727159217533, 4408.743692534758, 5061.9187347690295, 5063.770615178345, 5092.541671249605, 5106.259592359087, 69892.650536747, 75235.62382188054, 84739.0, 85252.0, 90978.09021909829, 81583.18416815756, 82394.0, 83586.58206708927, 83615.0, 83643.58178209192, 70897.6455117721, 73350.63324683343, 73936.63031684914, 73950.52098958098, 75319.62340188374, 8952.776180595538, 9254.907450925673, 10983.61557345521, 11133.332000079698, 11190.272632278877, 46351.76824115858, 47016.529834701214, 47130.528694712615, 50460.747696261285, 51411.915285083014, 66545.0, 67990.66004669946, 68001.65999169972, 69569.0, 69836.65081674763, 12811.615651530468, 13248.933755331162, 13295.069345145746, 13416.597502074954, 13522.661933451742, 14715.55853324402, 14728.484503042342, 14928.477503287768, 14936.029158104688, 15444.768328474856, 13701.520446784314, 13836.446542138201, 13858.16850988944, 14136.575902722934, 14319.28403579796, 13426.395812188279, 13630.454781808616, 13699.589012329647, 13748.063758557018, 14044.0, 13272.469101235842, 13319.134256273312, 13511.391987360788, 13738.519151829638, 13936.372863220977, 11018.669439916815, 11115.11079113685, 11275.50411645387, 11304.208705390543, 11710.063194944214, 8432.536210508235, 10110.191184705352, 10731.356118632906, 11080.0, 11100.666979990614], "value": 7482.863337953801, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 119.0, 119.0, 118.0, 136.0, 174.0, 152.0, 120.0, 119.0], "value": 128.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 115.0, 149.0, 113.0, 115.0, 117.0, 112.0, 144.0, 143.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [236.0, 270.0, 231.0, 269.0, 243.0, 195.0, 196.0, 259.0, 267.0, 193.0], "value": 235.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 83.0, 79.0, 81.0, 59.0, 63.0, 95.0, 84.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 84.0, 74.0, 71.0, 100.0, 108.0, 101.0, 82.0, 81.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 84.0, 103.0, 90.0, 88.0, 86.0, 90.0, 96.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 131.0, 103.0, 101.0, 114.0, 125.0, 99.0, 99.0, 113.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 132.0, 103.0, 82.0, 77.0, 142.0, 144.0, 136.0, 93.0, 96.0], "value": 109.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 67.0, 80.0, 75.0, 74.0, 70.0, 70.0, 84.0, 104.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 109.0, 89.0, 86.0, 89.0, 93.0, 92.0, 88.0, 99.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 158.0, 142.0, 145.0, 143.0, 145.0, 134.0, 210.0, 175.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 243.0, 221.0, 170.0, 174.0, 171.0, 173.0, 174.0, 172.0, 176.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 84.0, 89.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0], "value": 72.8, "unit": "score"}]}]} 11:42:44 INFO - Return code: 0 11:42:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:44 ERROR - # TBPL SUCCESS # 11:42:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:42:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:42:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:42:44 INFO - 2017-01-13 11:42:44.759 screenresolution[1661:10688] starting screenresolution argv=screenresolution get 11:42:44 INFO - 2017-01-13 11:42:44.762 screenresolution[1661:10688] Display 0: 1600x1200x32@60 11:42:44 INFO - 2017-01-13 11:42:44.768 screenresolution[1662:10691] starting screenresolution argv=screenresolution list 11:42:44 INFO - Available Modes on Display 0 11:42:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:42:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:42:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:42:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:42:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:42:45 INFO - Intel Iris: 11:42:45 INFO - Chipset Model: Intel Iris 11:42:45 INFO - Type: GPU 11:42:45 INFO - Bus: Built-In 11:42:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:42:45 INFO - Vendor: Intel (0x8086) 11:42:45 INFO - Device ID: 0x0a2e 11:42:45 INFO - Revision ID: 0x0009 11:42:45 INFO - Displays: 11:42:45 INFO - Display: 11:42:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:42:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:42:45 INFO - Display Serial Number: 1600x1200 60 11:42:45 INFO - Main Display: Yes 11:42:45 INFO - Mirror: Off 11:42:45 INFO - Online: Yes 11:42:45 INFO - Rotation: Supported 11:42:45 INFO - Return code: 0 11:42:45 INFO - Running post-action listener: _resource_record_post_action 11:42:45 INFO - [mozharness: 2017-01-13 19:42:45.011414Z] Finished run-tests step (success) 11:42:45 INFO - Running post-run listener: _resource_record_post_run 11:42:45 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 34140672; Write bytes: 557654016; Read time: 325; Write time: 1697 11:42:45 INFO - TinderboxPrint: CPU usage
54.7% 11:42:45 INFO - TinderboxPrint: I/O read bytes / time
34,140,672 / 325 11:42:45 INFO - TinderboxPrint: I/O write bytes / time
557,654,016 / 1,697 11:42:45 INFO - TinderboxPrint: CPU idle
2,175.1 (45.3%) 11:42:45 INFO - TinderboxPrint: CPU system
971.0 (20.2%) 11:42:45 INFO - TinderboxPrint: CPU user
1,651.6 (34.4%) 11:42:45 INFO - TinderboxPrint: Swap in / out
281,899,008 / 0 11:42:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 229020160; Write bytes: 224413696; Read time: 16355; Write time: 477 11:42:45 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 33202688; Write bytes: 302979072; Read time: 312; Write time: 1163 11:42:45 INFO - Running post-run listener: _upload_blobber_files 11:42:45 INFO - Blob upload gear active. 11:42:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:42:45 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:42:45 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:42:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:42:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:47 INFO - (blobuploader) - INFO - Done attempting. 11:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:48 INFO - (blobuploader) - INFO - Done attempting. 11:42:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:42:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:42:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:49 INFO - (blobuploader) - INFO - Done attempting. 11:42:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:52 INFO - (blobuploader) - INFO - Done attempting. 11:42:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:52 INFO - Return code: 0 11:42:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9ad33acbc4f3ae6d603f66b96ebff14df243d60daf0938fda56ad62c07c5896c7e542e7d2570e62d623598e9fec061fec06aed829ea9e59b371124290c0e5af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d2d4c59bf32474d1121348ccce2e89f524d5c067b18502f5053e362bd443f808405c4d8221f6d66c918b8bf02e858ae9da8ea7f5e45db0fd5878b7a565f9decb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9971ac1ee4a31ccb662cf7b26a7714452842a6509f8ff45f55e5ee8ddaecfd3a169e31f8639ea06bebded8ee34b2abec4ed96582584dec63d785a42aefe82569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a048082106b4412c4516a1526acb9d250194050babd031433ce0125c7b5776a1548477546afe7595db949a93e787be005014f44463c3bc7f8e1bc554046d5833"} 11:42:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:52 INFO - Contents: 11:42:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9ad33acbc4f3ae6d603f66b96ebff14df243d60daf0938fda56ad62c07c5896c7e542e7d2570e62d623598e9fec061fec06aed829ea9e59b371124290c0e5af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d2d4c59bf32474d1121348ccce2e89f524d5c067b18502f5053e362bd443f808405c4d8221f6d66c918b8bf02e858ae9da8ea7f5e45db0fd5878b7a565f9decb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9971ac1ee4a31ccb662cf7b26a7714452842a6509f8ff45f55e5ee8ddaecfd3a169e31f8639ea06bebded8ee34b2abec4ed96582584dec63d785a42aefe82569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a048082106b4412c4516a1526acb9d250194050babd031433ce0125c7b5776a1548477546afe7595db949a93e787be005014f44463c3bc7f8e1bc554046d5833"} 11:42:52 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:52 INFO - Copying logs to upload dir... 11:42:52 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.516703 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-13 11:42:52.154333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 11:42:52.157896) ========= 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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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/Graphics/sha512/b9ad33acbc4f3ae6d603f66b96ebff14df243d60daf0938fda56ad62c07c5896c7e542e7d2570e62d623598e9fec061fec06aed829ea9e59b371124290c0e5af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d2d4c59bf32474d1121348ccce2e89f524d5c067b18502f5053e362bd443f808405c4d8221f6d66c918b8bf02e858ae9da8ea7f5e45db0fd5878b7a565f9decb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9971ac1ee4a31ccb662cf7b26a7714452842a6509f8ff45f55e5ee8ddaecfd3a169e31f8639ea06bebded8ee34b2abec4ed96582584dec63d785a42aefe82569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a048082106b4412c4516a1526acb9d250194050babd031433ce0125c7b5776a1548477546afe7595db949a93e787be005014f44463c3bc7f8e1bc554046d5833"} build_url:https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9ad33acbc4f3ae6d603f66b96ebff14df243d60daf0938fda56ad62c07c5896c7e542e7d2570e62d623598e9fec061fec06aed829ea9e59b371124290c0e5af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d2d4c59bf32474d1121348ccce2e89f524d5c067b18502f5053e362bd443f808405c4d8221f6d66c918b8bf02e858ae9da8ea7f5e45db0fd5878b7a565f9decb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9971ac1ee4a31ccb662cf7b26a7714452842a6509f8ff45f55e5ee8ddaecfd3a169e31f8639ea06bebded8ee34b2abec4ed96582584dec63d785a42aefe82569", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a048082106b4412c4516a1526acb9d250194050babd031433ce0125c7b5776a1548477546afe7595db949a93e787be005014f44463c3bc7f8e1bc554046d5833"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 11:42:52.192032) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:42:52.192364) ========= 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.7FtM5kEaBY/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.ZBsYPigh2W/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.004983 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:42:52.241304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 11:42:52.241600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 11:42:52.241878) ========= ========= Total master_lag: 0.20 =========