builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1490382189.3 results: success (0) buildid: 20170324102715 builduid: f0dc57b0e93942cea107d9e82e754f0b revision: 3ae80b40ca579dcfbda891794da475bb67ab6eb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.299687) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.300153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.300510) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.325104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.325446) ========= 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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-03-24 12:03:09-- 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% 149M=0s 2017-03-24 12:03:09 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.471906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.472217) ========= 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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.021723 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:09.520974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 12:03:09.521323) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3ae80b40ca579dcfbda891794da475bb67ab6eb3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3ae80b40ca579dcfbda891794da475bb67ab6eb3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-03-24 12:03:09,549 truncating revision to first 12 chars 2017-03-24 12:03:09,549 Setting DEBUG logging. 2017-03-24 12:03:09,549 attempt 1/10 2017-03-24 12:03:09,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3ae80b40ca57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 12:03:11,131 unpacking tar archive at: mozilla-beta-3ae80b40ca57/testing/mozharness/ program finished with exit code 0 elapsedTime=1.836348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 12:03:11.381921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:11.382416) ========= script_repo_revision: 3ae80b40ca579dcfbda891794da475bb67ab6eb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:11.382801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:11.383068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 12:03:11.402721) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-24 12:03:11.402998) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:11 INFO - MultiFileLogger online at 20170324 12:03:11 in /builds/slave/test 12:03:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:03:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:03:11 INFO - {'append_to_log': False, 12:03:11 INFO - 'base_work_dir': '/builds/slave/test', 12:03:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:03:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:03:11 INFO - 'branch': 'Mozilla-Beta', 12:03:11 INFO - 'buildbot_json_path': 'buildprops.json', 12:03:11 INFO - 'config_files': ('talos/mac_config.py',), 12:03:11 INFO - 'default_actions': ('clobber', 12:03:11 INFO - 'read-buildbot-config', 12:03:11 INFO - 'download-and-extract', 12:03:11 INFO - 'populate-webroot', 12:03:11 INFO - 'create-virtualenv', 12:03:11 INFO - 'install', 12:03:11 INFO - 'run-tests'), 12:03:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:03:11 INFO - 'download_minidump_stackwalk': True, 12:03:11 INFO - 'download_symbols': 'ondemand', 12:03:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:03:11 INFO - 'tooltool.py': '/tools/tooltool.py', 12:03:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:03:11 INFO - '/tools/misc-python/virtualenv.py')}, 12:03:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:03:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:03:11 INFO - 'installer_path': 'installer.exe', 12:03:11 INFO - 'log_level': 'info', 12:03:11 INFO - 'log_name': 'talos', 12:03:11 INFO - 'log_to_console': True, 12:03:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:03:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:03:11 INFO - 'opt_config_files': (), 12:03:11 INFO - 'pip_index': False, 12:03:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:03:11 INFO - 'cmd': ('bash', 12:03:11 INFO - '-c', 12:03:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:03:11 INFO - 'enabled': True, 12:03:11 INFO - 'halt_on_failure': False, 12:03:11 INFO - 'name': 'check_screen_resolution'},), 12:03:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:03:11 INFO - 'cmd': ('bash', 12:03:11 INFO - '-c', 12:03:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:03:11 INFO - 'enabled': True, 12:03:11 INFO - 'halt_on_failure': False, 12:03:11 INFO - 'name': 'check_screen_resolution'},), 12:03:11 INFO - 'run_cmd_checks_enabled': True, 12:03:11 INFO - 'sps_profile': False, 12:03:11 INFO - 'sps_profile_interval': 0, 12:03:11 INFO - 'suite': 'dromaeojs-e10s', 12:03:11 INFO - 'system_bits': '32', 12:03:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:03:11 INFO - 'title': 't-yosemite-r7-0167', 12:03:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:03:11 INFO - 'use_talos_json': True, 12:03:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:03:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:03:11 INFO - 'work_dir': 'build'} 12:03:11 INFO - [mozharness: 2017-03-24 19:03:11.554062Z] Running clobber step. 12:03:11 INFO - Running pre-action listener: _resource_record_pre_action 12:03:11 INFO - Running main action method: clobber 12:03:11 INFO - rmtree: /builds/slave/test/build 12:03:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:03:13 INFO - Running post-action listener: _resource_record_post_action 12:03:13 INFO - [mozharness: 2017-03-24 19:03:13.323643Z] Finished clobber step (success) 12:03:13 INFO - [mozharness: 2017-03-24 19:03:13.323786Z] Running read-buildbot-config step. 12:03:13 INFO - Running pre-action listener: _resource_record_pre_action 12:03:13 INFO - Running main action method: read_buildbot_config 12:03:13 INFO - Using buildbot properties: 12:03:13 INFO - { 12:03:13 INFO - "project": "", 12:03:13 INFO - "product": "firefox", 12:03:13 INFO - "script_repo_revision": "production", 12:03:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:03:13 INFO - "repository": "", 12:03:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:03:13 INFO - "buildid": "20170324102715", 12:03:13 INFO - "pgo_build": "False", 12:03:13 INFO - "basedir": "/builds/slave/test", 12:03:13 INFO - "buildnumber": 15, 12:03:13 INFO - "slavename": "t-yosemite-r7-0167", 12:03:13 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:03:13 INFO - "platform": "yosemite_r7", 12:03:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:03:13 INFO - "branch": "mozilla-beta", 12:03:13 INFO - "repo_path": "releases/mozilla-beta", 12:03:13 INFO - "revision": "3ae80b40ca579dcfbda891794da475bb67ab6eb3", 12:03:13 INFO - "stage_platform": "macosx64", 12:03:13 INFO - "builduid": "f0dc57b0e93942cea107d9e82e754f0b", 12:03:13 INFO - "slavebuilddir": "test" 12:03:13 INFO - } 12:03:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 12:03:13 INFO - Running post-action listener: _resource_record_post_action 12:03:13 INFO - [mozharness: 2017-03-24 19:03:13.327209Z] Finished read-buildbot-config step (success) 12:03:13 INFO - [mozharness: 2017-03-24 19:03:13.327322Z] Running download-and-extract step. 12:03:13 INFO - Running pre-action listener: _resource_record_pre_action 12:03:13 INFO - Running main action method: download_and_extract 12:03:13 INFO - mkdir: /builds/slave/test/build/tests 12:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:13 INFO - trying https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 12:03:13 INFO - Downloading https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 12:03:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 12:03:14 INFO - Downloaded 1165 bytes. 12:03:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 12:03:14 INFO - Using the following test package requirements: 12:03:14 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 12:03:14 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 12:03:14 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 12:03:14 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:03:14 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 12:03:14 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 12:03:14 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 12:03:14 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 12:03:14 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 12:03:14 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 12:03:14 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 12:03:14 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 12:03:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 12:03:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 12:03:14 INFO - Fetch https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 12:03:15 INFO - Expected file size: 16108239 12:03:15 INFO - Obtained file size: 16108239 12:03:22 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:03:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 12:03:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 12:03:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 12:03:23 INFO - Expected file size: 16108239 12:03:23 INFO - Obtained file size: 16108239 12:03:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 12:03:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 12:03:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 12:03:30 INFO - Expected file size: 14403663 12:03:30 INFO - Obtained file size: 14403663 12:03:30 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')]} 12:03:30 INFO - trying https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 12:03:30 INFO - Downloading https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 12:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 12:03:32 INFO - Downloaded 58731883 bytes. 12:03:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 12:03:32 INFO - mkdir: /builds/slave/test/properties 12:03:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:03:32 INFO - Writing to file /builds/slave/test/properties/build_url 12:03:32 INFO - Contents: 12:03:32 INFO - build_url:https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 12:03:33 INFO - Running post-action listener: _resource_record_post_action 12:03:33 INFO - Running post-action listener: set_extra_try_arguments 12:03:33 INFO - [mozharness: 2017-03-24 19:03:33.379734Z] Finished download-and-extract step (success) 12:03:33 INFO - [mozharness: 2017-03-24 19:03:33.379854Z] Running populate-webroot step. 12:03:33 INFO - Running pre-action listener: _resource_record_pre_action 12:03:33 INFO - Running main action method: populate_webroot 12:03:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:03:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:03:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:03:33 INFO - '--tppagecycles', 12:03:33 INFO - '7'], 12:03:33 INFO - 'tests': ['tsvgm']}}, 12:03:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:03:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:03:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:03:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:03:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['damp', 'tps']}, 12:03:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'tests': ['damp', 'tps']}, 12:03:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['dromaeo_dom']}, 12:03:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:03:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['basic_compositor_video']}, 12:03:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:03:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'other-e10s': {'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['a11yr', 12:03:33 INFO - 'ts_paint', 12:03:33 INFO - 'tpaint', 12:03:33 INFO - 'sessionrestore', 12:03:33 INFO - 'sessionrestore_no_auto_restore', 12:03:33 INFO - 'tabpaint']}, 12:03:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['tsvgx', 12:03:33 INFO - 'tsvgr_opacity', 12:03:33 INFO - 'tart', 12:03:33 INFO - 'tscrollx', 12:03:33 INFO - 'cart', 12:03:33 INFO - 'tsvg_static']}, 12:03:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:03:33 INFO - 'tsvgr_opacity', 12:03:33 INFO - 'tart', 12:03:33 INFO - 'tscrollx', 12:03:33 INFO - 'cart', 12:03:33 INFO - 'tsvg_static']}, 12:03:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'talos_options': ['--disable-e10s'], 12:03:33 INFO - 'tests': ['tp5o']}, 12:03:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:03:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'talos_options': ['--disable-e10s', 12:03:33 INFO - '--xperf_path', 12:03:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:33 INFO - 'tests': ['tp5n']}, 12:03:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:03:33 INFO - 'talos_options': ['--xperf_path', 12:03:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:33 INFO - 'tests': ['tp5n']}}, 12:03:33 INFO - 'talos.zip': {'path': '', 12:03:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:03:33 INFO - Running post-action listener: _resource_record_post_action 12:03:33 INFO - [mozharness: 2017-03-24 19:03:33.398493Z] Finished populate-webroot step (success) 12:03:33 INFO - [mozharness: 2017-03-24 19:03:33.398635Z] Running create-virtualenv step. 12:03:33 INFO - Running pre-action listener: _resource_record_pre_action 12:03:33 INFO - Running main action method: create_virtualenv 12:03:33 INFO - Creating virtualenv /builds/slave/test/build/venv 12:03:33 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 12:03:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:03:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:03:33 INFO - Using real prefix '/tools/python27' 12:03:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:03:34 INFO - Installing distribute.............................................................................................................................................................................................done. 12:03:37 INFO - Installing pip.................done. 12:03:37 INFO - Return code: 0 12:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:03:37 INFO - Reading from file tmpfile_stdout 12:03:37 INFO - Output received: 12:03:37 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) 12:03:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:37 INFO - 'HOME': '/Users/cltbld', 12:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:37 INFO - 'LOGNAME': 'cltbld', 12:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:37 INFO - 'MOZ_NO_REMOTE': '1', 12:03:37 INFO - 'NO_EM_RESTART': '1', 12:03:37 INFO - 'PAGER': '/bin/cat', 12:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:37 INFO - 'PWD': '/builds/slave/test', 12:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:37 INFO - 'SHELL': '/bin/bash', 12:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:37 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:37 INFO - 'USER': 'cltbld', 12:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:37 INFO - 'XPC_FLAGS': '0x0', 12:03:37 INFO - 'XPC_SERVICE_NAME': '0', 12:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:37 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 12:03:37 INFO - Cleaning up... 12:03:37 INFO - Return code: 0 12:03:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:37 INFO - 'HOME': '/Users/cltbld', 12:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:37 INFO - 'LOGNAME': 'cltbld', 12:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:37 INFO - 'MOZ_NO_REMOTE': '1', 12:03:37 INFO - 'NO_EM_RESTART': '1', 12:03:37 INFO - 'PAGER': '/bin/cat', 12:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:37 INFO - 'PWD': '/builds/slave/test', 12:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:37 INFO - 'SHELL': '/bin/bash', 12:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:37 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:37 INFO - 'USER': 'cltbld', 12:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:37 INFO - 'XPC_FLAGS': '0x0', 12:03:37 INFO - 'XPC_SERVICE_NAME': '0', 12:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:37 INFO - Downloading/unpacking psutil>=3.1.1 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:41 INFO - Installing collected packages: psutil 12:03:41 INFO - Running setup.py install for psutil 12:03:41 INFO - building 'psutil._psutil_osx' extension 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 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 12:03:41 INFO - building 'psutil._psutil_posix' extension 12:03:41 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 12:03:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:03:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:03:41 INFO - ^ 12:03:42 INFO - 1 warning generated. 12:03:42 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 12:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:42 INFO - Successfully installed psutil 12:03:42 INFO - Cleaning up... 12:03:42 INFO - Return code: 0 12:03:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:42 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:42 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 12:03:42 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 12:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:42 INFO - 'HOME': '/Users/cltbld', 12:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:42 INFO - 'LOGNAME': 'cltbld', 12:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:42 INFO - 'MOZ_NO_REMOTE': '1', 12:03:42 INFO - 'NO_EM_RESTART': '1', 12:03:42 INFO - 'PAGER': '/bin/cat', 12:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:42 INFO - 'PWD': '/builds/slave/test', 12:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:42 INFO - 'SHELL': '/bin/bash', 12:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:42 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:42 INFO - 'USER': 'cltbld', 12:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:42 INFO - 'XPC_FLAGS': '0x0', 12:03:42 INFO - 'XPC_SERVICE_NAME': '0', 12:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:03:42 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 12:03:42 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 12:03:42 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 12:03:42 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 12:03:42 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 12:03:42 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 12:03:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:03:45 INFO - Installing collected packages: mozsystemmonitor 12:03:45 INFO - Running setup.py install for mozsystemmonitor 12:03:45 INFO - Successfully installed mozsystemmonitor 12:03:45 INFO - Cleaning up... 12:03:45 INFO - Return code: 0 12:03:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:03: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')]} 12:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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')]} 12:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03: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==2.5.1'] in /builds/slave/test/build 12:03: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==2.5.1 12:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:45 INFO - 'HOME': '/Users/cltbld', 12:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:45 INFO - 'LOGNAME': 'cltbld', 12:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:45 INFO - 'MOZ_NO_REMOTE': '1', 12:03:45 INFO - 'NO_EM_RESTART': '1', 12:03:45 INFO - 'PAGER': '/bin/cat', 12:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:45 INFO - 'PWD': '/builds/slave/test', 12:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:45 INFO - 'SHELL': '/bin/bash', 12:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:45 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:45 INFO - 'USER': 'cltbld', 12:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:45 INFO - 'XPC_FLAGS': '0x0', 12:03:45 INFO - 'XPC_SERVICE_NAME': '0', 12:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:45 INFO - Downloading/unpacking jsonschema==2.5.1 12:03:45 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 12:03:45 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 12:03:45 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 12:03:45 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 12:03:45 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 12:03:45 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 12:03:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:03:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:03:48 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 12:03:48 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 12:03:48 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 12:03:48 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 12:03:48 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 12:03:48 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 12:03:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:03:48 INFO - warning: no files found matching '*.txt' 12:03:48 INFO - no previously-included directories found matching 'build' 12:03:48 INFO - no previously-included directories found matching 'dist' 12:03:48 INFO - no previously-included directories found matching '.git*' 12:03:48 INFO - Installing collected packages: jsonschema, functools32 12:03:48 INFO - Running setup.py install for functools32 12:03:48 INFO - warning: no files found matching '*.txt' 12:03:48 INFO - no previously-included directories found matching 'build' 12:03:48 INFO - no previously-included directories found matching 'dist' 12:03:48 INFO - no previously-included directories found matching '.git*' 12:03:48 INFO - Successfully installed jsonschema functools32 12:03:48 INFO - Cleaning up... 12:03:48 INFO - Return code: 0 12:03:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:48 INFO - 'HOME': '/Users/cltbld', 12:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:48 INFO - 'LOGNAME': 'cltbld', 12:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:48 INFO - 'MOZ_NO_REMOTE': '1', 12:03:48 INFO - 'NO_EM_RESTART': '1', 12:03:48 INFO - 'PAGER': '/bin/cat', 12:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:49 INFO - 'PWD': '/builds/slave/test', 12:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:49 INFO - 'SHELL': '/bin/bash', 12:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:49 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:49 INFO - 'USER': 'cltbld', 12:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:49 INFO - 'XPC_FLAGS': '0x0', 12:03:49 INFO - 'XPC_SERVICE_NAME': '0', 12:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:03:49 INFO - Cleaning up... 12:03:49 INFO - Return code: 0 12:03:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:49 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:49 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 12:03:49 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 12:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:49 INFO - 'HOME': '/Users/cltbld', 12:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:49 INFO - 'LOGNAME': 'cltbld', 12:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:49 INFO - 'MOZ_NO_REMOTE': '1', 12:03:49 INFO - 'NO_EM_RESTART': '1', 12:03:49 INFO - 'PAGER': '/bin/cat', 12:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:49 INFO - 'PWD': '/builds/slave/test', 12:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:49 INFO - 'SHELL': '/bin/bash', 12:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:49 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:49 INFO - 'USER': 'cltbld', 12:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:49 INFO - 'XPC_FLAGS': '0x0', 12:03:49 INFO - 'XPC_SERVICE_NAME': '0', 12:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:03:49 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 12:03:49 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 12:03:49 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 12:03:49 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 12:03:49 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 12:03:49 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 12:03:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:03:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:03:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:52 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 12:03:53 INFO - Downloading docopt-0.6.1.tar.gz 12:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:03:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:03:53 INFO - Running setup.py install for blobuploader 12:03:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:03:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:03:53 INFO - Running setup.py install for requests 12:03:54 INFO - Running setup.py install for docopt 12:03:54 INFO - Successfully installed blobuploader requests docopt 12:03:54 INFO - Cleaning up... 12:03:54 INFO - Return code: 0 12:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:54 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:54 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 12:03:54 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 12:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:54 INFO - 'HOME': '/Users/cltbld', 12:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:54 INFO - 'LOGNAME': 'cltbld', 12:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:54 INFO - 'MOZ_NO_REMOTE': '1', 12:03:54 INFO - 'NO_EM_RESTART': '1', 12:03:54 INFO - 'PAGER': '/bin/cat', 12:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:54 INFO - 'PWD': '/builds/slave/test', 12:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:54 INFO - 'SHELL': '/bin/bash', 12:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:54 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:54 INFO - 'USER': 'cltbld', 12:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:54 INFO - 'XPC_FLAGS': '0x0', 12:03:54 INFO - 'XPC_SERVICE_NAME': '0', 12:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-lPJWx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rTmcs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BWm_cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7RQYPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gEg4Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BaJCBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-134mrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-s9akRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-2ZsccC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SxBarl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YgifKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-M3vOeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-64cvHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:55 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SVFekX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:56 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-JQkCil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:56 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-XakliF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:56 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hYNp_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:03:56 INFO - Running setup.py install for manifestparser 12:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:56 INFO - Running setup.py install for mozcrash 12:03:56 INFO - Running setup.py install for mozdebug 12:03:56 INFO - Running setup.py install for mozdevice 12:03:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:56 INFO - Running setup.py install for mozfile 12:03:57 INFO - Running setup.py install for mozhttpd 12:03:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Running setup.py install for mozinfo 12:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Running setup.py install for mozInstall 12:03:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Running setup.py install for mozleak 12:03:57 INFO - Running setup.py install for mozlog 12:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:57 INFO - Running setup.py install for moznetwork 12:03:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Running setup.py install for mozprocess 12:03:58 INFO - Running setup.py install for mozprofile 12:03:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Running setup.py install for mozrunner 12:03:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Running setup.py install for mozscreenshot 12:03:58 INFO - Running setup.py install for moztest 12:03:58 INFO - Running setup.py install for mozversion 12:03:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:58 INFO - Cleaning up... 12:03:58 INFO - Return code: 0 12:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:58 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')]} 12:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:58 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')]} 12:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:58 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:03:58 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 12:03:58 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 12:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:58 INFO - 'HOME': '/Users/cltbld', 12:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:58 INFO - 'LOGNAME': 'cltbld', 12:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:58 INFO - 'MOZ_NO_REMOTE': '1', 12:03:58 INFO - 'NO_EM_RESTART': '1', 12:03:58 INFO - 'PAGER': '/bin/cat', 12:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:58 INFO - 'PWD': '/builds/slave/test', 12:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:58 INFO - 'SHELL': '/bin/bash', 12:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:03:58 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:58 INFO - 'USER': 'cltbld', 12:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:58 INFO - 'XPC_FLAGS': '0x0', 12:03:58 INFO - 'XPC_SERVICE_NAME': '0', 12:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-_z2bE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-B5w3d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hkEzX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-h1DNov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-bBF5bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7OCF5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-DRAlt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:59 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)) 12:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-5lteeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AOFPMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-k0iST9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-N0qE7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-txCeWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mxvRvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ABhbg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-V74sPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ETDytu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:04:00 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)) 12:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:04:00 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-oZsvm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:04:01 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)) 12:04:01 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)) 12:04:01 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)) 12:04:01 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)) 12:04:01 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)) 12:04:01 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)) 12:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:04:01 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 12:04:01 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 12:04:01 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 12:04:01 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 12:04:01 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 12:04:01 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 12:04:03 INFO - Downloading blessings-1.6.tar.gz 12:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:04:03 INFO - Installing collected packages: blessings 12:04:03 INFO - Running setup.py install for blessings 12:04:03 INFO - Successfully installed blessings 12:04:03 INFO - Cleaning up... 12:04:04 INFO - Return code: 0 12:04:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:04:04 INFO - Reading from file tmpfile_stdout 12:04:04 INFO - Current package versions: 12:04:04 INFO - blessings == 1.6 12:04:04 INFO - blobuploader == 1.2.4 12:04:04 INFO - docopt == 0.6.1 12:04:04 INFO - functools32 == 3.2.3-2 12:04:04 INFO - jsonschema == 2.5.1 12:04:04 INFO - manifestparser == 1.1 12:04:04 INFO - mozInstall == 1.12 12:04:04 INFO - mozcrash == 1.0 12:04:04 INFO - mozdebug == 0.1 12:04:04 INFO - mozdevice == 0.49 12:04:04 INFO - mozfile == 1.2 12:04:04 INFO - mozhttpd == 0.7 12:04:04 INFO - mozinfo == 0.9 12:04:04 INFO - mozleak == 0.1 12:04:04 INFO - mozlog == 3.4 12:04:04 INFO - moznetwork == 0.27 12:04:04 INFO - mozprocess == 0.24 12:04:04 INFO - mozprofile == 0.28 12:04:04 INFO - mozrunner == 6.13 12:04:04 INFO - mozscreenshot == 0.1 12:04:04 INFO - mozsystemmonitor == 0.3 12:04:04 INFO - moztest == 0.8 12:04:04 INFO - mozversion == 1.4 12:04:04 INFO - psutil == 3.1.1 12:04:04 INFO - requests == 1.2.3 12:04:04 INFO - wsgiref == 0.1.2 12:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:04:04 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')]} 12:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:04:04 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')]} 12:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:04:04 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:04:04 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 12:04:04 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 12:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:04:04 INFO - 'HOME': '/Users/cltbld', 12:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:04:04 INFO - 'LOGNAME': 'cltbld', 12:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:04 INFO - 'MOZ_NO_REMOTE': '1', 12:04:04 INFO - 'NO_EM_RESTART': '1', 12:04:04 INFO - 'PAGER': '/bin/cat', 12:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:04 INFO - 'PWD': '/builds/slave/test', 12:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:04:04 INFO - 'SHELL': '/bin/bash', 12:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:04:04 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:04:04 INFO - 'USER': 'cltbld', 12:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:04 INFO - 'XPC_FLAGS': '0x0', 12:04:04 INFO - 'XPC_SERVICE_NAME': '0', 12:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 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)) 12:04:04 INFO - Cleaning up... 12:04:04 INFO - Return code: 0 12:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:04:04 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')]} 12:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:04:04 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')]} 12:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:04:04 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 0x10aebeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aec1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8595d3050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, '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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 12:04:04 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 12:04:04 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 12:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:04:04 INFO - 'HOME': '/Users/cltbld', 12:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:04:04 INFO - 'LOGNAME': 'cltbld', 12:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:04 INFO - 'MOZ_NO_REMOTE': '1', 12:04:04 INFO - 'NO_EM_RESTART': '1', 12:04:04 INFO - 'PAGER': '/bin/cat', 12:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:04 INFO - 'PWD': '/builds/slave/test', 12:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:04:04 INFO - 'SHELL': '/bin/bash', 12:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:04:04 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:04:04 INFO - 'USER': 'cltbld', 12:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:04 INFO - 'XPC_FLAGS': '0x0', 12:04:04 INFO - 'XPC_SERVICE_NAME': '0', 12:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:04:04 INFO - Cleaning up... 12:04:04 INFO - Return code: 0 12:04:04 INFO - Running post-action listener: _resource_record_post_action 12:04:04 INFO - Running post-action listener: _start_resource_monitoring 12:04:04 INFO - Starting resource monitoring. 12:04:04 INFO - [mozharness: 2017-03-24 19:04:04.862504Z] Finished create-virtualenv step (success) 12:04:04 INFO - [mozharness: 2017-03-24 19:04:04.863478Z] Running install step. 12:04:04 INFO - Running pre-action listener: _resource_record_pre_action 12:04:04 INFO - Running main action method: install 12:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:04:05 INFO - Reading from file tmpfile_stdout 12:04:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:04:05 INFO - Reading from file tmpfile_stdout 12:04:05 INFO - Output received: 12:04:05 INFO - Usage: mozinstall [options] installer 12:04:05 INFO - Options: 12:04:05 INFO - -h, --help show this help message and exit 12:04:05 INFO - -d DEST, --destination=DEST 12:04:05 INFO - Directory to install application into. [default: 12:04:05 INFO - "/builds/slave/test"] 12:04:05 INFO - --app=APP Application being installed. [default: firefox] 12:04:05 INFO - mkdir: /builds/slave/test/build/application 12:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:04:19 INFO - Reading from file tmpfile_stdout 12:04:19 INFO - Output received: 12:04:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:04:19 INFO - Running post-action listener: _resource_record_post_action 12:04:19 INFO - [mozharness: 2017-03-24 19:04:19.960649Z] Finished install step (success) 12:04:19 INFO - [mozharness: 2017-03-24 19:04:19.960777Z] Running run-tests step. 12:04:19 INFO - Running pre-action listener: _resource_record_pre_action 12:04:19 INFO - Running main action method: run_tests 12:04:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:04:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:04:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:04:19 INFO - 2017-03-24 12:04:19.975 screenresolution[2149:18687] starting screenresolution argv=screenresolution get 12:04:19 INFO - 2017-03-24 12:04:19.978 screenresolution[2149:18687] Display 0: 1600x1200x32@60 12:04:19 INFO - 2017-03-24 12:04:19.983 screenresolution[2150:18689] starting screenresolution argv=screenresolution list 12:04:19 INFO - Available Modes on Display 0 12:04:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:04:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:04:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:04:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:04:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:04:20 INFO - Intel Iris: 12:04:20 INFO - Chipset Model: Intel Iris 12:04:20 INFO - Type: GPU 12:04:20 INFO - Bus: Built-In 12:04:20 INFO - VRAM (Dynamic, Max): 1536 MB 12:04:20 INFO - Vendor: Intel (0x8086) 12:04:20 INFO - Device ID: 0x0a2e 12:04:20 INFO - Revision ID: 0x0009 12:04:20 INFO - Displays: 12:04:20 INFO - Display: 12:04:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:04:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:04:20 INFO - Display Serial Number: 1600x1200 60 12:04:20 INFO - Main Display: Yes 12:04:20 INFO - Mirror: Off 12:04:20 INFO - Online: Yes 12:04:20 INFO - Rotation: Supported 12:04:20 INFO - Return code: 0 12:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:04:20 INFO - Python 2.7.3 12:04:20 INFO - Return code: 0 12:04:20 INFO - grabbing minidump binary from tooltool 12:04:20 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')]} 12:04:20 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 0x10ac9cd30>, '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 0x10abc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac91be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:04:20 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 12:04:20 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 12:04:20 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 12:04:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:04:20 INFO - Return code: 0 12:04:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:04:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:04:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:04:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:04:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 12:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 12:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwIWvDHv6Y/Render', 12:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:04:20 INFO - 'HOME': '/Users/cltbld', 12:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:04:20 INFO - 'LOGNAME': 'cltbld', 12:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:04:20 INFO - 'MOZ_NO_REMOTE': '1', 12:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:04:20 INFO - 'NO_EM_RESTART': '1', 12:04:20 INFO - 'PAGER': '/bin/cat', 12:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:04:20 INFO - 'PWD': '/builds/slave/test', 12:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:04:20 INFO - 'SHELL': '/bin/bash', 12:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsG4zqx1fj/Listeners', 12:04:20 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 12:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:04:20 INFO - 'USER': 'cltbld', 12:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:04:20 INFO - 'XPC_FLAGS': '0x0', 12:04:20 INFO - 'XPC_SERVICE_NAME': '0', 12:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:04:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 12:04:20 INFO - mozversion application_buildid: 20170324102715 12:04:20 INFO - mozversion application_changeset: 3ae80b40ca579dcfbda891794da475bb67ab6eb3 12:04:20 INFO - mozversion application_display_name: Firefox 12:04:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:04:20 INFO - mozversion application_name: Firefox 12:04:20 INFO - mozversion application_remotingname: firefox 12:04:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:04:20 INFO - mozversion application_vendor: Mozilla 12:04:20 INFO - mozversion application_version: 53.0 12:04:20 INFO - mozversion platform_buildid: 20170324102715 12:04:20 INFO - mozversion platform_changeset: 3ae80b40ca579dcfbda891794da475bb67ab6eb3 12:04:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:04:20 INFO - mozversion platform_version: 53.0 12:04:20 INFO - using testdate: 1490382260 12:04:20 INFO - actual date: 1490382260 12:04:20 INFO - starting webserver on 'localhost:54361' 12:04:20 INFO - SUITE-START | Running 2 tests 12:04:20 INFO - TEST-START | dromaeo_css 12:04:20 INFO - operating with platform_type : mac_ 12:04:20 INFO - Initialising browser for dromaeo_css test... 12:04:20 INFO - TEST-INFO | started process 2160 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpx9UTl3/profile http://localhost:54361/getInfo.html) 12:04:23 INFO - PROCESS | 2160 | 2017-03-24 12:04:23.368 plugin-container[2163:18837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f47, name = 'com.apple.tsm.portname' 12:04:23 INFO - PROCESS | 2160 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:23 INFO - PROCESS | 2160 | 2017-03-24 12:04:23.368 plugin-container[2163:18837] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d13, name = 'com.apple.CFPasteboardClient' 12:04:23 INFO - PROCESS | 2160 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:23 INFO - PROCESS | 2160 | 2017-03-24 12:04:23.368 plugin-container[2163:18837] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:04:23 INFO - PROCESS | 2160 | __metrics Screen width/height:1600/1200 12:04:23 INFO - PROCESS | 2160 | colorDepth:24 12:04:23 INFO - PROCESS | 2160 | Browser inner width/height: 1024/689 12:04:23 INFO - PROCESS | 2160 | __metrics 12:04:23 ERROR - PROCESS | 2160 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 12:04:24 INFO - TEST-INFO | 2160: exit 0 12:04:24 INFO - Browser initialized. 12:04:24 INFO - Running cycle 1/1 for dromaeo_css test... 12:04:24 INFO - TEST-INFO | started process 2164 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpx9UTl3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:26 INFO - PROCESS | 2164 | 2017-03-24 12:04:26.374 plugin-container[2165:18966] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 12:04:26 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:26 INFO - PROCESS | 2164 | 2017-03-24 12:04:26.374 plugin-container[2165:18966] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 12:04:26 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:04:26 INFO - PROCESS | 2164 | 2017-03-24 12:04:26.374 plugin-container[2165:18966] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:04:36 INFO - PROCESS | 2164 | RSS: Main: 173019136 12:04:36 INFO - PROCESS | 2164 | 12:07:38 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54361/tests/dromaeo/cssquery-ext.html) 12:07:40 INFO - PROCESS | 2164 | RSS: Main: 191737856 12:07:40 INFO - PROCESS | 2164 | 12:10:42 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-ext.html (next: http://localhost:54361/tests/dromaeo/cssquery-jquery.html) 12:10:43 INFO - PROCESS | 2164 | RSS: Main: 201928704 12:10:43 INFO - PROCESS | 2164 | 12:13:44 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54361/tests/dromaeo/cssquery-mootools.html) 12:13:45 INFO - PROCESS | 2164 | RSS: Main: 203644928 12:13:45 INFO - PROCESS | 2164 | 12:16:47 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54361/tests/dromaeo/cssquery-prototype.html) 12:16:47 INFO - PROCESS | 2164 | RSS: Main: 206716928 12:16:47 INFO - PROCESS | 2164 | 12:19:50 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54361/tests/dromaeo/cssquery-yui.html) 12:19:51 INFO - PROCESS | 2164 | RSS: Main: 207863808 12:19:51 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | Cycle 1(1): loaded http://localhost:54361/tests/dromaeo/cssquery-yui.html (next: http://localhost:54361/tests/dromaeo/cssquery-dojo.html) 12:22:54 INFO - PROCESS | 2164 | RSS: Main: 207925248 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | __start_tp_report 12:22:54 INFO - PROCESS | 2164 | _x_x_mozilla_page_load 12:22:54 INFO - PROCESS | 2164 | _x_x_mozilla_page_load_details 12:22:54 INFO - PROCESS | 2164 | |i|pagename|runs| 12:22:54 INFO - PROCESS | 2164 | |0;dojo.html;3101.503759398496;3570.5001299818014;3584.838682259299;3593.9281214375696;3595.1731101846576;6054;6108.419700128481;6125.663088530129;6126.908096378558;6150.261968563773;6105.481034112106;6172.783952561661;6192.690365481731;6216.285127210373;6216.595921265114;5397.217403476494;5460.34475862895;5462;5475.0966090595;5529.557635389159;5507.394186639466;5533.920885427343;5537.944620553803;5539.639923404986;5566.2207290979295;5350.571954243651;5362.544183744387;5512.724363781815;5517.641353312042;5519.889602207953;5363.007843548937;5381.838544843661;5415.241866138744;5444.972775136139;5494.780208791643;5346.732663366855;5463.535599474049;5478.45215478453;5490.286262785812;5502.394736579013;5924.911126333109;6077.118817771443;6133.478654314388;6189.412005859436;6213.161223234851;6279.623222606612;6297.685115744241;6319.715612797435;6339.778107766252;6443.097966284724;4814.940713043125;6478.481721462272;6503.642299673516;6541.869162616768;6547.214334279917;6208.379162083801;6227.09707092469;6248.1564988726395;6259.248890133168;6267.341929097379;5421.322334708161;6375.2987171411105;6379;6481.611103333815;6502.44729198014;6290.905636415458;6336.651484168323;6344.714487848058;6350;6366.618002919747;5484.533814625722;6455.096286519891;6483.286838447767;6487.935120648733;6499.967500162469;6272.247330320391;6288.717007734663;6301.338359472281;6336.493080553637;6351.618902865843;6381.202349706286;6407.903881441782;6469.094326794253;6471.9029214561815;6493.058506516529;5206.140986737221;5233.869153271123;5235.3717553893775;5239.29269548606;5290.444503327095;4558.8632341029825;4568.17772800899;4630.6063984561015;4652.674312798139;4673.836415725501;6123.326434092246;6147;6209.2548894133;6239.812805615838;6263.812085637438;6485.44873685742;6489.935100649028;6502.057201705821;6506.869862602722;6524.706388212447;5037.874053148701;6109.131392049051;6145.016797312409;6180.938190618126;6213.068039794067;5754.56840736938;5756.7121643917635;5765.596408251382;5777.0467872801355;5801.767929282866;6621.205455345389;6689.09697190873;6699.497537684693;6714.060031595581;6723.058771772054;6302.684865756602;6363.331850155852;6411.775587854403;6439.710213040518;6480.805575832733;6701.865962680817;6717.429018533479;6718.160229971254;6719.932800671931;6728.798136055926;6404.775832845828;6408.61548307103;6422.454091402283;6452.257990330984;6453.548251622341;5851.6541195526115;6285.465735412358;6334.3665633436285;6476.514261430318;6509.414152726277;6188.257409110935;6210.937890621036;6348.301686814539;6359.459445946961;6362.618242905441;6268.2478102626155;6300.21247344082;6312.589681670676;6313.1792866928845;6315.747370105144;6208.627482351073;6217.875642487215;6222.968885155546;6263.498920086473;6305.495560355253;5084.3898732152375;5280.6303558750515;6224.875502490016;6274.341194174546;6296.811095667137;6291.402316779899;6309.842253943688;6310.148130002391;6312.684365781601;6314.242290925118 12:22:54 INFO - PROCESS | 2164 | |1;ext.html;480.6755440077949;508.8525375278746;518.4323166133084;532.2202972645076;532.5845840244608;37865.62134378655;41622.37566436502;41624.16751664972;41661.58338416615;41771.37342939858;43215.567844321544;43953.02211400487;43959.56040439603;43989.560104398945;43995.78002109985;9478.763030924212;9724.611015559405;9743.707688769313;11436.828447573293;11829.40852957353;11625.418729063513;11695;11711.472983715754;11744.823827642549;11749.882501175007;11608.825867611951;11689.12331575131;11711.5900943467;11746.29522228669;11771.587994420197;11504.884951150465;11643.767124657501;11678.591249306275;11710;11730.35483048432;11512.88487115135;11549.53801847925;11622.593209237637;11652.30086194831;11678.883211167864;37414.8129259352;37448.62551374506;37590.43614345787;37645.870623881325;37655.4351684725;4046.372812214082;4064.735792173529;4081.4490043844;4152.626263636287;4155.31437312843;28290.575641365394;28303.292417689518;28323.150305490868;29875.70124298751;30209.848950755324;3138.0115263691864;3333.4999750037446;3471.3230919970615;3474.5656792900886;3486.9825650871835;453037;455497;456326;458810;459374.9999999967;59425.702871485366;59695;59907.70046149829;59930;60173.699131504065;61256.77486450246;61420.692896535234;61472.38527614756;61574.92125393802;61639;16201.108939008467;16658.33366665344;16704.164791760362;16766.497005089866;16870.409535666193;11859.762804743857;12252.81620775689;12620.747585048248;12917.160384574972;12929.741405171844;14590;16225.701943844464;18224.08879556017;18489.7226541602;18776.906115469334;7635.541867487857;8307.08622051574;8332.208440198172;8349.206825351583;8352.457090289112;901.1574178143456;901.7024381953939;907.0974380491454;929.0616477357783;937.1659223291276;27113.1866044019;30585.694143058285;31121.8443907779;31432;31511.212219694233;1045.5974449836715;1053.2942928238099;1055.8574592430077;1146.9541218351173;1241.7702724995904;14422.495212667507;14721.263936803118;14864.182469964257;14880.62798430048;14882.553523394316;676903;682503;686718;687660;688515;52667;52901;53077.7346113267;53219.73390133025;53253.73373133109;1219.6584956212275;1469.8456662050544;1494.671172342083;1503.616577772661;1504.375684091112;19833.50416239548;27383.178504644893;27800.860995694893;28275.858620706764;28546.714532854407;46813;47366;47376.52623473859;47435.52564474449;47505;596394;599962;600012;600095;601148;24562.385940351633;24722.629160562246;24759.62860557129;26226.475470490866;26943.461130776883;42595;44161.33757993697;44492.77753611211;44718.77640611776;45212;30178.69821301759;30466;35587.644123558435;36268;37291.88124356273;30479;36211;36523.452148218326;37412.43881341837;37493.87518374453;35714.821425892704;35904.10239744027;36374.09064773402;36512.634873650924;36562.26875462422;31197.688023119477;32669.673303266663;32689;32726.836365818017;32821;24286.14998475045;24528;24685.87657061775;24769.50460990734;24778.00887964461 12:22:54 INFO - PROCESS | 2164 | |2;jquery.html;358.4855732024545;368.4087040300318;393.6122918924857;404.62369995903805;412.5750477008682;20383.898080509596;21757.45606359838;22004;22166.224182153626;22367.66448503274;22306.107755689754;22511.212107576237;22523.662145067796;22625.886870565664;22649.320520384415;6022.277326720789;6160.630362178261;6184.505239580845;6235.563510554263;6260.624362538262;6094.756209751605;6105.71779926216;6129.356417576158;6146.600470969395;6247.468965137969;6139.416755408229;6151.384861513858;6163.2604087509335;6164.815055548318;6174.289956654998;5970.940290597082;6059.7273122709585;6111.236095488064;6148.231471066117;6159.538034647375;4709;5245.186996015624;5377.978184145;5391.433899440542;5393.6763794172475;26758;26842.865785671143;27048.323791905164;27052.864735676194;27235.591466128022;2583.844969301848;2757.241758516404;2794.944101117966;3225.951610725841;3229.54786329914;10257.538410771533;10374.688759337232;10419.270651054429;10571.471426428649;10687.30532515384;1604.6630207656406;1795.524186090687;1897.2885168061978;1903.7620297462818;1943.057617055727;141433;144635;146741;147504.78742818974;148690.0687070581;12125.878741212651;12195.41459610245;12279.631611051684;12372.505099796088;12540.310282934526;15889.68220635604;16053.598660033593;16076.919615402083;16091.954022988468;16257.374262573885;7449.925500744923;8831.735047948572;9216.400933939272;9326.580303886341;9356.625734970661;8246.546439945741;8332.375071869634;9018.909810901938;9024;9182.540872956326;4306.93390413182;4807.807687692453;4860.3681521401995;4918.631102667314;4999.125153098194;2058.6706127019606;2097.0039231365286;2110.271956175148;2114.228306668055;2114.904829282686;894.6019021535484;1038.7299302181486;1040.95836166554;1046.6493724602192;1057.8201705710048;21916.342509724735;22244.443888902908;22247.998840052238;22253.332400028026;22292.331230063122;1054.7995880782628;1069.3370110531364;1085.2511766880984;1113.6380676280241;1114.7324642086003;8336.333093352518;10136.18754742604;10139;11389.829152562717;11703.356315402734;677601;796403;801243;807226;815640.921795399;165211.17394412952;166598;168840;169158;170003.14998425177;939.628846605587;1089.1395797320188;1142.1034487926938;1143.2854465958776;1147.6212849759559;20497.692534611695;20788.792112078685;20938.0577873993;21053;21123.26068587592;62172.756544867945;64274;64329;64520;64792;94009.5299523498;94807;94814.52592737268;95572.52213738886;98176;7450.739224127129;8364.916350836656;8507.064222935349;8607.311415086653;8675.609597568251;10307.94846025795;12918.870811291767;13421.32893355348;13474.93262533681;13495.865041349462;10092.747681308027;11231.606893758679;11332.716682083013;11496.48265828023;11914.166008379678;11274.267172634081;11523.596674116367;11589.884101159218;11660.358680272666;11979.04167666602;11440.542378304775;11715.1799374043;11940.10449216295;12139.696507587381;12192.817107743214;8412.579371031547;8565.186307300797;8633.266172375419;8752.431091979255;8757.693480728143;9333.439993600407;11375.715607109889;11523.942380288045;11618.535258589562;11706.00498957564 12:22:54 INFO - PROCESS | 2164 | |3;mootools.html;1436.942522299108;1475.5130806833745;1477.8152730908637;1490.210188600042;1493.634059655384;7754.534727916329;8021.879671804928;8274.213949674779;8678.696245631396;8688.869666955;8156.755297341075;8492.405531612789;8492.66029358825;8568.228859402652;8580.313574914007;2351.5532048910695;2385.8329916905823;2403.471236328005;2403.5433267679086;2404.519096180762;1958.7453631027947;2161.3407910587266;2394.389430695179;2420.6490058941445;2472.2336075816556;2386.8304530779965;2390.2829151254555;2390.964135537968;2425.0663494554547;2426.0780903256828;2362.0669835414915;2396.928092157238;2396.9640455393182;2426.0417135231573;2435.987820060906;2101.821345185661;2408.0608562660577;2420.9757902420924;2431.3070774829266;2437.8902949367143;6982.685779139951;8524.8721269181;8564.400491965565;8586.398952073358;8592.5703714814;5209.973950130263;5290.497402746733;5342.492463215988;5359.705216213107;5380.273663055476;3502.2295095079044;3551.325248202859;3598.6581274779114;3649.087728067983;3676.2279921216577;1231.132051903415;1231.445849367788;1266.949322027118;1294.4175121195406;1299.1944994103717;10899.618513351994;10979.780404391868;11022;11023.724406889813;11035.944820275927;4484.2376795944765;4757.643176761688;4799;4829.082474329936;4839.2983017462975;9506.762330941643;9599.232061435068;9672.56473458696;9685.128338449573;9698.951505242429;5411.864703382447;5415.810446634349;5454.863628409322;5456.127019676912;5501.284832971688;4078.715204710507;4442.111577684412;4569.109023740405;4929.038837426668;4991.67554108989;3918.686505079587;3979.621935916083;4014.2172276406404;4089.2230476209425;4138.586141385837;1323.4573824731813;1334.1061488802525;1334.4728832111261;1335.7261761338902;1343.7581235377727;927.8886533615874;939.2063706168277;943.9669611563562;954.1984732824461;994.3685759542742;5583.581231407661;5619.971900140473;5653.660780353192;5713.457221563945;5918.644881307136;573.3406582430156;575.7581815637442;592.9288485381695;594.2123715015716;594.9702514874239;3797.6012518685693;3804.9809750951067;3853.7687738735203;3882.5535063467496;3912.765234085964;8421.747347579583;9722.61109555624;9915.30592858493;10230.130438912627;10283.12593429567;10093.798124037477;10167.796644067077;10222.488875556193;10236.48817559119;10249.94875025635;7975.2423519765525;8017.759467215993;8063.911371964827;8066.7579972600915;8071.919280807234;5541.861453463695;5578.832635020955;5590.776368945197;5808.767649293981;5823.359430462561;9341.019192984639;9347.252219822534;9367.953160234156;9445.763855903382;9454.763630909283;9328;9454.480003599592;9460.385074970105;9485.193758530602;9606.807863842823;7143;7266.564006159648;7299.927000729925;7384.741534046282;7448.255174482509;7397.816349384073;7469.141048779243;8120.187981201832;8128.227818357246;8144.185581441809;6943.548669336477;7138.607376594337;7283.635818209174;7284.053073100463;7302.123745150403;7060.258672839278;7138.107736532934;7165.713371465083;7253.492255542062;7266.7093316266755;6489.772857949949;6492;6572.671366431755;6573.638449885302;6591.538592298493;4899.363082799213;4936;5014.314478857964;5053.2420136979745;5186.559142472781;4487.439070116236;5057.165567681292;5101.642884998015;5308.362996440452;5357.946420535901 12:22:54 INFO - PROCESS | 2164 | |4;prototype.html;332.3187465695325;365.31868066056796;372.29264397644465;380.1200221487255;385.6182379444349;4696.624270058395;5042.1428357179275;5276.261323414725;5432.891342173154;5668.404817494165;4813.855584332467;4979.327790748248;5438.15708565173;5475.616706830523;5505.201745746865;3568.50040994261;3867.477890484791;4129.2360913231;4354.325079612665;4372.453443319585;3427.263138425238;3482.9129271768156;3917.784521851297;4372.491490435795;4421.0494743630115;3417.316536692659;4121.866486716147;4134.875953721393;4153.169366126772;4179.1432756284885;4142.316517774563;4167.229062623409;4170.4152422079715;4176.853810116631;4231.661467082626;3624.2026754114054;3627.6553727395853;3635.8727444539577;3636.799976001319;3649.288388764192;5232.92150617741;5283.471652834724;5315.963387139509;5376.354837419495;5420.674759514442;4789.712617242976;4806.807727690888;4821.4696383397795;4828.806847726087;4832.565069143794;5609.411011843738;5811.198528456192;5839.562032847553;5856.092305692582;5869;3629.0564453242346;3929.5677475477673;3972.9006774830573;4000.6999475039197;4000.9399859002137;5378.596605254583;5416.781224224518;6098.08528720691;6179.3202747697715;6183.96908015457;4031.778252196157;4039.4546736190237;4040.3939409088284;4067.186562687474;4068.247374235776;3256.5929258842643;3575.8557261676533;3631.7457777955287;3929.548101968253;4002.9199416011515;4782.880427989328;4786;4792.353032340659;4814.301926220678;4855.174620314555;4708.976455117771;5608.411116832755;5633.661980281115;5946.57282252265;5948.375420580776;1026.338011982282;1185.549491193341;1190.6487586162102;1213.6541085790507;1337.5920344294889;862.4092496639822;882.3250213586612;896.0546623312468;900.428228075177;904.7647611621026;4452.376667266585;4876.439209490883;5037.617272972538;5221.347331583552;5381.946180538144;5239.873427213168;5339.813106541253;5363.865903352447;5390.029794636925;5653.65373370055;4347.913041739147;4568.817247310137;5184.137817326041;5211.1922651989;5316.680999140064;2598.5712357460807;2805.621241132421;2812.356384998095;2852.9714702852707;3024.9243768905953;5141.922871156936;5347.705876176769;5656.925184214986;6033.276006879202;6039.184710064173;5466.098093814556;5675.73900774287;5816.534677225812;5906.379830117861;5951.9702401488585;5294.293994204149;5347.51872331492;5375.59683023767;5719.714014299351;5962.195103661037;5178.844634660966;5583.497485226187;5614.606977511535;5734.684592347461;5824.737886795019;4708.576228139484;5259.947400525945;5343.706096164593;5449.700266485382;5693.572982026281;5965.284165899946;6002.279726432856;6018.187544681412;6022.337542870193;6114.877702445837;3275.5741753571883;3750.718696097749;3853.094522787199;3868.883933482;3887.5334959805004;4780.5219478053305;5063.772130254221;5433.402325744244;5571.303587051619;5586.88262347524;4472.284434490596;5550.446794474587;5712.714364281853;5746.793173433626;5869.886840737246;5779.913301300568;5842.444967728059;5874.911876321773;5879.353271140086;5888.821136179641;4772.141014617263;5697.3448053474385;5760.798372056958;5777.566682498746;5792.623479473821;5891.734871930687;5895.322037965518;5922.230110085661;5935.347111817783;5935.664475492979;4672.976635116803;5038.319826823478;5351.839444816662;5403.648762830403;5766.769329226951 12:22:54 INFO - PROCESS | 2164 | |5;yui.html;736.0982796074805;737.8339873528457;780.2041917244411;865.2213008292538;865.3380164174407;15095.24523773811;15474.61313467164;15983.600409989756;16119.355225790969;16134.354625814982;14743.852561474381;14932.208135023786;14963.251837408114;15073.547793566184;15115.697686046273;877.2674816528206;880.2517859819167;906.632813710445;907.2061945797427;909.3634455880876;711.7331000874672;737.0308044920938;881.2509367037999;900.6802585082299;902.2015516268084;942.4486675294961;951.1107114847605;954.4941181173954;956.1060408518023;956.3879117364892;913.6208473483497;935.3826474526813;938.8779458670398;945.6453829813786;947.6114792934898;690.8031211104811;701.487913822907;706.7844307486215;710.9502334836563;712.2379054411781;15946.122963237018;16290.592735181715;16438;16537.751933721003;16585.83414165855;15172.620684482976;15315.846841531666;15447.691046179014;15546.300416481285;15557.611059723598;11914.523419063227;12025.278483291031;12028.731587275468;12118.697032574168;12161.844624760633;3836.1943991761764;3873.593272706353;3882.1265215326607;3896.610338966109;3933.449317095609;98161;98254.52618210732;103086.48456757743;113284;113587;11065.944670276758;11338.546458141582;11424.428778561205;11839.28964262147;11971.042316614825;23457.648135277985;23673.7632623675;23720.169794057125;23778.286651400485;23798.048078076685;8242.505449672919;8261;8282.792930176794;8415.495070295801;8435.072142064368;3475.0443628002504;4193.224253513049;4222.19778242133;4331.306990881444;4435.622972047412;3732;3747.569029561581;3812.5615554211067;3839.0786211309087;3846.653801157853;685.2975699907635;691.1844024051567;695.5096656857005;699.909011828459;702.8699690557263;513.2224679610393;567.5743192605546;595.7348979704077;596.5496050481859;605.1890466774455;8023.558704271321;9132.954335228282;9888.901110988942;10007.349522281029;10337.492839174016;709.1808960650457;712.9251428600026;732.7252280394852;733.9211359301818;745.4558172533972;4892.51074892515;5166.81916132941;5180.8963820723375;5183.844484665466;5200.92198617021;112878;115477;116481;118631;120074.79925200636;97175.02824971802;97422.5128874351;98584.50707746559;99505;99706;66370;81741.9999999988;82410.58794705987;83528;84939;9039.54802259889;9488;9969.900300996896;10067.949660251652;10162.339447935861;46826.765866171816;53457.4654253468;54864;56862.431375685715;59896.40103599083;74603.89497045022;74891;75287;76932;77962;11420;11774.411279436164;11880.04959603247;11937.940310298392;11979.880201198224;13119.001823744647;13503.932480337928;13539.526116585872;14129.717405652034;14145.787813182606;12118;12418.463376985583;12574.748505030031;12675.30285834288;13023.153495022792;12250.509979601073;12663.556775512812;12763;12940.352982351033;13050.15174013686;11745;12078.154529182873;12094.334811585448;12159.75680486403;12184.20802647825;9920.319516750887;10486.947565262124;10649;11021;11068.335899846035;8706.434081784664;9078.319126065704;9705.951470242604;9733.221342292742;9749.317547771872 12:22:54 INFO - PROCESS | 2164 | __end_tp_report 12:22:54 INFO - PROCESS | 2164 | __start_cc_report 12:22:54 INFO - PROCESS | 2164 | _x_x_mozilla_cycle_collect,380 12:22:54 INFO - PROCESS | 2164 | __end_cc_report 12:22:54 INFO - PROCESS | 2164 | __startTimestamp1490383374375__endTimestamp 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | ------- Summary: start ------- 12:22:54 INFO - PROCESS | 2164 | Number of tests: 6 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#0] dojo.html Cycles:165 Average:5980.41 Median:6239.81 stddev:666.38 (10.7%) stddev-sans-first:629.00 12:22:54 INFO - PROCESS | 2164 | Values: 3101.5 3570.5 3584.8 3593.9 3595.2 6054.0 6108.4 6125.7 6126.9 6150.3 6105.5 6172.8 6192.7 6216.3 6216.6 5397.2 5460.3 5462.0 5475.1 5529.6 5507.4 5533.9 5537.9 5539.6 5566.2 5350.6 5362.5 5512.7 5517.6 5519.9 5363.0 5381.8 5415.2 5445.0 5494.8 5346.7 5463.5 5478.5 5490.3 5502.4 5924.9 6077.1 6133.5 6189.4 6213.2 6279.6 6297.7 6319.7 6339.8 6443.1 4814.9 6478.5 6503.6 6541.9 6547.2 6208.4 6227.1 6248.2 6259.2 6267.3 5421.3 6375.3 6379.0 6481.6 6502.4 6290.9 6336.7 6344.7 6350.0 6366.6 5484.5 6455.1 6483.3 6487.9 6500.0 6272.2 6288.7 6301.3 6336.5 6351.6 6381.2 6407.9 6469.1 6471.9 6493.1 5206.1 5233.9 5235.4 5239.3 5290.4 4558.9 4568.2 4630.6 4652.7 4673.8 6123.3 6147.0 6209.3 6239.8 6263.8 6485.4 6489.9 6502.1 6506.9 6524.7 5037.9 6109.1 6145.0 6180.9 6213.1 5754.6 5756.7 5765.6 5777.0 5801.8 6621.2 6689.1 6699.5 6714.1 6723.1 6302.7 6363.3 6411.8 6439.7 6480.8 6701.9 6717.4 6718.2 6719.9 6728.8 6404.8 6408.6 6422.5 6452.3 6453.5 5851.7 6285.5 6334.4 6476.5 6509.4 6188.3 6210.9 6348.3 6359.5 6362.6 6268.2 6300.2 6312.6 6313.2 6315.7 6208.6 6217.9 6223.0 6263.5 6305.5 5084.4 5280.6 6224.9 6274.3 6296.8 6291.4 6309.8 6310.1 6312.7 6314.2 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#1] ext.html Cycles:180 Average:70573.82 Median:35651.23 stddev:157381.78 (441.4%) stddev-sans-first:157735.29 12:22:54 INFO - PROCESS | 2164 | Values: 480.7 508.9 518.4 532.2 532.6 37865.6 41622.4 41624.2 41661.6 41771.4 43215.6 43953.0 43959.6 43989.6 43995.8 9478.8 9724.6 9743.7 11436.8 11829.4 11625.4 11695.0 11711.5 11744.8 11749.9 11608.8 11689.1 11711.6 11746.3 11771.6 11504.9 11643.8 11678.6 11710.0 11730.4 11512.9 11549.5 11622.6 11652.3 11678.9 37414.8 37448.6 37590.4 37645.9 37655.4 4046.4 4064.7 4081.4 4152.6 4155.3 28290.6 28303.3 28323.2 29875.7 30209.8 3138.0 3333.5 3471.3 3474.6 3487.0 453037.0 455497.0 456326.0 458810.0 459375.0 59425.7 59695.0 59907.7 59930.0 60173.7 61256.8 61420.7 61472.4 61574.9 61639.0 16201.1 16658.3 16704.2 16766.5 16870.4 11859.8 12252.8 12620.7 12917.2 12929.7 14590.0 16225.7 18224.1 18489.7 18776.9 7635.5 8307.1 8332.2 8349.2 8352.5 901.2 901.7 907.1 929.1 937.2 27113.2 30585.7 31121.8 31432.0 31511.2 1045.6 1053.3 1055.9 1147.0 1241.8 14422.5 14721.3 14864.2 14880.6 14882.6 676903.0 682503.0 686718.0 687660.0 688515.0 52667.0 52901.0 53077.7 53219.7 53253.7 1219.7 1469.8 1494.7 1503.6 1504.4 19833.5 27383.2 27800.9 28275.9 28546.7 46813.0 47366.0 47376.5 47435.5 47505.0 596394.0 599962.0 600012.0 600095.0 601148.0 24562.4 24722.6 24759.6 26226.5 26943.5 42595.0 44161.3 44492.8 44718.8 45212.0 30178.7 30466.0 35587.6 36268.0 37291.9 30479.0 36211.0 36523.5 37412.4 37493.9 35714.8 35904.1 36374.1 36512.6 36562.3 31197.7 32669.7 32689.0 32726.8 32821.0 24286.1 24528.0 24685.9 24769.5 24778.0 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#2] jquery.html Cycles:180 Average:43179.34 Median:22336.89 stddev:130587.97 (584.6%) stddev-sans-first:130914.72 12:22:54 INFO - PROCESS | 2164 | Values: 358.5 368.4 393.6 404.6 412.6 20383.9 21757.5 22004.0 22166.2 22367.7 22306.1 22511.2 22523.7 22625.9 22649.3 6022.3 6160.6 6184.5 6235.6 6260.6 6094.8 6105.7 6129.4 6146.6 6247.5 6139.4 6151.4 6163.3 6164.8 6174.3 5970.9 6059.7 6111.2 6148.2 6159.5 4709.0 5245.2 5378.0 5391.4 5393.7 26758.0 26842.9 27048.3 27052.9 27235.6 2583.8 2757.2 2794.9 3226.0 3229.5 10257.5 10374.7 10419.3 10571.5 10687.3 1604.7 1795.5 1897.3 1903.8 1943.1 141433.0 144635.0 146741.0 147504.8 148690.1 12125.9 12195.4 12279.6 12372.5 12540.3 15889.7 16053.6 16076.9 16092.0 16257.4 7449.9 8831.7 9216.4 9326.6 9356.6 8246.5 8332.4 9018.9 9024.0 9182.5 4306.9 4807.8 4860.4 4918.6 4999.1 2058.7 2097.0 2110.3 2114.2 2114.9 894.6 1038.7 1041.0 1046.6 1057.8 21916.3 22244.4 22248.0 22253.3 22292.3 1054.8 1069.3 1085.3 1113.6 1114.7 8336.3 10136.2 10139.0 11389.8 11703.4 677601.0 796403.0 801243.0 807226.0 815640.9 165211.2 166598.0 168840.0 169158.0 170003.1 939.6 1089.1 1142.1 1143.3 1147.6 20497.7 20788.8 20938.1 21053.0 21123.3 62172.8 64274.0 64329.0 64520.0 64792.0 94009.5 94807.0 94814.5 95572.5 98176.0 7450.7 8364.9 8507.1 8607.3 8675.6 10307.9 12918.9 13421.3 13474.9 13495.9 10092.7 11231.6 11332.7 11496.5 11914.2 11274.3 11523.6 11589.9 11660.4 11979.0 11440.5 11715.2 11940.1 12139.7 12192.8 8412.6 8565.2 8633.3 8752.4 8757.7 9333.4 11375.7 11523.9 11618.5 11706.0 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#3] mootools.html Cycles:180 Average:5527.07 Median:5369.99 stddev:2995.86 (55.8%) stddev-sans-first:2988.50 12:22:54 INFO - PROCESS | 2164 | Values: 1436.9 1475.5 1477.8 1490.2 1493.6 7754.5 8021.9 8274.2 8678.7 8688.9 8156.8 8492.4 8492.7 8568.2 8580.3 2351.6 2385.8 2403.5 2403.5 2404.5 1958.7 2161.3 2394.4 2420.6 2472.2 2386.8 2390.3 2391.0 2425.1 2426.1 2362.1 2396.9 2397.0 2426.0 2436.0 2101.8 2408.1 2421.0 2431.3 2437.9 6982.7 8524.9 8564.4 8586.4 8592.6 5210.0 5290.5 5342.5 5359.7 5380.3 3502.2 3551.3 3598.7 3649.1 3676.2 1231.1 1231.4 1266.9 1294.4 1299.2 10899.6 10979.8 11022.0 11023.7 11035.9 4484.2 4757.6 4799.0 4829.1 4839.3 9506.8 9599.2 9672.6 9685.1 9699.0 5411.9 5415.8 5454.9 5456.1 5501.3 4078.7 4442.1 4569.1 4929.0 4991.7 3918.7 3979.6 4014.2 4089.2 4138.6 1323.5 1334.1 1334.5 1335.7 1343.8 927.9 939.2 944.0 954.2 994.4 5583.6 5620.0 5653.7 5713.5 5918.6 573.3 575.8 592.9 594.2 595.0 3797.6 3805.0 3853.8 3882.6 3912.8 8421.7 9722.6 9915.3 10230.1 10283.1 10093.8 10167.8 10222.5 10236.5 10249.9 7975.2 8017.8 8063.9 8066.8 8071.9 5541.9 5578.8 5590.8 5808.8 5823.4 9341.0 9347.3 9368.0 9445.8 9454.8 9328.0 9454.5 9460.4 9485.2 9606.8 7143.0 7266.6 7299.9 7384.7 7448.3 7397.8 7469.1 8120.2 8128.2 8144.2 6943.5 7138.6 7283.6 7284.1 7302.1 7060.3 7138.1 7165.7 7253.5 7266.7 6489.8 6492.0 6572.7 6573.6 6591.5 4899.4 4936.0 5014.3 5053.2 5186.6 4487.4 5057.2 5101.6 5308.4 5357.9 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#4] prototype.html Cycles:180 Average:4598.80 Median:5216.27 stddev:1422.33 (27.3%) stddev-sans-first:1389.80 12:22:54 INFO - PROCESS | 2164 | Values: 332.3 365.3 372.3 380.1 385.6 4696.6 5042.1 5276.3 5432.9 5668.4 4813.9 4979.3 5438.2 5475.6 5505.2 3568.5 3867.5 4129.2 4354.3 4372.5 3427.3 3482.9 3917.8 4372.5 4421.0 3417.3 4121.9 4134.9 4153.2 4179.1 4142.3 4167.2 4170.4 4176.9 4231.7 3624.2 3627.7 3635.9 3636.8 3649.3 5232.9 5283.5 5316.0 5376.4 5420.7 4789.7 4806.8 4821.5 4828.8 4832.6 5609.4 5811.2 5839.6 5856.1 5869.0 3629.1 3929.6 3972.9 4000.7 4000.9 5378.6 5416.8 6098.1 6179.3 6184.0 4031.8 4039.5 4040.4 4067.2 4068.2 3256.6 3575.9 3631.7 3929.5 4002.9 4782.9 4786.0 4792.4 4814.3 4855.2 4709.0 5608.4 5633.7 5946.6 5948.4 1026.3 1185.5 1190.6 1213.7 1337.6 862.4 882.3 896.1 900.4 904.8 4452.4 4876.4 5037.6 5221.3 5381.9 5239.9 5339.8 5363.9 5390.0 5653.7 4347.9 4568.8 5184.1 5211.2 5316.7 2598.6 2805.6 2812.4 2853.0 3024.9 5141.9 5347.7 5656.9 6033.3 6039.2 5466.1 5675.7 5816.5 5906.4 5952.0 5294.3 5347.5 5375.6 5719.7 5962.2 5178.8 5583.5 5614.6 5734.7 5824.7 4708.6 5259.9 5343.7 5449.7 5693.6 5965.3 6002.3 6018.2 6022.3 6114.9 3275.6 3750.7 3853.1 3868.9 3887.5 4780.5 5063.8 5433.4 5571.3 5586.9 4472.3 5550.4 5712.7 5746.8 5869.9 5779.9 5842.4 5874.9 5879.4 5888.8 4772.1 5697.3 5760.8 5777.6 5792.6 5891.7 5895.3 5922.2 5935.3 5935.7 4673.0 5038.3 5351.8 5403.6 5766.8 12:22:54 INFO - PROCESS | 2164 | 12:22:54 INFO - PROCESS | 2164 | [#5] yui.html Cycles:180 Average:21521.92 Median:25631.19 stddev:31747.99 (123.9%) stddev-sans-first:31798.69 12:22:54 INFO - PROCESS | 2164 | Values: 736.1 737.8 780.2 865.2 865.3 15095.2 15474.6 15983.6 16119.4 16134.4 14743.9 14932.2 14963.3 15073.5 15115.7 877.3 880.3 906.6 907.2 909.4 711.7 737.0 881.3 900.7 902.2 942.4 951.1 954.5 956.1 956.4 913.6 935.4 938.9 945.6 947.6 690.8 701.5 706.8 711.0 712.2 15946.1 16290.6 16438.0 16537.8 16585.8 15172.6 15315.8 15447.7 15546.3 15557.6 11914.5 12025.3 12028.7 12118.7 12161.8 3836.2 3873.6 3882.1 3896.6 3933.4 98161.0 98254.5 103086.5 113284.0 113587.0 11065.9 11338.5 11424.4 11839.3 11971.0 23457.6 23673.8 23720.2 23778.3 23798.0 8242.5 8261.0 8282.8 8415.5 8435.1 3475.0 4193.2 4222.2 4331.3 4435.6 3732.0 3747.6 3812.6 3839.1 3846.7 685.3 691.2 695.5 699.9 702.9 513.2 567.6 595.7 596.5 605.2 8023.6 9133.0 9888.9 10007.3 10337.5 709.2 712.9 732.7 733.9 745.5 4892.5 5166.8 5180.9 5183.8 5200.9 112878.0 115477.0 116481.0 118631.0 120074.8 97175.0 97422.5 98584.5 99505.0 99706.0 66370.0 81742.0 82410.6 83528.0 84939.0 9039.5 9488.0 9969.9 10067.9 10162.3 46826.8 53457.5 54864.0 56862.4 59896.4 74603.9 74891.0 75287.0 76932.0 77962.0 11420.0 11774.4 11880.0 11937.9 11979.9 13119.0 13503.9 13539.5 14129.7 14145.8 12118.0 12418.5 12574.7 12675.3 13023.2 12250.5 12663.6 12763.0 12940.4 13050.2 11745.0 12078.2 12094.3 12159.8 12184.2 9920.3 10486.9 10649.0 11021.0 11068.3 8706.4 9078.3 9706.0 9733.2 9749.3 12:22:54 INFO - PROCESS | 2164 | -------- Summary: end -------- 12:22:54 INFO - PROCESS | 2164 | 12:22:55 INFO - TEST-INFO | 2164: exit 0 12:22:55 INFO - TEST-OK | dromaeo_css | took 1114467ms 12:22:55 INFO - TEST-START | kraken 12:22:55 INFO - operating with platform_type : mac_ 12:22:55 INFO - Initialising browser for kraken test... 12:22:55 INFO - TEST-INFO | started process 2171 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpm7luq2/profile http://localhost:54361/getInfo.html) 12:22:57 INFO - PROCESS | 2171 | 2017-03-24 12:22:57.778 plugin-container[2173:20874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884f, name = 'com.apple.tsm.portname' 12:22:57 INFO - PROCESS | 2171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:57 INFO - PROCESS | 2171 | 2017-03-24 12:22:57.778 plugin-container[2173:20874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 12:22:57 INFO - PROCESS | 2171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:57 INFO - PROCESS | 2171 | 2017-03-24 12:22:57.778 plugin-container[2173:20874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:22:57 INFO - PROCESS | 2171 | __metrics Screen width/height:1600/1200 12:22:57 INFO - PROCESS | 2171 | colorDepth:24 12:22:57 INFO - PROCESS | 2171 | Browser inner width/height: 1024/689 12:22:57 INFO - PROCESS | 2171 | __metrics 12:22:57 ERROR - PROCESS | 2171 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 12:22:58 INFO - TEST-INFO | 2171: exit 0 12:22:58 INFO - Browser initialized. 12:22:58 INFO - Running cycle 1/1 for kraken test... 12:22:58 INFO - TEST-INFO | started process 2174 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpm7luq2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:23:00 INFO - PROCESS | 2174 | 2017-03-24 12:23:00.869 plugin-container[2175:21002] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 12:23:00 INFO - PROCESS | 2174 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:23:00 INFO - PROCESS | 2174 | 2017-03-24 12:23:00.870 plugin-container[2175:21002] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 12:23:00 INFO - PROCESS | 2174 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:23:00 INFO - PROCESS | 2174 | 2017-03-24 12:23:00.870 plugin-container[2175:21002] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:23:10 INFO - PROCESS | 2174 | RSS: Main: 173105152 12:23:10 INFO - PROCESS | 2174 | 12:23:13 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54361/tests/kraken/driver.html?testName=audio-beat-detection) 12:23:14 INFO - PROCESS | 2174 | RSS: Main: 185905152 12:23:14 INFO - PROCESS | 2174 | 12:23:17 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54361/tests/kraken/driver.html?testName=audio-dft) 12:23:17 INFO - PROCESS | 2174 | RSS: Main: 193994752 12:23:17 INFO - PROCESS | 2174 | 12:23:20 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54361/tests/kraken/driver.html?testName=audio-fft) 12:23:21 INFO - PROCESS | 2174 | RSS: Main: 197865472 12:23:21 INFO - PROCESS | 2174 | 12:23:23 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54361/tests/kraken/driver.html?testName=audio-oscillator) 12:23:24 INFO - PROCESS | 2174 | RSS: Main: 198774784 12:23:24 INFO - PROCESS | 2174 | 12:23:26 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:23:26 INFO - PROCESS | 2174 | RSS: Main: 199323648 12:23:26 INFO - PROCESS | 2174 | 12:23:29 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54361/tests/kraken/driver.html?testName=imaging-darkroom) 12:23:30 INFO - PROCESS | 2174 | RSS: Main: 203628544 12:23:30 INFO - PROCESS | 2174 | 12:23:33 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54361/tests/kraken/driver.html?testName=imaging-desaturate) 12:23:33 INFO - PROCESS | 2174 | RSS: Main: 204333056 12:23:33 INFO - PROCESS | 2174 | 12:23:37 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54361/tests/kraken/driver.html?testName=json-parse-financial) 12:23:37 INFO - PROCESS | 2174 | RSS: Main: 203640832 12:23:37 INFO - PROCESS | 2174 | 12:23:39 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:23:40 INFO - PROCESS | 2174 | RSS: Main: 202174464 12:23:40 INFO - PROCESS | 2174 | 12:23:41 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:23:42 INFO - PROCESS | 2174 | RSS: Main: 202207232 12:23:42 INFO - PROCESS | 2174 | 12:23:44 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:23:45 INFO - PROCESS | 2174 | RSS: Main: 202178560 12:23:45 INFO - PROCESS | 2174 | 12:23:48 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:49 INFO - PROCESS | 2174 | RSS: Main: 202530816 12:23:49 INFO - PROCESS | 2174 | 12:23:52 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:52 INFO - PROCESS | 2174 | RSS: Main: 210612224 12:23:52 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:54361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54361/tests/kraken/driver.html?testName=ai-astar) 12:23:54 INFO - PROCESS | 2174 | RSS: Main: 211906560 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | __start_tp_report 12:23:54 INFO - PROCESS | 2174 | _x_x_mozilla_page_load 12:23:54 INFO - PROCESS | 2174 | _x_x_mozilla_page_load_details 12:23:54 INFO - PROCESS | 2174 | |i|pagename|runs| 12:23:54 INFO - PROCESS | 2174 | |0;ai-astar;105;119;119;118;117;119;122;116;119;119 12:23:54 INFO - PROCESS | 2174 | |1;audio-beat-detection;142;112;110;156;144;145;142;110;131;108 12:23:54 INFO - PROCESS | 2174 | |2;audio-dft;199;195;198;201;198;198;198;195;199;200 12:23:54 INFO - PROCESS | 2174 | |3;audio-fft;73;58;60;83;59;59;59;58;72;58 12:23:54 INFO - PROCESS | 2174 | |4;audio-oscillator;67;57;82;99;103;86;113;104;106;71 12:23:54 INFO - PROCESS | 2174 | |5;imaging-gaussian-blur;89;87;88;85;90;87;88;110;90;86 12:23:54 INFO - PROCESS | 2174 | |6;imaging-darkroom;95;102;154;119;95;97;96;95;116;152 12:23:54 INFO - PROCESS | 2174 | |7;imaging-desaturate;116;113;98;93;99;147;146;113;84;151 12:23:54 INFO - PROCESS | 2174 | |8;json-parse-financial;56;48;49;57;74;72;55;59;68;96 12:23:54 INFO - PROCESS | 2174 | |9;json-stringify-tinderbox;68;77;72;80;75;75;72;60;87;94 12:23:54 INFO - PROCESS | 2174 | |10;stanford-crypto-aes;84;86;86;83;85;84;88;87;76;109 12:23:54 INFO - PROCESS | 2174 | |11;stanford-crypto-ccm;147;143;124;122;123;135;158;159;199;156 12:23:54 INFO - PROCESS | 2174 | |12;stanford-crypto-pbkdf2;170;165;166;166;169;168;168;217;227;169 12:23:54 INFO - PROCESS | 2174 | |13;stanford-crypto-sha256-iterative;65;68;67;66;69;71;88;84;85;65 12:23:54 INFO - PROCESS | 2174 | __end_tp_report 12:23:54 INFO - PROCESS | 2174 | __start_cc_report 12:23:54 INFO - PROCESS | 2174 | _x_x_mozilla_cycle_collect,938 12:23:54 INFO - PROCESS | 2174 | __end_cc_report 12:23:54 INFO - PROCESS | 2174 | __startTimestamp1490383434704__endTimestamp 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | ------- Summary: start ------- 12:23:54 INFO - PROCESS | 2174 | Number of tests: 14 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#0] ai-astar Cycles:10 Average:117.30 Median:119.00 stddev:4.60 (3.9%) stddev-sans-first:1.66 12:23:54 INFO - PROCESS | 2174 | Values: 105.0 119.0 119.0 118.0 117.0 119.0 122.0 116.0 119.0 119.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:142.00 stddev:18.24 (12.8%) stddev-sans-first:18.82 12:23:54 INFO - PROCESS | 2174 | Values: 142.0 112.0 110.0 156.0 144.0 145.0 142.0 110.0 131.0 108.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#2] audio-dft Cycles:10 Average:198.10 Median:198.50 stddev:1.91 (1.0%) stddev-sans-first:2.00 12:23:54 INFO - PROCESS | 2174 | Values: 199.0 195.0 198.0 201.0 198.0 198.0 198.0 195.0 199.0 200.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#3] audio-fft Cycles:10 Average:63.90 Median:59.50 stddev:8.85 (14.9%) stddev-sans-first:8.75 12:23:54 INFO - PROCESS | 2174 | Values: 73.0 58.0 60.0 83.0 59.0 59.0 59.0 58.0 72.0 58.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:69.00 stddev:19.08 (27.6%) stddev-sans-first:18.53 12:23:54 INFO - PROCESS | 2174 | Values: 67.0 57.0 82.0 99.0 103.0 86.0 113.0 104.0 106.0 71.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:88.00 stddev:7.21 (8.2%) stddev-sans-first:7.64 12:23:54 INFO - PROCESS | 2174 | Values: 89.0 87.0 88.0 85.0 90.0 87.0 88.0 110.0 90.0 86.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:95.00 stddev:23.28 (24.5%) stddev-sans-first:23.85 12:23:54 INFO - PROCESS | 2174 | Values: 95.0 102.0 154.0 119.0 95.0 97.0 96.0 95.0 116.0 152.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#7] imaging-desaturate Cycles:10 Average:116.00 Median:117.50 stddev:24.20 (20.6%) stddev-sans-first:25.67 12:23:54 INFO - PROCESS | 2174 | Values: 116.0 113.0 98.0 93.0 99.0 147.0 146.0 113.0 84.0 151.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:14.53 (22.9%) stddev-sans-first:15.16 12:23:54 INFO - PROCESS | 2174 | Values: 56.0 48.0 49.0 57.0 74.0 72.0 55.0 59.0 68.0 96.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#9] json-stringify-tinderbox Cycles:10 Average:76.00 Median:76.00 stddev:9.52 (12.5%) stddev-sans-first:9.65 12:23:54 INFO - PROCESS | 2174 | Values: 68.0 77.0 72.0 80.0 75.0 75.0 72.0 60.0 87.0 94.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.50 stddev:8.47 (9.9%) stddev-sans-first:8.92 12:23:54 INFO - PROCESS | 2174 | Values: 84.0 86.0 86.0 83.0 85.0 84.0 88.0 87.0 76.0 109.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:151.50 stddev:23.42 (15.5%) stddev-sans-first:24.85 12:23:54 INFO - PROCESS | 2174 | Values: 147.0 143.0 124.0 122.0 123.0 135.0 158.0 159.0 199.0 156.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:169.00 stddev:23.10 (13.7%) stddev-sans-first:24.30 12:23:54 INFO - PROCESS | 2174 | Values: 170.0 165.0 166.0 166.0 169.0 168.0 168.0 217.0 227.0 169.0 12:23:54 INFO - PROCESS | 2174 | 12:23:54 INFO - PROCESS | 2174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:70.00 stddev:9.11 (13.0%) stddev-sans-first:9.22 12:23:54 INFO - PROCESS | 2174 | Values: 65.0 68.0 67.0 66.0 69.0 71.0 88.0 84.0 85.0 65.0 12:23:54 INFO - PROCESS | 2174 | -------- Summary: end -------- 12:23:54 INFO - PROCESS | 2174 | 12:23:55 INFO - TEST-INFO | 2174: exit 0 12:23:55 INFO - TEST-OK | kraken | took 60529ms 12:23:55 INFO - SUITE-END | took 1174s 12:23:55 INFO - Completed test suite (00:19:35) 12:23:55 INFO - javascript benchmark 12:23:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7485.733293078989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.503759398496, 3570.5001299818014, 3584.838682259299, 3593.9281214375696, 3595.1731101846576, 6054.0, 6108.419700128481, 6125.663088530129, 6126.908096378558, 6150.261968563773, 6105.481034112106, 6172.783952561661, 6192.690365481731, 6216.285127210373, 6216.595921265114, 5397.217403476494, 5460.34475862895, 5462.0, 5475.0966090595, 5529.557635389159, 5507.394186639466, 5533.920885427343, 5537.944620553803, 5539.639923404986, 5566.2207290979295, 5350.571954243651, 5362.544183744387, 5512.724363781815, 5517.641353312042, 5519.889602207953, 5363.007843548937, 5381.838544843661, 5415.241866138744, 5444.972775136139, 5494.780208791643, 5346.732663366855, 5463.535599474049, 5478.45215478453, 5490.286262785812, 5502.394736579013, 5924.911126333109, 6077.118817771443, 6133.478654314388, 6189.412005859436, 6213.161223234851, 6279.623222606612, 6297.685115744241, 6319.715612797435, 6339.778107766252, 6443.097966284724, 4814.940713043125, 6478.481721462272, 6503.642299673516, 6541.869162616768, 6547.214334279917, 6208.379162083801, 6227.09707092469, 6248.1564988726395, 6259.248890133168, 6267.341929097379, 5421.322334708161, 6375.2987171411105, 6379.0, 6481.611103333815, 6502.44729198014, 6290.905636415458, 6336.651484168323, 6344.714487848058, 6350.0, 6366.618002919747, 5484.533814625722, 6455.096286519891, 6483.286838447767, 6487.935120648733, 6499.967500162469, 6272.247330320391, 6288.717007734663, 6301.338359472281, 6336.493080553637, 6351.618902865843, 6381.202349706286, 6407.903881441782, 6469.094326794253, 6471.9029214561815, 6493.058506516529, 5206.140986737221, 5233.869153271123, 5235.3717553893775, 5239.29269548606, 5290.444503327095, 4558.8632341029825, 4568.17772800899, 4630.6063984561015, 4652.674312798139, 4673.836415725501, 6123.326434092246, 6147.0, 6209.2548894133, 6239.812805615838, 6263.812085637438, 6485.44873685742, 6489.935100649028, 6502.057201705821, 6506.869862602722, 6524.706388212447, 5037.874053148701, 6109.131392049051, 6145.016797312409, 6180.938190618126, 6213.068039794067, 5754.56840736938, 5756.7121643917635, 5765.596408251382, 5777.0467872801355, 5801.767929282866, 6621.205455345389, 6689.09697190873, 6699.497537684693, 6714.060031595581, 6723.058771772054, 6302.684865756602, 6363.331850155852, 6411.775587854403, 6439.710213040518, 6480.805575832733, 6701.865962680817, 6717.429018533479, 6718.160229971254, 6719.932800671931, 6728.798136055926, 6404.775832845828, 6408.61548307103, 6422.454091402283, 6452.257990330984, 6453.548251622341, 5851.6541195526115, 6285.465735412358, 6334.3665633436285, 6476.514261430318, 6509.414152726277, 6188.257409110935, 6210.937890621036, 6348.301686814539, 6359.459445946961, 6362.618242905441, 6268.2478102626155, 6300.21247344082, 6312.589681670676, 6313.1792866928845, 6315.747370105144, 6208.627482351073, 6217.875642487215, 6222.968885155546, 6263.498920086473, 6305.495560355253, 5084.3898732152375, 5280.6303558750515, 6224.875502490016, 6274.341194174546, 6296.811095667137, 6291.402316779899, 6309.842253943688, 6310.148130002391, 6312.684365781601, 6314.242290925118], "value": 5940.032936968298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.6755440077949, 508.8525375278746, 518.4323166133084, 532.2202972645076, 532.5845840244608, 37865.62134378655, 41622.37566436502, 41624.16751664972, 41661.58338416615, 41771.37342939858, 43215.567844321544, 43953.02211400487, 43959.56040439603, 43989.560104398945, 43995.78002109985, 9478.763030924212, 9724.611015559405, 9743.707688769313, 11436.828447573293, 11829.40852957353, 11625.418729063513, 11695.0, 11711.472983715754, 11744.823827642549, 11749.882501175007, 11608.825867611951, 11689.12331575131, 11711.5900943467, 11746.29522228669, 11771.587994420197, 11504.884951150465, 11643.767124657501, 11678.591249306275, 11710.0, 11730.35483048432, 11512.88487115135, 11549.53801847925, 11622.593209237637, 11652.30086194831, 11678.883211167864, 37414.8129259352, 37448.62551374506, 37590.43614345787, 37645.870623881325, 37655.4351684725, 4046.372812214082, 4064.735792173529, 4081.4490043844, 4152.626263636287, 4155.31437312843, 28290.575641365394, 28303.292417689518, 28323.150305490868, 29875.70124298751, 30209.848950755324, 3138.0115263691864, 3333.4999750037446, 3471.3230919970615, 3474.5656792900886, 3486.9825650871835, 453037.0, 455497.0, 456326.0, 458810.0, 459374.9999999967, 59425.702871485366, 59695.0, 59907.70046149829, 59930.0, 60173.699131504065, 61256.77486450246, 61420.692896535234, 61472.38527614756, 61574.92125393802, 61639.0, 16201.108939008467, 16658.33366665344, 16704.164791760362, 16766.497005089866, 16870.409535666193, 11859.762804743857, 12252.81620775689, 12620.747585048248, 12917.160384574972, 12929.741405171844, 14590.0, 16225.701943844464, 18224.08879556017, 18489.7226541602, 18776.906115469334, 7635.541867487857, 8307.08622051574, 8332.208440198172, 8349.206825351583, 8352.457090289112, 901.1574178143456, 901.7024381953939, 907.0974380491454, 929.0616477357783, 937.1659223291276, 27113.1866044019, 30585.694143058285, 31121.8443907779, 31432.0, 31511.212219694233, 1045.5974449836715, 1053.2942928238099, 1055.8574592430077, 1146.9541218351173, 1241.7702724995904, 14422.495212667507, 14721.263936803118, 14864.182469964257, 14880.62798430048, 14882.553523394316, 676903.0, 682503.0, 686718.0, 687660.0, 688515.0, 52667.0, 52901.0, 53077.7346113267, 53219.73390133025, 53253.73373133109, 1219.6584956212275, 1469.8456662050544, 1494.671172342083, 1503.616577772661, 1504.375684091112, 19833.50416239548, 27383.178504644893, 27800.860995694893, 28275.858620706764, 28546.714532854407, 46813.0, 47366.0, 47376.52623473859, 47435.52564474449, 47505.0, 596394.0, 599962.0, 600012.0, 600095.0, 601148.0, 24562.385940351633, 24722.629160562246, 24759.62860557129, 26226.475470490866, 26943.461130776883, 42595.0, 44161.33757993697, 44492.77753611211, 44718.77640611776, 45212.0, 30178.69821301759, 30466.0, 35587.644123558435, 36268.0, 37291.88124356273, 30479.0, 36211.0, 36523.452148218326, 37412.43881341837, 37493.87518374453, 35714.821425892704, 35904.10239744027, 36374.09064773402, 36512.634873650924, 36562.26875462422, 31197.688023119477, 32669.673303266663, 32689.0, 32726.836365818017, 32821.0, 24286.14998475045, 24528.0, 24685.87657061775, 24769.50460990734, 24778.00887964461], "value": 20171.49915038198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.4855732024545, 368.4087040300318, 393.6122918924857, 404.62369995903805, 412.5750477008682, 20383.898080509596, 21757.45606359838, 22004.0, 22166.224182153626, 22367.66448503274, 22306.107755689754, 22511.212107576237, 22523.662145067796, 22625.886870565664, 22649.320520384415, 6022.277326720789, 6160.630362178261, 6184.505239580845, 6235.563510554263, 6260.624362538262, 6094.756209751605, 6105.71779926216, 6129.356417576158, 6146.600470969395, 6247.468965137969, 6139.416755408229, 6151.384861513858, 6163.2604087509335, 6164.815055548318, 6174.289956654998, 5970.940290597082, 6059.7273122709585, 6111.236095488064, 6148.231471066117, 6159.538034647375, 4709.0, 5245.186996015624, 5377.978184145, 5391.433899440542, 5393.6763794172475, 26758.0, 26842.865785671143, 27048.323791905164, 27052.864735676194, 27235.591466128022, 2583.844969301848, 2757.241758516404, 2794.944101117966, 3225.951610725841, 3229.54786329914, 10257.538410771533, 10374.688759337232, 10419.270651054429, 10571.471426428649, 10687.30532515384, 1604.6630207656406, 1795.524186090687, 1897.2885168061978, 1903.7620297462818, 1943.057617055727, 141433.0, 144635.0, 146741.0, 147504.78742818974, 148690.0687070581, 12125.878741212651, 12195.41459610245, 12279.631611051684, 12372.505099796088, 12540.310282934526, 15889.68220635604, 16053.598660033593, 16076.919615402083, 16091.954022988468, 16257.374262573885, 7449.925500744923, 8831.735047948572, 9216.400933939272, 9326.580303886341, 9356.625734970661, 8246.546439945741, 8332.375071869634, 9018.909810901938, 9024.0, 9182.540872956326, 4306.93390413182, 4807.807687692453, 4860.3681521401995, 4918.631102667314, 4999.125153098194, 2058.6706127019606, 2097.0039231365286, 2110.271956175148, 2114.228306668055, 2114.904829282686, 894.6019021535484, 1038.7299302181486, 1040.95836166554, 1046.6493724602192, 1057.8201705710048, 21916.342509724735, 22244.443888902908, 22247.998840052238, 22253.332400028026, 22292.331230063122, 1054.7995880782628, 1069.3370110531364, 1085.2511766880984, 1113.6380676280241, 1114.7324642086003, 8336.333093352518, 10136.18754742604, 10139.0, 11389.829152562717, 11703.356315402734, 677601.0, 796403.0, 801243.0, 807226.0, 815640.921795399, 165211.17394412952, 166598.0, 168840.0, 169158.0, 170003.14998425177, 939.628846605587, 1089.1395797320188, 1142.1034487926938, 1143.2854465958776, 1147.6212849759559, 20497.692534611695, 20788.792112078685, 20938.0577873993, 21053.0, 21123.26068587592, 62172.756544867945, 64274.0, 64329.0, 64520.0, 64792.0, 94009.5299523498, 94807.0, 94814.52592737268, 95572.52213738886, 98176.0, 7450.739224127129, 8364.916350836656, 8507.064222935349, 8607.311415086653, 8675.609597568251, 10307.94846025795, 12918.870811291767, 13421.32893355348, 13474.93262533681, 13495.865041349462, 10092.747681308027, 11231.606893758679, 11332.716682083013, 11496.48265828023, 11914.166008379678, 11274.267172634081, 11523.596674116367, 11589.884101159218, 11660.358680272666, 11979.04167666602, 11440.542378304775, 11715.1799374043, 11940.10449216295, 12139.696507587381, 12192.817107743214, 8412.579371031547, 8565.186307300797, 8633.266172375419, 8752.431091979255, 8757.693480728143, 9333.439993600407, 11375.715607109889, 11523.942380288045, 11618.535258589562, 11706.00498957564], "value": 10352.001309992575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.942522299108, 1475.5130806833745, 1477.8152730908637, 1490.210188600042, 1493.634059655384, 7754.534727916329, 8021.879671804928, 8274.213949674779, 8678.696245631396, 8688.869666955, 8156.755297341075, 8492.405531612789, 8492.66029358825, 8568.228859402652, 8580.313574914007, 2351.5532048910695, 2385.8329916905823, 2403.471236328005, 2403.5433267679086, 2404.519096180762, 1958.7453631027947, 2161.3407910587266, 2394.389430695179, 2420.6490058941445, 2472.2336075816556, 2386.8304530779965, 2390.2829151254555, 2390.964135537968, 2425.0663494554547, 2426.0780903256828, 2362.0669835414915, 2396.928092157238, 2396.9640455393182, 2426.0417135231573, 2435.987820060906, 2101.821345185661, 2408.0608562660577, 2420.9757902420924, 2431.3070774829266, 2437.8902949367143, 6982.685779139951, 8524.8721269181, 8564.400491965565, 8586.398952073358, 8592.5703714814, 5209.973950130263, 5290.497402746733, 5342.492463215988, 5359.705216213107, 5380.273663055476, 3502.2295095079044, 3551.325248202859, 3598.6581274779114, 3649.087728067983, 3676.2279921216577, 1231.132051903415, 1231.445849367788, 1266.949322027118, 1294.4175121195406, 1299.1944994103717, 10899.618513351994, 10979.780404391868, 11022.0, 11023.724406889813, 11035.944820275927, 4484.2376795944765, 4757.643176761688, 4799.0, 4829.082474329936, 4839.2983017462975, 9506.762330941643, 9599.232061435068, 9672.56473458696, 9685.128338449573, 9698.951505242429, 5411.864703382447, 5415.810446634349, 5454.863628409322, 5456.127019676912, 5501.284832971688, 4078.715204710507, 4442.111577684412, 4569.109023740405, 4929.038837426668, 4991.67554108989, 3918.686505079587, 3979.621935916083, 4014.2172276406404, 4089.2230476209425, 4138.586141385837, 1323.4573824731813, 1334.1061488802525, 1334.4728832111261, 1335.7261761338902, 1343.7581235377727, 927.8886533615874, 939.2063706168277, 943.9669611563562, 954.1984732824461, 994.3685759542742, 5583.581231407661, 5619.971900140473, 5653.660780353192, 5713.457221563945, 5918.644881307136, 573.3406582430156, 575.7581815637442, 592.9288485381695, 594.2123715015716, 594.9702514874239, 3797.6012518685693, 3804.9809750951067, 3853.7687738735203, 3882.5535063467496, 3912.765234085964, 8421.747347579583, 9722.61109555624, 9915.30592858493, 10230.130438912627, 10283.12593429567, 10093.798124037477, 10167.796644067077, 10222.488875556193, 10236.48817559119, 10249.94875025635, 7975.2423519765525, 8017.759467215993, 8063.911371964827, 8066.7579972600915, 8071.919280807234, 5541.861453463695, 5578.832635020955, 5590.776368945197, 5808.767649293981, 5823.359430462561, 9341.019192984639, 9347.252219822534, 9367.953160234156, 9445.763855903382, 9454.763630909283, 9328.0, 9454.480003599592, 9460.385074970105, 9485.193758530602, 9606.807863842823, 7143.0, 7266.564006159648, 7299.927000729925, 7384.741534046282, 7448.255174482509, 7397.816349384073, 7469.141048779243, 8120.187981201832, 8128.227818357246, 8144.185581441809, 6943.548669336477, 7138.607376594337, 7283.635818209174, 7284.053073100463, 7302.123745150403, 7060.258672839278, 7138.107736532934, 7165.713371465083, 7253.492255542062, 7266.7093316266755, 6489.772857949949, 6492.0, 6572.671366431755, 6573.638449885302, 6591.538592298493, 4899.363082799213, 4936.0, 5014.314478857964, 5053.2420136979745, 5186.559142472781, 4487.439070116236, 5057.165567681292, 5101.642884998015, 5308.362996440452, 5357.946420535901], "value": 4466.980997131221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3187465695325, 365.31868066056796, 372.29264397644465, 380.1200221487255, 385.6182379444349, 4696.624270058395, 5042.1428357179275, 5276.261323414725, 5432.891342173154, 5668.404817494165, 4813.855584332467, 4979.327790748248, 5438.15708565173, 5475.616706830523, 5505.201745746865, 3568.50040994261, 3867.477890484791, 4129.2360913231, 4354.325079612665, 4372.453443319585, 3427.263138425238, 3482.9129271768156, 3917.784521851297, 4372.491490435795, 4421.0494743630115, 3417.316536692659, 4121.866486716147, 4134.875953721393, 4153.169366126772, 4179.1432756284885, 4142.316517774563, 4167.229062623409, 4170.4152422079715, 4176.853810116631, 4231.661467082626, 3624.2026754114054, 3627.6553727395853, 3635.8727444539577, 3636.799976001319, 3649.288388764192, 5232.92150617741, 5283.471652834724, 5315.963387139509, 5376.354837419495, 5420.674759514442, 4789.712617242976, 4806.807727690888, 4821.4696383397795, 4828.806847726087, 4832.565069143794, 5609.411011843738, 5811.198528456192, 5839.562032847553, 5856.092305692582, 5869.0, 3629.0564453242346, 3929.5677475477673, 3972.9006774830573, 4000.6999475039197, 4000.9399859002137, 5378.596605254583, 5416.781224224518, 6098.08528720691, 6179.3202747697715, 6183.96908015457, 4031.778252196157, 4039.4546736190237, 4040.3939409088284, 4067.186562687474, 4068.247374235776, 3256.5929258842643, 3575.8557261676533, 3631.7457777955287, 3929.548101968253, 4002.9199416011515, 4782.880427989328, 4786.0, 4792.353032340659, 4814.301926220678, 4855.174620314555, 4708.976455117771, 5608.411116832755, 5633.661980281115, 5946.57282252265, 5948.375420580776, 1026.338011982282, 1185.549491193341, 1190.6487586162102, 1213.6541085790507, 1337.5920344294889, 862.4092496639822, 882.3250213586612, 896.0546623312468, 900.428228075177, 904.7647611621026, 4452.376667266585, 4876.439209490883, 5037.617272972538, 5221.347331583552, 5381.946180538144, 5239.873427213168, 5339.813106541253, 5363.865903352447, 5390.029794636925, 5653.65373370055, 4347.913041739147, 4568.817247310137, 5184.137817326041, 5211.1922651989, 5316.680999140064, 2598.5712357460807, 2805.621241132421, 2812.356384998095, 2852.9714702852707, 3024.9243768905953, 5141.922871156936, 5347.705876176769, 5656.925184214986, 6033.276006879202, 6039.184710064173, 5466.098093814556, 5675.73900774287, 5816.534677225812, 5906.379830117861, 5951.9702401488585, 5294.293994204149, 5347.51872331492, 5375.59683023767, 5719.714014299351, 5962.195103661037, 5178.844634660966, 5583.497485226187, 5614.606977511535, 5734.684592347461, 5824.737886795019, 4708.576228139484, 5259.947400525945, 5343.706096164593, 5449.700266485382, 5693.572982026281, 5965.284165899946, 6002.279726432856, 6018.187544681412, 6022.337542870193, 6114.877702445837, 3275.5741753571883, 3750.718696097749, 3853.094522787199, 3868.883933482, 3887.5334959805004, 4780.5219478053305, 5063.772130254221, 5433.402325744244, 5571.303587051619, 5586.88262347524, 4472.284434490596, 5550.446794474587, 5712.714364281853, 5746.793173433626, 5869.886840737246, 5779.913301300568, 5842.444967728059, 5874.911876321773, 5879.353271140086, 5888.821136179641, 4772.141014617263, 5697.3448053474385, 5760.798372056958, 5777.566682498746, 5792.623479473821, 5891.734871930687, 5895.322037965518, 5922.230110085661, 5935.347111817783, 5935.664475492979, 4672.976635116803, 5038.319826823478, 5351.839444816662, 5403.648762830403, 5766.769329226951], "value": 4153.473527757139, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.0982796074805, 737.8339873528457, 780.2041917244411, 865.2213008292538, 865.3380164174407, 15095.24523773811, 15474.61313467164, 15983.600409989756, 16119.355225790969, 16134.354625814982, 14743.852561474381, 14932.208135023786, 14963.251837408114, 15073.547793566184, 15115.697686046273, 877.2674816528206, 880.2517859819167, 906.632813710445, 907.2061945797427, 909.3634455880876, 711.7331000874672, 737.0308044920938, 881.2509367037999, 900.6802585082299, 902.2015516268084, 942.4486675294961, 951.1107114847605, 954.4941181173954, 956.1060408518023, 956.3879117364892, 913.6208473483497, 935.3826474526813, 938.8779458670398, 945.6453829813786, 947.6114792934898, 690.8031211104811, 701.487913822907, 706.7844307486215, 710.9502334836563, 712.2379054411781, 15946.122963237018, 16290.592735181715, 16438.0, 16537.751933721003, 16585.83414165855, 15172.620684482976, 15315.846841531666, 15447.691046179014, 15546.300416481285, 15557.611059723598, 11914.523419063227, 12025.278483291031, 12028.731587275468, 12118.697032574168, 12161.844624760633, 3836.1943991761764, 3873.593272706353, 3882.1265215326607, 3896.610338966109, 3933.449317095609, 98161.0, 98254.52618210732, 103086.48456757743, 113284.0, 113587.0, 11065.944670276758, 11338.546458141582, 11424.428778561205, 11839.28964262147, 11971.042316614825, 23457.648135277985, 23673.7632623675, 23720.169794057125, 23778.286651400485, 23798.048078076685, 8242.505449672919, 8261.0, 8282.792930176794, 8415.495070295801, 8435.072142064368, 3475.0443628002504, 4193.224253513049, 4222.19778242133, 4331.306990881444, 4435.622972047412, 3732.0, 3747.569029561581, 3812.5615554211067, 3839.0786211309087, 3846.653801157853, 685.2975699907635, 691.1844024051567, 695.5096656857005, 699.909011828459, 702.8699690557263, 513.2224679610393, 567.5743192605546, 595.7348979704077, 596.5496050481859, 605.1890466774455, 8023.558704271321, 9132.954335228282, 9888.901110988942, 10007.349522281029, 10337.492839174016, 709.1808960650457, 712.9251428600026, 732.7252280394852, 733.9211359301818, 745.4558172533972, 4892.51074892515, 5166.81916132941, 5180.8963820723375, 5183.844484665466, 5200.92198617021, 112878.0, 115477.0, 116481.0, 118631.0, 120074.79925200636, 97175.02824971802, 97422.5128874351, 98584.50707746559, 99505.0, 99706.0, 66370.0, 81741.9999999988, 82410.58794705987, 83528.0, 84939.0, 9039.54802259889, 9488.0, 9969.900300996896, 10067.949660251652, 10162.339447935861, 46826.765866171816, 53457.4654253468, 54864.0, 56862.431375685715, 59896.40103599083, 74603.89497045022, 74891.0, 75287.0, 76932.0, 77962.0, 11420.0, 11774.411279436164, 11880.04959603247, 11937.940310298392, 11979.880201198224, 13119.001823744647, 13503.932480337928, 13539.526116585872, 14129.717405652034, 14145.787813182606, 12118.0, 12418.463376985583, 12574.748505030031, 12675.30285834288, 13023.153495022792, 12250.509979601073, 12663.556775512812, 12763.0, 12940.352982351033, 13050.15174013686, 11745.0, 12078.154529182873, 12094.334811585448, 12159.75680486403, 12184.20802647825, 9920.319516750887, 10486.947565262124, 10649.0, 11021.0, 11068.335899846035, 8706.434081784664, 9078.319126065704, 9705.951470242604, 9733.221342292742, 9749.317547771872], "value": 7645.081528484841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 119.0, 118.0, 117.0, 119.0, 122.0, 116.0, 119.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 110.0, 156.0, 144.0, 145.0, 142.0, 110.0, 131.0, 108.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 198.0, 201.0, 198.0, 198.0, 198.0, 195.0, 199.0, 200.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 58.0, 60.0, 83.0, 59.0, 59.0, 59.0, 58.0, 72.0, 58.0], "value": 63.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 57.0, 82.0, 99.0, 103.0, 86.0, 113.0, 104.0, 106.0, 71.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 85.0, 90.0, 87.0, 88.0, 110.0, 90.0, 86.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 154.0, 119.0, 95.0, 97.0, 96.0, 95.0, 116.0, 152.0], "value": 112.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 98.0, 93.0, 99.0, 147.0, 146.0, 113.0, 84.0, 151.0], "value": 116.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 48.0, 49.0, 57.0, 74.0, 72.0, 55.0, 59.0, 68.0, 96.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 72.0, 80.0, 75.0, 75.0, 72.0, 60.0, 87.0, 94.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 83.0, 85.0, 84.0, 88.0, 87.0, 76.0, 109.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 143.0, 124.0, 122.0, 123.0, 135.0, 158.0, 159.0, 199.0, 156.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 166.0, 166.0, 169.0, 168.0, 168.0, 217.0, 227.0, 169.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 66.0, 69.0, 71.0, 88.0, 84.0, 85.0, 65.0], "value": 72.8, "unit": "score"}]}]} 12:23:55 INFO - Return code: 0 12:23:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:23:56 ERROR - # TBPL SUCCESS # 12:23:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:23:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:23:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:23:56 INFO - 2017-03-24 12:23:56.029 screenresolution[2179:21399] starting screenresolution argv=screenresolution get 12:23:56 INFO - 2017-03-24 12:23:56.032 screenresolution[2179:21399] Display 0: 1600x1200x32@60 12:23:56 INFO - 2017-03-24 12:23:56.038 screenresolution[2180:21402] starting screenresolution argv=screenresolution list 12:23:56 INFO - Available Modes on Display 0 12:23:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:23:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:23:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:23:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:23:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:23:56 INFO - Intel Iris: 12:23:56 INFO - Chipset Model: Intel Iris 12:23:56 INFO - Type: GPU 12:23:56 INFO - Bus: Built-In 12:23:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:23:56 INFO - Vendor: Intel (0x8086) 12:23:56 INFO - Device ID: 0x0a2e 12:23:56 INFO - Revision ID: 0x0009 12:23:56 INFO - Displays: 12:23:56 INFO - Display: 12:23:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:23:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:23:56 INFO - Display Serial Number: 1600x1200 60 12:23:56 INFO - Main Display: Yes 12:23:56 INFO - Mirror: Off 12:23:56 INFO - Online: Yes 12:23:56 INFO - Rotation: Supported 12:23:56 INFO - Return code: 0 12:23:56 INFO - Running post-action listener: _resource_record_post_action 12:23:56 INFO - [mozharness: 2017-03-24 19:23:56.271958Z] Finished run-tests step (success) 12:23:56 INFO - Running post-run listener: _resource_record_post_run 12:23:56 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 1770496; Write bytes: 421354496; Read time: 20; Write time: 1492 12:23:56 INFO - TinderboxPrint: CPU usage
54.3% 12:23:56 INFO - TinderboxPrint: I/O read bytes / time
1,770,496 / 20 12:23:56 INFO - TinderboxPrint: I/O write bytes / time
421,354,496 / 1,492 12:23:56 INFO - TinderboxPrint: CPU idle
2,176.5 (45.7%) 12:23:56 INFO - TinderboxPrint: CPU system
960.6 (20.2%) 12:23:56 INFO - TinderboxPrint: CPU user
1,624.5 (34.1%) 12:23:56 INFO - TinderboxPrint: Swap in / out
124,006,400 / 0 12:23:56 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122722816; Write bytes: 122662912; Read time: 11327; Write time: 273 12:23:56 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1631232; Write bytes: 297139200; Read time: 18; Write time: 1211 12:23:56 INFO - Running post-run listener: _upload_blobber_files 12:23:56 INFO - Blob upload gear active. 12:23:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:56 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 12:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:23:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:57 INFO - (blobuploader) - INFO - Done attempting. 12:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:58 INFO - (blobuploader) - INFO - Done attempting. 12:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:59 INFO - (blobuploader) - INFO - Done attempting. 12:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:24:02 INFO - (blobuploader) - INFO - Done attempting. 12:24:02 INFO - (blobuploader) - INFO - Iteration through files over. 12:24:02 INFO - Return code: 0 12:24:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:24:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:24:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ae5b74483e5f0a483e012e8200afd9588ae6d0eb9d38fc3b653bb990c781c8cecd7adeac3d38078ed33e2d55d40687b229497a69f3581e7d398a5577c98f4b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfb9cfe47f84b342a0bbb569a4561f978fd2f9b2676e00c57470f093e21dc49e2b7918a366abe8079797047186b4d138e75866529ac7486a2e65860dae9e6f18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c00493f875be88c96e7a33b6bbf574bf378dd02af4c2184392f7302ce15699988853bf250e5c524a78ae95ffb9b35ca36f32cc2329c948ea6080aceff3d6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13d5a6b1653b53bd98b74b85f1d8fee96fc4992cfb72efbbd27776d4b94058d6f6ed8ccacd2b739d735fa729a373a185527cc7e49c37410934f381b36a60a07b"} 12:24:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:24:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:24:02 INFO - Contents: 12:24:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ae5b74483e5f0a483e012e8200afd9588ae6d0eb9d38fc3b653bb990c781c8cecd7adeac3d38078ed33e2d55d40687b229497a69f3581e7d398a5577c98f4b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfb9cfe47f84b342a0bbb569a4561f978fd2f9b2676e00c57470f093e21dc49e2b7918a366abe8079797047186b4d138e75866529ac7486a2e65860dae9e6f18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c00493f875be88c96e7a33b6bbf574bf378dd02af4c2184392f7302ce15699988853bf250e5c524a78ae95ffb9b35ca36f32cc2329c948ea6080aceff3d6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13d5a6b1653b53bd98b74b85f1d8fee96fc4992cfb72efbbd27776d4b94058d6f6ed8ccacd2b739d735fa729a373a185527cc7e49c37410934f381b36a60a07b"} 12:24:02 INFO - Running post-run listener: copy_logs_to_upload_dir 12:24:02 INFO - Copying logs to upload dir... 12:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs 12:24:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.709858 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-24 12:24:02.144815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 12:24:02.148691) ========= 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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ae5b74483e5f0a483e012e8200afd9588ae6d0eb9d38fc3b653bb990c781c8cecd7adeac3d38078ed33e2d55d40687b229497a69f3581e7d398a5577c98f4b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfb9cfe47f84b342a0bbb569a4561f978fd2f9b2676e00c57470f093e21dc49e2b7918a366abe8079797047186b4d138e75866529ac7486a2e65860dae9e6f18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c00493f875be88c96e7a33b6bbf574bf378dd02af4c2184392f7302ce15699988853bf250e5c524a78ae95ffb9b35ca36f32cc2329c948ea6080aceff3d6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13d5a6b1653b53bd98b74b85f1d8fee96fc4992cfb72efbbd27776d4b94058d6f6ed8ccacd2b739d735fa729a373a185527cc7e49c37410934f381b36a60a07b"} build_url:https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/WZ2wbxaBRamqSWj9obVgiA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5ae5b74483e5f0a483e012e8200afd9588ae6d0eb9d38fc3b653bb990c781c8cecd7adeac3d38078ed33e2d55d40687b229497a69f3581e7d398a5577c98f4b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfb9cfe47f84b342a0bbb569a4561f978fd2f9b2676e00c57470f093e21dc49e2b7918a366abe8079797047186b4d138e75866529ac7486a2e65860dae9e6f18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73c00493f875be88c96e7a33b6bbf574bf378dd02af4c2184392f7302ce15699988853bf250e5c524a78ae95ffb9b35ca36f32cc2329c948ea6080aceff3d6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13d5a6b1653b53bd98b74b85f1d8fee96fc4992cfb72efbbd27776d4b94058d6f6ed8ccacd2b739d735fa729a373a185527cc7e49c37410934f381b36a60a07b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 12:24:02.183486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:24:02.183831) ========= 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.GwIWvDHv6Y/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.gsG4zqx1fj/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 12:24:02.232030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 12:24:02.232354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 12:24:02.232656) ========= ========= Total master_lag: 0.17 =========