builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0292 starttime: 1491600776.73 results: success (0) buildid: 20170407131422 builduid: 822f04c07d5a4e7585f7c3b897f48835 revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.730482) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.730959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.731287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.758142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.758518) ========= 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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-07 14:32:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.9M=0.001s 2017-04-07 14:32:56 (17.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.895105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.895444) ========= 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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.029654 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:56.947151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 14:32:56.947523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35c7be9c2db288d1d449e3cc586c4164d642c5fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 35c7be9c2db288d1d449e3cc586c4164d642c5fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-07 14:32:57,038 truncating revision to first 12 chars 2017-04-07 14:32:57,038 Setting DEBUG logging. 2017-04-07 14:32:57,038 attempt 1/10 2017-04-07 14:32:57,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35c7be9c2db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 14:32:59,550 unpacking tar archive at: mozilla-central-35c7be9c2db2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.796522 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 14:32:59.770647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:59.771004) ========= script_repo_revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:59.771484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:59.771754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 14:32:59.791469) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-07 14:32:59.791747) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:32:59 INFO - MultiFileLogger online at 20170407 14:32:59 in /builds/slave/test 14:32:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:59 INFO - {'append_to_log': False, 14:32:59 INFO - 'base_work_dir': '/builds/slave/test', 14:32:59 INFO - 'blob_upload_branch': 'Firefox', 14:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:59 INFO - 'branch': 'Firefox', 14:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:59 INFO - 'config_files': ('talos/mac_config.py',), 14:32:59 INFO - 'default_actions': ('clobber', 14:32:59 INFO - 'read-buildbot-config', 14:32:59 INFO - 'download-and-extract', 14:32:59 INFO - 'populate-webroot', 14:32:59 INFO - 'create-virtualenv', 14:32:59 INFO - 'install', 14:32:59 INFO - 'run-tests'), 14:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:59 INFO - 'download_minidump_stackwalk': True, 14:32:59 INFO - 'download_symbols': 'ondemand', 14:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:59 INFO - 'gecko_profile': False, 14:32:59 INFO - 'gecko_profile_interval': 0, 14:32:59 INFO - 'installer_path': 'installer.exe', 14:32:59 INFO - 'log_level': 'info', 14:32:59 INFO - 'log_name': 'talos', 14:32:59 INFO - 'log_to_console': True, 14:32:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:59 INFO - 'opt_config_files': (), 14:32:59 INFO - 'pip_index': False, 14:32:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:59 INFO - 'cmd': ('bash', 14:32:59 INFO - '-c', 14:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:59 INFO - 'enabled': True, 14:32:59 INFO - 'halt_on_failure': False, 14:32:59 INFO - 'name': 'check_screen_resolution'},), 14:32:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:59 INFO - 'cmd': ('bash', 14:32:59 INFO - '-c', 14:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:59 INFO - 'enabled': True, 14:32:59 INFO - 'halt_on_failure': False, 14:32:59 INFO - 'name': 'check_screen_resolution'},), 14:32:59 INFO - 'run_cmd_checks_enabled': True, 14:32:59 INFO - 'suite': 'dromaeojs', 14:32:59 INFO - 'system_bits': '32', 14:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:59 INFO - 'title': 't-yosemite-r7-0292', 14:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:59 INFO - 'use_talos_json': True, 14:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:59 INFO - 'work_dir': 'build'} 14:32:59 INFO - [mozharness: 2017-04-07 21:32:59.989984Z] Running clobber step. 14:32:59 INFO - Running pre-action listener: _resource_record_pre_action 14:32:59 INFO - Running main action method: clobber 14:32:59 INFO - rmtree: /builds/slave/test/build 14:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:33:02 INFO - Running post-action listener: _resource_record_post_action 14:33:02 INFO - [mozharness: 2017-04-07 21:33:02.526743Z] Finished clobber step (success) 14:33:02 INFO - [mozharness: 2017-04-07 21:33:02.526872Z] Running read-buildbot-config step. 14:33:02 INFO - Running pre-action listener: _resource_record_pre_action 14:33:02 INFO - Running main action method: read_buildbot_config 14:33:02 INFO - Using buildbot properties: 14:33:02 INFO - { 14:33:02 INFO - "project": "", 14:33:02 INFO - "product": "firefox", 14:33:02 INFO - "script_repo_revision": "production", 14:33:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:33:02 INFO - "repository": "", 14:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:33:02 INFO - "buildid": "20170407131422", 14:33:02 INFO - "pgo_build": "False", 14:33:02 INFO - "basedir": "/builds/slave/test", 14:33:02 INFO - "buildnumber": 7, 14:33:02 INFO - "slavename": "t-yosemite-r7-0292", 14:33:02 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:33:02 INFO - "platform": "yosemite_r7", 14:33:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:33:02 INFO - "branch": "mozilla-central", 14:33:02 INFO - "repo_path": "mozilla-central", 14:33:02 INFO - "revision": "35c7be9c2db288d1d449e3cc586c4164d642c5fd", 14:33:02 INFO - "stage_platform": "macosx64", 14:33:02 INFO - "builduid": "822f04c07d5a4e7585f7c3b897f48835", 14:33:02 INFO - "slavebuilddir": "test" 14:33:02 INFO - } 14:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:33:02 INFO - Running post-action listener: _resource_record_post_action 14:33:02 INFO - [mozharness: 2017-04-07 21:33:02.530273Z] Finished read-buildbot-config step (success) 14:33:02 INFO - [mozharness: 2017-04-07 21:33:02.530407Z] Running download-and-extract step. 14:33:02 INFO - Running pre-action listener: _resource_record_pre_action 14:33:02 INFO - Running main action method: download_and_extract 14:33:02 INFO - mkdir: /builds/slave/test/build/tests 14:33:02 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')]} 14:33:02 INFO - trying https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:33:03 INFO - Downloaded 1325 bytes. 14:33:03 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:33:03 INFO - Using the following test package requirements: 14:33:03 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:33:03 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:03 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:33:03 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:33:03 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'jsshell-mac.zip'], 14:33:03 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:33:03 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:33:03 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:33:03 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:33:03 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:33:03 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:33:03 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:33:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:33:05 INFO - Expected file size: 52521953 14:33:05 INFO - Obtained file size: 52521953 14:33:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:33:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:33:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:33:21 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:33:23 INFO - Expected file size: 52521953 14:33:23 INFO - Obtained file size: 52521953 14:33:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:33:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:33:38 INFO - Fetch https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:33:39 INFO - Expected file size: 14404138 14:33:39 INFO - Obtained file size: 14404138 14:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:39 INFO - trying https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:33:41 INFO - Downloaded 70935825 bytes. 14:33:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:33:41 INFO - mkdir: /builds/slave/test/properties 14:33:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:33:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:33:41 INFO - Contents: 14:33:41 INFO - build_url:https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:33:42 INFO - Running post-action listener: _resource_record_post_action 14:33:42 INFO - Running post-action listener: set_extra_try_arguments 14:33:42 INFO - [mozharness: 2017-04-07 21:33:42.632245Z] Finished download-and-extract step (success) 14:33:42 INFO - [mozharness: 2017-04-07 21:33:42.632397Z] Running populate-webroot step. 14:33:42 INFO - Running pre-action listener: _resource_record_pre_action 14:33:42 INFO - Running main action method: populate_webroot 14:33:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:33:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:33:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:33:42 INFO - '--tppagecycles', 14:33:42 INFO - '7'], 14:33:42 INFO - 'tests': ['tsvgm']}}, 14:33:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:33:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:33:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:33:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:33:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:33:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:33:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['damp', 'tps']}, 14:33:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'tests': ['damp', 'tps']}, 14:33:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['dromaeo_dom']}, 14:33:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:33:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['basic_compositor_video']}, 14:33:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:33:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['a11yr', 14:33:42 INFO - 'ts_paint', 14:33:42 INFO - 'tpaint', 14:33:42 INFO - 'sessionrestore', 14:33:42 INFO - 'sessionrestore_no_auto_restore', 14:33:42 INFO - 'tabpaint']}, 14:33:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['tsvgx', 14:33:42 INFO - 'tsvgr_opacity', 14:33:42 INFO - 'tart', 14:33:42 INFO - 'tscrollx', 14:33:42 INFO - 'cart', 14:33:42 INFO - 'tsvg_static']}, 14:33:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:33:42 INFO - 'tsvgr_opacity', 14:33:42 INFO - 'tart', 14:33:42 INFO - 'tscrollx', 14:33:42 INFO - 'cart', 14:33:42 INFO - 'tsvg_static']}, 14:33:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'talos_options': ['--disable-e10s'], 14:33:42 INFO - 'tests': ['tp5o']}, 14:33:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:33:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'talos_options': ['--disable-e10s', 14:33:42 INFO - '--xperf_path', 14:33:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:33:42 INFO - 'tests': ['tp5n']}, 14:33:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:33:42 INFO - 'talos_options': ['--xperf_path', 14:33:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:33:42 INFO - 'tests': ['tp5n']}}, 14:33:42 INFO - 'talos.zip': {'path': '', 14:33:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:33:42 INFO - Running post-action listener: _resource_record_post_action 14:33:42 INFO - [mozharness: 2017-04-07 21:33:42.650768Z] Finished populate-webroot step (success) 14:33:42 INFO - [mozharness: 2017-04-07 21:33:42.650909Z] Running create-virtualenv step. 14:33:42 INFO - Running pre-action listener: _resource_record_pre_action 14:33:42 INFO - Running main action method: create_virtualenv 14:33:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:33:42 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 14:33:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:33:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:33:42 INFO - Using real prefix '/tools/python27' 14:33:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:33:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:33:46 INFO - Installing pip.................done. 14:33:46 INFO - Return code: 0 14:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:33:46 INFO - Reading from file tmpfile_stdout 14:33:46 INFO - Output received: 14:33:46 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) 14:33:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:33:46 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')]} 14:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:46 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')]} 14:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:46 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:33:46 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 14:33:46 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 14:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:46 INFO - 'HOME': '/Users/cltbld', 14:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:46 INFO - 'LOGNAME': 'cltbld', 14:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:46 INFO - 'MOZ_NO_REMOTE': '1', 14:33:46 INFO - 'NO_EM_RESTART': '1', 14:33:46 INFO - 'PAGER': '/bin/cat', 14:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:46 INFO - 'PWD': '/builds/slave/test', 14:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:46 INFO - 'SHELL': '/bin/bash', 14:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:33:46 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:46 INFO - 'USER': 'cltbld', 14:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:46 INFO - 'XPC_FLAGS': '0x0', 14:33:46 INFO - 'XPC_SERVICE_NAME': '0', 14:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:46 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 14:33:46 INFO - Cleaning up... 14:33:46 INFO - Return code: 0 14:33:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:33:46 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')]} 14:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:46 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')]} 14:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:46 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:33:46 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 14:33:46 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 14:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:46 INFO - 'HOME': '/Users/cltbld', 14:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:46 INFO - 'LOGNAME': 'cltbld', 14:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:46 INFO - 'MOZ_NO_REMOTE': '1', 14:33:46 INFO - 'NO_EM_RESTART': '1', 14:33:46 INFO - 'PAGER': '/bin/cat', 14:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:46 INFO - 'PWD': '/builds/slave/test', 14:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:46 INFO - 'SHELL': '/bin/bash', 14:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:33:46 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:46 INFO - 'USER': 'cltbld', 14:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:46 INFO - 'XPC_FLAGS': '0x0', 14:33:46 INFO - 'XPC_SERVICE_NAME': '0', 14:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:47 INFO - Downloading/unpacking psutil>=3.1.1 14:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:33:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:50 INFO - Installing collected packages: psutil 14:33:50 INFO - Running setup.py install for psutil 14:33:50 INFO - building 'psutil._psutil_osx' extension 14:33:50 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 14:33:51 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 14:33:51 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 14:33:51 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 14:33:51 INFO - building 'psutil._psutil_posix' extension 14:33:51 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 14:33:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:33:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:33:51 INFO - ^ 14:33:51 INFO - 1 warning generated. 14:33:51 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 14:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:51 INFO - Successfully installed psutil 14:33:51 INFO - Cleaning up... 14:33:51 INFO - Return code: 0 14:33:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:52 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:33:52 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 14:33:52 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 14:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:52 INFO - 'HOME': '/Users/cltbld', 14:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:52 INFO - 'LOGNAME': 'cltbld', 14:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:52 INFO - 'MOZ_NO_REMOTE': '1', 14:33:52 INFO - 'NO_EM_RESTART': '1', 14:33:52 INFO - 'PAGER': '/bin/cat', 14:33:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:52 INFO - 'PWD': '/builds/slave/test', 14:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:52 INFO - 'SHELL': '/bin/bash', 14:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:33:52 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:52 INFO - 'USER': 'cltbld', 14:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:52 INFO - 'XPC_FLAGS': '0x0', 14:33:52 INFO - 'XPC_SERVICE_NAME': '0', 14:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33: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 14:33:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:33:56 INFO - Installing collected packages: mozsystemmonitor 14:33:56 INFO - Running setup.py install for mozsystemmonitor 14:33:56 INFO - Successfully installed mozsystemmonitor 14:33:56 INFO - Cleaning up... 14:33:56 INFO - Return code: 0 14:33:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:33:56 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')]} 14:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:56 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')]} 14:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:56 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:33:56 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 14:33:56 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 14:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:56 INFO - 'HOME': '/Users/cltbld', 14:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:56 INFO - 'LOGNAME': 'cltbld', 14:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:56 INFO - 'MOZ_NO_REMOTE': '1', 14:33:56 INFO - 'NO_EM_RESTART': '1', 14:33:56 INFO - 'PAGER': '/bin/cat', 14:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:56 INFO - 'PWD': '/builds/slave/test', 14:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:56 INFO - 'SHELL': '/bin/bash', 14:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:33:56 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:56 INFO - 'USER': 'cltbld', 14:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:56 INFO - 'XPC_FLAGS': '0x0', 14:33:56 INFO - 'XPC_SERVICE_NAME': '0', 14:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:56 INFO - Downloading/unpacking jsonschema==2.5.1 14:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:33:59 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 14:33:59 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 14:33:59 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 14:33:59 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 14:33:59 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 14:33:59 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 14:33:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:59 INFO - warning: no files found matching '*.txt' 14:33:59 INFO - no previously-included directories found matching 'build' 14:33:59 INFO - no previously-included directories found matching 'dist' 14:33:59 INFO - no previously-included directories found matching '.git*' 14:33:59 INFO - Installing collected packages: jsonschema, functools32 14:33:59 INFO - Running setup.py install for functools32 14:34:00 INFO - warning: no files found matching '*.txt' 14:34:00 INFO - no previously-included directories found matching 'build' 14:34:00 INFO - no previously-included directories found matching 'dist' 14:34:00 INFO - no previously-included directories found matching '.git*' 14:34:00 INFO - Successfully installed jsonschema functools32 14:34:00 INFO - Cleaning up... 14:34:00 INFO - Return code: 0 14:34:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:00 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:00 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 14:34:00 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 14:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:00 INFO - 'HOME': '/Users/cltbld', 14:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:00 INFO - 'LOGNAME': 'cltbld', 14:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:00 INFO - 'MOZ_NO_REMOTE': '1', 14:34:00 INFO - 'NO_EM_RESTART': '1', 14:34:00 INFO - 'PAGER': '/bin/cat', 14:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:00 INFO - 'PWD': '/builds/slave/test', 14:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:00 INFO - 'SHELL': '/bin/bash', 14:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:00 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:00 INFO - 'USER': 'cltbld', 14:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:00 INFO - 'XPC_FLAGS': '0x0', 14:34:00 INFO - 'XPC_SERVICE_NAME': '0', 14:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:34:00 INFO - Cleaning up... 14:34:00 INFO - Return code: 0 14:34:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:00 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:00 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 14:34:00 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 14:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:00 INFO - 'HOME': '/Users/cltbld', 14:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:00 INFO - 'LOGNAME': 'cltbld', 14:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:00 INFO - 'MOZ_NO_REMOTE': '1', 14:34:00 INFO - 'NO_EM_RESTART': '1', 14:34:00 INFO - 'PAGER': '/bin/cat', 14:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:00 INFO - 'PWD': '/builds/slave/test', 14:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:00 INFO - 'SHELL': '/bin/bash', 14:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:00 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:00 INFO - 'USER': 'cltbld', 14:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:00 INFO - 'XPC_FLAGS': '0x0', 14:34:00 INFO - 'XPC_SERVICE_NAME': '0', 14:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:00 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 14:34:00 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 14:34:00 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 14:34:00 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 14:34:00 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 14:34:00 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 14:34:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:03 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 14:34:03 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 14:34:03 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 14:34:03 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 14:34:03 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 14:34:03 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 14:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:04 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 14:34:04 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 14:34:04 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 14:34:04 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 14:34:04 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 14:34:04 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 14:34:04 INFO - Downloading docopt-0.6.1.tar.gz 14:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:04 INFO - Running setup.py install for blobuploader 14:34:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:04 INFO - Running setup.py install for requests 14:34:05 INFO - Running setup.py install for docopt 14:34:05 INFO - Successfully installed blobuploader requests docopt 14:34:05 INFO - Cleaning up... 14:34:05 INFO - Return code: 0 14:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:05 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')]} 14:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:05 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')]} 14:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:05 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:05 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 14:34:05 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 14:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:05 INFO - 'HOME': '/Users/cltbld', 14:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:05 INFO - 'LOGNAME': 'cltbld', 14:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:05 INFO - 'MOZ_NO_REMOTE': '1', 14:34:05 INFO - 'NO_EM_RESTART': '1', 14:34:05 INFO - 'PAGER': '/bin/cat', 14:34:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:05 INFO - 'PWD': '/builds/slave/test', 14:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:05 INFO - 'SHELL': '/bin/bash', 14:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:05 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:05 INFO - 'USER': 'cltbld', 14:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:05 INFO - 'XPC_FLAGS': '0x0', 14:34:05 INFO - 'XPC_SERVICE_NAME': '0', 14:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ls5I3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-zkoW2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-wqhv3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-7CPrJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-x4yQFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-WXERey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-cZJMZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-prQzfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Hr0qis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-62TvcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-XRTois-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:06 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-3j5vjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:07 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-W7gLcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:07 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-xNh2cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:07 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-oUbi0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:07 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hIeooH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:07 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-vcIhc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:07 INFO - Running setup.py install for manifestparser 14:34:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:07 INFO - Running setup.py install for mozcrash 14:34:07 INFO - Running setup.py install for mozdebug 14:34:08 INFO - Running setup.py install for mozdevice 14:34:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Running setup.py install for mozfile 14:34:08 INFO - Running setup.py install for mozhttpd 14:34:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Running setup.py install for mozinfo 14:34:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Running setup.py install for mozInstall 14:34:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:08 INFO - Running setup.py install for mozleak 14:34:08 INFO - Running setup.py install for mozlog 14:34:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Running setup.py install for moznetwork 14:34:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Running setup.py install for mozprocess 14:34:09 INFO - Running setup.py install for mozprofile 14:34:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Running setup.py install for mozrunner 14:34:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:09 INFO - Running setup.py install for mozscreenshot 14:34:09 INFO - Running setup.py install for moztest 14:34:09 INFO - Running setup.py install for mozversion 14:34:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:10 INFO - Cleaning up... 14:34:10 INFO - Return code: 0 14:34:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:10 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:10 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 14:34:10 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 14:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:10 INFO - 'HOME': '/Users/cltbld', 14:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:10 INFO - 'LOGNAME': 'cltbld', 14:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:10 INFO - 'MOZ_NO_REMOTE': '1', 14:34:10 INFO - 'NO_EM_RESTART': '1', 14:34:10 INFO - 'PAGER': '/bin/cat', 14:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:10 INFO - 'PWD': '/builds/slave/test', 14:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:10 INFO - 'SHELL': '/bin/bash', 14:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:10 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:10 INFO - 'USER': 'cltbld', 14:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:10 INFO - 'XPC_FLAGS': '0x0', 14:34:10 INFO - 'XPC_SERVICE_NAME': '0', 14:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-2Yx2_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:10 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)) 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ZVyVOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:10 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)) 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-5bO6_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:10 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)) 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-2eAWJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-6E6wM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:10 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)) 14:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Au5hiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-T7nxHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-tCuX7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-qap6Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-XZZZlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-J5T1ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-7nknGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JMDWSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-yC11qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:11 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)) 14:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:11 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-7FdkBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:12 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)) 14:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:12 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-3IbCFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:12 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)) 14:34:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:12 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-EPKMmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:12 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)) 14:34:12 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)) 14:34:12 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)) 14:34:12 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)) 14:34:12 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:12 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:12 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 14:34:12 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 14:34:12 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 14:34:12 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 14:34:12 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 14:34:12 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 14:34:14 INFO - Downloading blessings-1.6.tar.gz 14:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:15 INFO - Installing collected packages: blessings 14:34:15 INFO - Running setup.py install for blessings 14:34:15 INFO - Successfully installed blessings 14:34:15 INFO - Cleaning up... 14:34:15 INFO - Return code: 0 14:34:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:15 INFO - Reading from file tmpfile_stdout 14:34:15 INFO - Current package versions: 14:34:15 INFO - blessings == 1.6 14:34:15 INFO - blobuploader == 1.2.4 14:34:15 INFO - docopt == 0.6.1 14:34:15 INFO - functools32 == 3.2.3-2 14:34:15 INFO - jsonschema == 2.5.1 14:34:15 INFO - manifestparser == 1.1 14:34:15 INFO - mozInstall == 1.12 14:34:15 INFO - mozcrash == 1.0 14:34:15 INFO - mozdebug == 0.1 14:34:15 INFO - mozdevice == 0.50 14:34:15 INFO - mozfile == 1.2 14:34:15 INFO - mozhttpd == 0.7 14:34:15 INFO - mozinfo == 0.9 14:34:15 INFO - mozleak == 0.1 14:34:15 INFO - mozlog == 3.4 14:34:15 INFO - moznetwork == 0.27 14:34:15 INFO - mozprocess == 0.25 14:34:15 INFO - mozprofile == 0.28 14:34:15 INFO - mozrunner == 6.13 14:34:15 INFO - mozscreenshot == 0.1 14:34:15 INFO - mozsystemmonitor == 0.3 14:34:15 INFO - moztest == 0.8 14:34:15 INFO - mozversion == 1.4 14:34:15 INFO - psutil == 3.1.1 14:34:15 INFO - requests == 1.2.3 14:34:15 INFO - wsgiref == 0.1.2 14:34:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:15 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 14:34:15 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 14:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:15 INFO - 'HOME': '/Users/cltbld', 14:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:15 INFO - 'LOGNAME': 'cltbld', 14:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:15 INFO - 'MOZ_NO_REMOTE': '1', 14:34:15 INFO - 'NO_EM_RESTART': '1', 14:34:15 INFO - 'PAGER': '/bin/cat', 14:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:15 INFO - 'PWD': '/builds/slave/test', 14:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:15 INFO - 'SHELL': '/bin/bash', 14:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:15 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:15 INFO - 'USER': 'cltbld', 14:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:15 INFO - 'XPC_FLAGS': '0x0', 14:34:15 INFO - 'XPC_SERVICE_NAME': '0', 14:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 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)) 14:34:15 INFO - Cleaning up... 14:34:15 INFO - Return code: 0 14:34:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:15 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 0x104385b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104388768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff19b456490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, '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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 14:34:15 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 14:34:15 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 14:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:15 INFO - 'HOME': '/Users/cltbld', 14:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:15 INFO - 'LOGNAME': 'cltbld', 14:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:15 INFO - 'MOZ_NO_REMOTE': '1', 14:34:15 INFO - 'NO_EM_RESTART': '1', 14:34:15 INFO - 'PAGER': '/bin/cat', 14:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:15 INFO - 'PWD': '/builds/slave/test', 14:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:15 INFO - 'SHELL': '/bin/bash', 14:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:15 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:15 INFO - 'USER': 'cltbld', 14:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:15 INFO - 'XPC_FLAGS': '0x0', 14:34:15 INFO - 'XPC_SERVICE_NAME': '0', 14:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:34:16 INFO - Cleaning up... 14:34:16 INFO - Return code: 0 14:34:16 INFO - Running post-action listener: _resource_record_post_action 14:34:16 INFO - Running post-action listener: _start_resource_monitoring 14:34:16 INFO - Starting resource monitoring. 14:34:16 INFO - [mozharness: 2017-04-07 21:34:16.129773Z] Finished create-virtualenv step (success) 14:34:16 INFO - [mozharness: 2017-04-07 21:34:16.130766Z] Running install step. 14:34:16 INFO - Running pre-action listener: _resource_record_pre_action 14:34:16 INFO - Running main action method: install 14:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:16 INFO - Reading from file tmpfile_stdout 14:34:16 INFO - Detecting whether we're running mozinstall >=1.0... 14:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:34:16 INFO - Reading from file tmpfile_stdout 14:34:16 INFO - Output received: 14:34:16 INFO - Usage: mozinstall [options] installer 14:34:16 INFO - Options: 14:34:16 INFO - -h, --help show this help message and exit 14:34:16 INFO - -d DEST, --destination=DEST 14:34:16 INFO - Directory to install application into. [default: 14:34:16 INFO - "/builds/slave/test"] 14:34:16 INFO - --app=APP Application being installed. [default: firefox] 14:34:16 INFO - mkdir: /builds/slave/test/build/application 14:34:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:34:36 INFO - Reading from file tmpfile_stdout 14:34:36 INFO - Output received: 14:34:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:34:36 INFO - Running post-action listener: _resource_record_post_action 14:34:36 INFO - [mozharness: 2017-04-07 21:34:36.419376Z] Finished install step (success) 14:34:36 INFO - [mozharness: 2017-04-07 21:34:36.419518Z] Running run-tests step. 14:34:36 INFO - Running pre-action listener: _resource_record_pre_action 14:34:36 INFO - Running main action method: run_tests 14:34:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:34:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:34:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:34:36 INFO - 2017-04-07 14:34:36.434 screenresolution[1626:7594] starting screenresolution argv=screenresolution get 14:34:36 INFO - 2017-04-07 14:34:36.436 screenresolution[1626:7594] Display 0: 1600x1200x32@60 14:34:36 INFO - 2017-04-07 14:34:36.442 screenresolution[1627:7597] starting screenresolution argv=screenresolution list 14:34:36 INFO - Available Modes on Display 0 14:34:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:34:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:34:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:34:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:34:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:34:36 INFO - Intel Iris: 14:34:36 INFO - Chipset Model: Intel Iris 14:34:36 INFO - Type: GPU 14:34:36 INFO - Bus: Built-In 14:34:36 INFO - VRAM (Dynamic, Max): 1536 MB 14:34:36 INFO - Vendor: Intel (0x8086) 14:34:36 INFO - Device ID: 0x0a2e 14:34:36 INFO - Revision ID: 0x0009 14:34:36 INFO - Displays: 14:34:36 INFO - Display: 14:34:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:34:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:34:36 INFO - Display Serial Number: 1600x1200 60 14:34:36 INFO - Main Display: Yes 14:34:36 INFO - Mirror: Off 14:34:36 INFO - Online: Yes 14:34:36 INFO - Rotation: Supported 14:34:36 INFO - Return code: 0 14:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:34:36 INFO - Python 2.7.3 14:34:36 INFO - Return code: 0 14:34:36 INFO - grabbing minidump binary from tooltool 14:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:36 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 0x104163d30>, '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 0x10408adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104158be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:34:36 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 14:34:36 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 14:34:36 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 14:34:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:34:36 INFO - Return code: 0 14:34:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:34:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:34:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:34:36 INFO - ENV: RUST_BACKTRACE is now 1 14:34:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:34:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Aa9RBeZOEm/Render', 14:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:36 INFO - 'HOME': '/Users/cltbld', 14:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:36 INFO - 'LOGNAME': 'cltbld', 14:34:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:34:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:36 INFO - 'MOZ_NO_REMOTE': '1', 14:34:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:34:36 INFO - 'NO_EM_RESTART': '1', 14:34:36 INFO - 'PAGER': '/bin/cat', 14:34:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:36 INFO - 'PWD': '/builds/slave/test', 14:34:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:36 INFO - 'RUST_BACKTRACE': '1', 14:34:36 INFO - 'SHELL': '/bin/bash', 14:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C5zJDabGy8/Listeners', 14:34:36 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 14:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:36 INFO - 'USER': 'cltbld', 14:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:36 INFO - 'XPC_FLAGS': '0x0', 14:34:36 INFO - 'XPC_SERVICE_NAME': '0', 14:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:34:37 INFO - mozversion application_buildid: 20170407131422 14:34:37 INFO - mozversion application_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 14:34:37 INFO - mozversion application_display_name: Nightly 14:34:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:34:37 INFO - mozversion application_name: Firefox 14:34:37 INFO - mozversion application_remotingname: firefox 14:34:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:34:37 INFO - mozversion application_vendor: Mozilla 14:34:37 INFO - mozversion application_version: 55.0a1 14:34:37 INFO - mozversion platform_buildid: 20170407131422 14:34:37 INFO - mozversion platform_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 14:34:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:34:37 INFO - mozversion platform_version: 55.0a1 14:34:37 INFO - using testdate: 1491600877 14:34:37 INFO - actual date: 1491600877 14:34:37 INFO - starting webserver on 'localhost:49242' 14:34:37 INFO - SUITE-START | Running 2 tests 14:34:37 INFO - TEST-START | dromaeo_css 14:34:37 INFO - operating with platform_type : mac_ 14:34:37 INFO - Initialising browser for dromaeo_css test... 14:34:37 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpJtoFrW/profile http://localhost:49242/getInfo.html) 14:34:37 INFO - PID 1637 | 1491600877686 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:34:37 INFO - PID 1637 | 1491600877687 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 14:34:37 INFO - PID 1637 | 1491600877739 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:34:39 INFO - PID 1637 | __metrics Screen width/height:1600/1200 14:34:39 INFO - PID 1637 | colorDepth:24 14:34:39 INFO - PID 1637 | Browser inner width/height: 1024/689 14:34:39 INFO - PID 1637 | __metrics 14:34:40 INFO - PID 1637 | 1491600880029 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:34:40 INFO - PID 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:40 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:34:41 INFO - TEST-INFO | 1637: exit 0 14:34:41 INFO - Browser initialized. 14:34:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:34:41 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpJtoFrW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:41 INFO - PID 1639 | 1491600881502 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:34:41 INFO - PID 1639 | 1491600881503 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:34:53 INFO - PID 1639 | RSS: Main: 237723648 14:34:53 INFO - PID 1639 | 14:37:58 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:38:01 INFO - PID 1639 | RSS: Main: 505438208 14:38:01 INFO - PID 1639 | 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:39:43 INFO - PID 1639 | 14:39:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:39:43 INFO - PID 1639 | Full stack: 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:39:43 INFO - PID 1639 | 14:39:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:39:43 INFO - PID 1639 | Full stack: 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:39:43 INFO - PID 1639 | 14:39:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:39:43 INFO - PID 1639 | Full stack: 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | ************************* 14:39:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:39:43 INFO - PID 1639 | 14:39:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:39:43 INFO - PID 1639 | Full stack: 14:39:43 INFO - PID 1639 | ************************* 14:41:04 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:41:04 INFO - PID 1639 | RSS: Main: 371146752 14:41:04 INFO - PID 1639 | 14:44:06 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:44:07 INFO - PID 1639 | RSS: Main: 329400320 14:44:07 INFO - PID 1639 | 14:47:09 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:47:10 INFO - PID 1639 | RSS: Main: 360054784 14:47:10 INFO - PID 1639 | 14:50:14 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:50:14 INFO - PID 1639 | RSS: Main: 330510336 14:50:14 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:53:17 INFO - PID 1639 | RSS: Main: 378454016 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | __start_tp_report 14:53:17 INFO - PID 1639 | _x_x_mozilla_page_load 14:53:17 INFO - PID 1639 | _x_x_mozilla_page_load_details 14:53:17 INFO - PID 1639 | |i|pagename|runs| 14:53:17 INFO - PID 1639 | |0;dojo.html;3538.734594905382;3542.0967653248417;3559.697425718814;3566.3580555500016;3589.6589823966715;5928.940710592893;6111.69441527924;6146.569740118193;6229.906551401727;6240.282367527736;6159.445649891509;6176.629402235858;6204.069389591564;6208.9379106209035;6223.346548612399;5239.240310155025;5321.973390133044;5412.9458705412835;5419.430959749228;5553.416891226424;5484.862878428032;5528.253685752412;5537.390887002426;5544.1960915667205;5550.111982082867;5274.55166310864;5314.601404894648;5335.973320133375;5359.973200133974;5483;5341.1187154119525;5348.625596208267;5359.303290572239;5360.865978350534;5378.139497680391;5277.12927366984;5310.548603368718;5329.946700532983;5333.1733581294575;5350.250964864922;6132.306126318523;6171.290301615282;6274.654893980829;6294.968525157345;6295.937040629627;6691.76578819739;6713.899291510631;6722.025306330604;6725;6735.831604209885;5497.340319161686;6338.82731694638;6749.865002699968;6833.965830170818;6845.520813543054;5291.682499050069;6236.064590311445;6268.341824108448;6275.435210831047;6277.309495955441;5718.79984200551;5722.828315150552;6881.243063263037;6895.55178913369;6897.379235868796;6255.624662520263;6337.6197428154455;6339.5562310637815;6356.269029061717;6573.474122070223;6511.413972742476;6523.64119973406;6527.673616319165;6528;6532.248791389051;5462.699551524624;6412.9679351602945;6424.871502569922;6434.967825160844;6445.387688169616;6566.474682025427;6609.239937407259;6683.465322774166;6690.59856408617;6712;5076.949230507722;5257.342832145981;5360;5364.8122315718765;5409.6213265071065;3934.842606295716;4709.293605959065;4727.858164255078;4784.856454306377;4786.7845946932475;6281.214848143982;6322.462590679752;6346.968265158737;6349.396807303298;6365.0452432134625;6733.663316834139;6775.322467753185;6778.423833974069;6799.4900382471515;6809.7276108956075;6128.295246046672;6130.612163469723;6157.907631385533;6247.125402443661;6278.811635650938;5904.7342869570975;5921;5922.555808314393;5961.5230781537375;5980.312264089598;6864.691088901011;6867;6931.341522555349;6934.583924964519;6939.583624982517;6460.483161346987;6534.8366290843105;6684.598924064571;6765.019072234597;6766.966165169143;6655;6788.151481064867;6865.656717164022;6871.725130994704;6884.173899132136;6536.052272420377;6575.572587781779;6583.539152259296;6586.47308215332;6598.505112116514;6712.295209002984;6722.764703235363;6726.02472641474;6741.056252124805;6752.122224110834;6284.780032699016;6351.650659213603;6355.428011478989;6431.614103153639;6485.643289618927;6255.124282600531;6486.286508483969;6510.18622672166;6526.282108968105;6558;5280.3663560373;6242.282137554058;6269.843253918689;6314.400131987454;6333.6516491591565;6312.621242725451;6331.430171284606;6339.1125242467015;6342.143810585697;6355.014972679242;6303.086052522267;6305.684715764285;6355.269144048309;6356.173697419306;6362.236531616236 14:53:17 INFO - PID 1639 | |1;ext.html;790.9011373578303;804.6097642643318;1014.2291858187775;1026.409814356745;1028.2750660784143;35379.469307960404;35738.10654733633;36133.45799813005;36150.9154725358;36180.91457256283;37564.248715025686;37783.62216377835;37836.62163378365;37928.62071379292;38001.23997520048;6055.2430946131735;6195.28754193269;8351.206635369645;8527.530985795778;8530.74407767768;8321.292690121347;8533.359998000144;8563.35774816888;8573.914260857406;8584;8586.656533738644;8641.740747777576;8650.221480066793;8658.134186581323;8667.349948753837;8541.701040463586;8609.009963854174;8622.956885215533;8628.007779105421;8634.956825215897;8413.03250126231;8455.323574114056;8456;8457.873131903027;8464.957675211646;36095.63904360975;36287.27425451476;36296;36306;36422.90731278066;3575.1955809942556;3598.8920332389807;3610.4584312353095;3614.132608174046;3618.656227658368;29931.70068299311;29968.85015574908;30043.248918776986;30053.549196762066;30100;3160.4943209086664;3187.26692860641;3218.1471909943884;3222.7744057915957;3226.6289376721743;263671;266534;268853;268914.6554267216;270453;39002.804985974886;39517.40723889144;39584.40623390651;47310.5268947313;47483.5251647486;40107;40112;40139.79930100331;40195.99510012273;47596.28605570919;12610.306433146081;12666.050046246568;12704.364781760874;12758.170718903428;12762.872371276355;10258.58965641381;10272.229582781321;10288.794224115476;10320.948395258125;10344.896551034544;12157.331346775836;12162.574309899112;12187.39063046844;12198.939005304917;12336.259824410565;4357.847475338348;5150.48495150482;5161.612879034087;5172.663776854492;5197.324347834758;1028.1671845804922;1028.1980055556678;1032.5353590884133;1062.5537274344795;1069.909057730086;20980.05589748465;22020.33938981833;23179.420514486934;23247;23296.272596384497;953.2278854128178;1051.1748277602046;1100.7468282295117;1133.665568657248;1153.8442310288171;11718.472668729928;11836.822447663291;11868;11924;11930.403479826147;346587;346656;347572;347746;348441;50015.24977125346;50167;50179.74910125499;50226;50289;1474.226031333537;1482.392219190127;1530.869876060525;1535.0712818744498;1537.9000364976241;22715;22731.88634056819;22792.886035569714;22880.08479660795;22963.88518057399;36468.27063458769;36508.81745591255;36579.817100914326;36591.08522286964;36640.81679591585;320827;321130.7886921101;321489.31808750745;321697;322165;29005;29476.136437487574;32399.35201296008;33329;33519.497207542394;40675;41163.794181028905;41281.380779288935;41349.586504134575;41506;27615.861920691073;28531.572026419206;28730.281742956595;29061.41877162487;29863.402731945673;28076.438471230053;28244;28803.56794648124;29265.853670732362;29268.56097158502;28309;34277.65722342845;34332.485012724326;34373.968780936615;34402.655973440946;27305.590416143375;27846.58230126509;28686.42627147487;29247.415051698423;29727.55408668915;20411.4897127573;21425.55757975875;21945.670814937468;22570.7708517467;22586.887065565224 14:53:17 INFO - PID 1639 | |2;jquery.html;385.77432202161737;427.53738466433356;437.20428819548425;441.3071477779886;455.05802987815196;17592.912035439822;21117.472063198427;21912.23307184249;22616.643001419907;22967.42581435465;18972.62054758904;21941.232056878012;22184.33446996593;22316.21893233733;22600;4269.466316710411;5233.267342572033;6288.24541055074;6329.177206963089;6331.050342448623;6143.600665956721;6239.719212635442;6245.906311405332;6247.094171345152;6258.593191442542;5442.6462279951875;5966.910496342537;5967.522598192134;6196.318404975449;6205;5993;6123.418275263843;6206.193194884681;6211.627302361872;6214.25428948529;5426;5496.258005169291;5501.202325662756;5508;5519.172124181365;21280.04239809197;25958.09146679876;25966.221013369628;25982.22053338403;26227.868860655766;2153.257126291427;2222.466608014081;2226.4545186429427;2227.8440509164366;2229.4537838229576;17044.318227270895;17219.483415497554;17475.21361538734;17645.470635880945;17841.375551855625;2119.448943274744;2149.0973791007814;2204.1183526589334;2205.8014778669835;2208.0726095040122;143716.28141859328;143751.84372234426;144060.27969860085;145761;167925;11355.829662555068;11591.362475063785;11615.664198617098;12189;12212.877871221352;15007.574280443341;15094.39622415091;15757.921210394104;16167.676646467005;16188.595285117966;8197.754067377988;8203.138670439637;8319.625616847135;8428.283595894294;8575.571221439028;7623.504472209289;7661.233876612294;7707.036620422447;7795.934077469475;7823.887550361371;6657.234418041987;6691.26396096429;6994.4404447644065;7505.437092218105;7609.162992070978;2148.484363752719;2158.2230397057047;2171.6199665058552;2180.9345719628436;2323.7327707313875;777.413053144872;918.93108016899;926.8100039491889;961.0341606685377;961.5864678921973;19730.40808775739;20408.489787755127;20463.693044604344;20541.97290135487;20709.792902071087;940.6519587752575;951.6764300137986;971.7522031881825;983.2232536296245;983.6311383231289;10258.333208341433;10620.203484738675;10633.096186824052;10687.625933092304;10803.731216444477;685159;687574;693685;718119;725107;150672.2466387661;155234.37187537568;157625;158162;159552;1118.2898859224451;1136.8749437561862;1159.5709587452527;1160.5879912631062;1168.2639936839907;17089.471290107882;17556.648867022333;17557.297708092043;17632.471025869243;17973.460796176136;55189.1721624184;57407;57990.4200957985;58301.4169858296;58356;70095.64952175207;86070.2785944265;86606;87955;88696.11303886879;6915.827104322432;8347.165283471604;8396.648938297287;8820.25027872638;8848.91151088481;13297.933510332387;13544.984126190771;13567.728645427234;13928.651783705489;13975.720485590435;11530.654080377602;11685.357305347947;11851.229670071763;11863.881361186623;12044.638660840188;8763.554013587942;10743.355398675792;10793.730156746144;11074.058705010164;11231.15766317513;11059.170562208028;11457.541698331974;11949.76100478003;12214.816777748518;12260.26438413698;7861.567613781068;8662.870056949025;8915.821683566162;9083.772905677411;9084;11649.708757281136;11732;12028.518859245532;12073.698157546132;12139.271643701406 14:53:17 INFO - PID 1639 | |3;mootools.html;1373.8488766235716;1408.0566020766087;1420.6945506716047;1438.42463014794;1439.6256973186971;11283.830742538868;11787.29276243425;11793.469293881775;11795.764084718301;11806.704832379184;11490.942545287262;11493.885061149385;11950.82073768892;11963.1625786195;11986.2208956418;2491.725910149882;2535.2521006303186;2542.7838633716065;2545.5672535668887;2545.6054311581643;2461.20010996426;2474.035126300735;2527.658766066585;2533.0880882882147;2537.4037101281183;2395.993682653281;2493.8004959603277;2496.5755821510297;2497.0261597976805;2510.836795608289;2479.2934013806157;2509.498100379922;2509.7992160627105;2528.6459895614444;2547.350425641468;2472.394263405477;2493.30187547487;2501.562226610336;2504.8622325772076;2509.146890057389;11472.369019703912;11820;11830.881691183064;11840.644780656594;11859.229150105215;6427.903581446282;6680.5991640501725;6680.7661731839635;6682.331766823328;6691.297413771533;3991.5808840071954;4237.724547904407;4327.567243275679;4332.393464914914;4361.476622805284;1227.938603069852;1258.7860063789178;1312.0225432053087;1316.9078164528487;1318.0312470334297;14601;15088.698226035527;16043.35826566936;16306;16474.505764827074;4707.317438971399;5331.493508116722;5485.61600687956;5627.5779316551425;5634.070378387602;12255.877441225473;12286.447109880077;12289.815652765215;12300.81548776769;12319.445624946899;6484.481241500763;6504.544681872224;6505.739770409131;6512;6519.217693876671;5208.453112423141;5958.880822383528;6090.177825993523;6193.225846769154;6242.1261023456755;4055.945454181875;4091.4067460218102;4253.744775313491;4366.912661746811;4427.203103441347;1294.5339677716015;1294.540438144464;1296.4878872845172;1314.1917720601762;1316.2036967634635;686.4885660183096;774.6049514747519;800.2957397490288;802.8996375453069;810.1614828652316;6023.518118550505;6069.453749162597;6175.258968923668;6207.844803879939;6301.243850737941;483.2606112647655;589.8525368657836;593.483669207792;596.2219303808572;605.797057985571;3899.629535194152;4030.375291829771;4185.853495127656;4234.915301694011;4245.724027938174;14514.491992780202;15095.622609434851;15109.320080596399;15130.319135638923;15141.987373346072;14988.250587470582;15028.474003409829;15035.669471231977;15048.62378440526;15049;10466.581336746598;10512.369257844553;10918.1811364148;10924.399158046384;10962.342259464458;5545.391836367408;5753.827385178452;6626.768063117768;6912.654367281716;6948.652567371712;12865.935670321964;12935.935320323339;12979.805302920275;12992.220466772023;13037.217766934014;13536.458541658223;13854.16874987504;13948.930255348658;14037.438502459787;14201.147931124166;8372.204640559137;8599.441036332619;8600.311975042106;8622.482651040958;8628.309735221043;10552.31409958381;10651.680449586525;10677.305975111592;10678.359298442118;10682.092022178202;8753.212210901049;9150.771230719285;9217.078292170729;9222.354435189472;9289.535523223947;8903.243224325746;8940.46357218569;8967.10328967098;9012.2790176787;9014.639414423613;7951.681932722627;8112.75661730149;8129;8138.470999385021;8150.796230094295;5891.1752354669525;5905.793297234576;6027.397260274113;6082.60463069899;6132.754689812357;5902.1441890926435;5957.702114894325;6176;6206.72069756853;6330.272018717907 14:53:17 INFO - PID 1639 | |4;prototype.html;376.78299093926614;387.20236313194823;400.6194115590189;401.24165327530955;402.8589993502273;4839.2499162629765;5779.7688092476355;5903.26209223847;5959.3146788119375;5970.701464926752;5651.5761317901115;5666.688332141731;5800.883982320351;5830.329512106109;5833.737481813318;4289.05640759034;4301.139772045588;4315.503717072545;4320.65434765218;4325.48094228693;3474.6525347465176;3783.735138540303;4181.581841815824;4275.657947364203;4339.291868322858;3711;3724.255148970203;4236.851710190144;4285.892852678677;4306.88021114511;3724.422714479233;3799.8290076946605;4020.155767288873;4226.809793559281;4251.4260574822465;3568;3611.2304970564232;3718.4608231806506;3735.7758534488016;3759.342115129841;5504.504594586507;5620.269364982526;5639.746211420496;5648.406917273668;5661.830145095653;5046.899062018739;5064.2403639454005;5078.4921507849285;5099.949000509984;5109.744512774347;6000.18997435345;6028.153136449279;6170.629762214281;6176.4441200292185;6201.875962480725;4192.727472714294;4198.942518166107;4221.092465119983;4221.936670949938;4223.788810559459;4471.1728330259;5466.34403871534;6138.956377415805;6351.142595749515;6448.421126274916;3938.2517321708783;4041.9191616167514;4189.642771517588;4236.364545318165;4288.399624052635;3826.9617303827163;4345.760983145958;4348.173767017797;4354.477462704495;4390.582894625006;4415.315626077963;4600.700954437951;4814.711117332971;5090.2364645303505;5091.719955402488;4903.632227582945;5519.212797537299;6268.862550716596;6269;6277.748890044347;1453.731059753949;1489.2330449818353;1490.880729541634;1491.2171110167249;1500.5069955394451;845.2688424512875;930.3627015494408;979.4280180310499;982.5578489679673;1005.9798804023878;4926;5610.691411972299;5801.53587712982;5806.68063256525;5816.592838501264;6421.29365769765;6421.389967953037;6452.22573291208;6460.612363258219;6461;4725.267583524559;5621.98804215237;5728.713564321767;5793.94206057934;5802.6808525531505;3048.268415580245;3286.7863588867126;3363.663633636617;3390.423627983249;3396.7452441066525;5443.020256353815;5717.770069672831;6293.458102764852;6326.977055468426;6596.307387724316;6084.908726369108;6220.471259942956;6511.321103576464;6570.342965703391;6608.570442921291;5508.512701570554;6059.939400605937;6512.706928188148;6553.8361540960905;6564.409203171737;5067.429096979948;6309.886188127029;6364.408897775556;6420.357964203542;6469.159009328757;6266.023638771547;6290.685465726604;6327.936720632735;6346.397092276226;6370.617762934239;5631.408702086222;5643.735453646531;6026.306974697965;6041.365656605993;6575.408213260829;4213.199492096492;4239.809208585682;4243.554426785143;4276.059266961263;4284.271673815397;4934;5323.0950738373795;5547.973624879411;6129.578816367599;6474.773382931575;5349.893002140013;6125.571210015434;6157.507399408126;6181.81454556364;6217.533684973736;6110.725017374318;6123.234595675541;6125.234345706786;6152.538559608137;6184.257889053342;5040.445550989315;5290.947090529199;5674.233978412862;6022.7289771959495;6183.319834818257;6223.471004964629;6234.532410069353;6246.4378205959865;6248.187735594343;6248.718807653576;5801.506871915765;5979.521638268841;6082.391760823883;6094.994325936348;6108.57239993214 14:53:17 INFO - PID 1639 | |5;yui.html;721.7509959064121;760.5056713136462;874.2874557235848;876.9739404896271;886.7073865624344;13535.593932182039;17916.731249031258;18534.44396668102;18573.62852742948;18575.442736717887;17151.91424042881;17634.559136021573;17770.466885993443;17797.55506112348;17800.64398712025;965.0831709875629;995.6564985080136;996.432033740768;998.2114129837456;1000.6547741029333;657.9703913323912;682.8122266376761;962.8700125483075;1007.9344842585245;1011.413380239463;1059;1060.1571750458404;1060.9628662996797;1062.7980683670116;1063.0591926145378;1043.5564884923915;1044.9686509404692;1045.9058684718411;1046.7540128069897;1047.6647472808704;766.0156698642218;768.6502641298196;768.7808974442257;771.2750014985951;771.4098714483424;16477.58806029847;16784.496465106065;16817.075060871648;16996.745048824276;17268.481945541655;16018.199090045568;16379.344826206938;16593.50219493405;16614.252358643767;16642;15390.461333853262;15441.459548915846;15676.137812420313;15730.685386292325;15758.606034849106;4675.88310292242;5270.235815806686;5337;5337.70642614656;5342.813001544966;97957.0204297955;100503.49748251212;100751;101792;106370.93629063688;11415.942920285512;11789.115816313812;13481.662958426117;13749.862501375059;13917.23455209953;19508.12213450398;19997.200111995357;22423.32730018102;24878.5024299513;25033.87483062573;8736.301095912311;8740.825183496421;8895.199432051017;8998.775030624156;9038.322125840588;4508.1659892919915;4573.81704731807;4586.862394128181;4606.907861842745;4614.054118905617;4272.807723652443;4389.604935555815;4681.531846815291;4817.156997525419;4883.072216278895;960.6925783749133;976.0776066616979;993.3493561717087;994.7562847102362;995.9053889880449;656.9605823650596;666.5967089910631;669.2404121322335;681.495693187038;689.4449967775888;10944.343339399662;11495.827562586568;11839.05287577009;11904.583339583072;12050.578229761917;593.6705128653552;611.8802591257987;649.6199723161909;666.3436515032689;686.7664993902097;5259.789608415621;5306.52241298285;5465;5555.194496797942;5655.462731040545;100658.49670751746;100710;101408;101834;102608;89298.21403571892;90415;90663.54668226617;91540.54229728809;92592;73760.63119684368;73812.26187738054;74317.25682743211;74563;75958.86061709079;9471.526423678926;9992.850107248543;10629.681109566725;11025.17311201647;11984.880151198377;32249.838750806095;40631.59368406396;40873;41347;41910.79044604758;49820.50179498159;67593.32406675871;69258.65370673114;69439;69844.6507767458;13706.560811115089;16269.755953660468;16506.83493165053;16738.497845064667;16861;17068.975861448354;17233.310667573158;17413.390531331344;17568.472945811645;18406.26374944987;16274.593135171715;16358;16394.344226231293;16552.66894662076;16708.49874503767;16570.668586628442;16632.3347066116;16643.91678041602;16786.748198776782;16803.37907075564;16192.919035404748;16316.755248671518;16346.918265408596;16352.754708679617;16489.257983390537;11576.652700419001;11615.593454229062;11952.46213920393;12082.214656047328;12231;12274.509019639114;12674.683132921382;12705.618831435071;12708.173968692005;13052.15161014531 14:53:17 INFO - PID 1639 | __end_tp_report 14:53:17 INFO - PID 1639 | __start_cc_report 14:53:17 INFO - PID 1639 | _x_x_mozilla_cycle_collect,3366 14:53:17 INFO - PID 1639 | __end_cc_report 14:53:17 INFO - PID 1639 | __startTimestamp1491601997435__endTimestamp 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | ------- Summary: start ------- 14:53:17 INFO - PID 1639 | Number of tests: 6 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6088.45 Median:6305.68 stddev:727.97 (11.5%) stddev-sans-first:702.19 14:53:17 INFO - PID 1639 | Values: 3538.7 3542.1 3559.7 3566.4 3589.7 5928.9 6111.7 6146.6 6229.9 6240.3 6159.4 6176.6 6204.1 6208.9 6223.3 5239.2 5322.0 5412.9 5419.4 5553.4 5484.9 5528.3 5537.4 5544.2 5550.1 5274.6 5314.6 5336.0 5360.0 5483.0 5341.1 5348.6 5359.3 5360.9 5378.1 5277.1 5310.5 5329.9 5333.2 5350.3 6132.3 6171.3 6274.7 6295.0 6295.9 6691.8 6713.9 6722.0 6725.0 6735.8 5497.3 6338.8 6749.9 6834.0 6845.5 5291.7 6236.1 6268.3 6275.4 6277.3 5718.8 5722.8 6881.2 6895.6 6897.4 6255.6 6337.6 6339.6 6356.3 6573.5 6511.4 6523.6 6527.7 6528.0 6532.2 5462.7 6413.0 6424.9 6435.0 6445.4 6566.5 6609.2 6683.5 6690.6 6712.0 5076.9 5257.3 5360.0 5364.8 5409.6 3934.8 4709.3 4727.9 4784.9 4786.8 6281.2 6322.5 6347.0 6349.4 6365.0 6733.7 6775.3 6778.4 6799.5 6809.7 6128.3 6130.6 6157.9 6247.1 6278.8 5904.7 5921.0 5922.6 5961.5 5980.3 6864.7 6867.0 6931.3 6934.6 6939.6 6460.5 6534.8 6684.6 6765.0 6767.0 6655.0 6788.2 6865.7 6871.7 6884.2 6536.1 6575.6 6583.5 6586.5 6598.5 6712.3 6722.8 6726.0 6741.1 6752.1 6284.8 6351.7 6355.4 6431.6 6485.6 6255.1 6486.3 6510.2 6526.3 6558.0 5280.4 6242.3 6269.8 6314.4 6333.7 6312.6 6331.4 6339.1 6342.1 6355.0 6303.1 6305.7 6355.3 6356.2 6362.2 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:44772.33 Median:32864.18 stddev:82662.00 (251.5%) stddev-sans-first:82827.93 14:53:17 INFO - PID 1639 | Values: 790.9 804.6 1014.2 1026.4 1028.3 35379.5 35738.1 36133.5 36150.9 36180.9 37564.2 37783.6 37836.6 37928.6 38001.2 6055.2 6195.3 8351.2 8527.5 8530.7 8321.3 8533.4 8563.4 8573.9 8584.0 8586.7 8641.7 8650.2 8658.1 8667.3 8541.7 8609.0 8623.0 8628.0 8635.0 8413.0 8455.3 8456.0 8457.9 8465.0 36095.6 36287.3 36296.0 36306.0 36422.9 3575.2 3598.9 3610.5 3614.1 3618.7 29931.7 29968.9 30043.2 30053.5 30100.0 3160.5 3187.3 3218.1 3222.8 3226.6 263671.0 266534.0 268853.0 268914.7 270453.0 39002.8 39517.4 39584.4 47310.5 47483.5 40107.0 40112.0 40139.8 40196.0 47596.3 12610.3 12666.1 12704.4 12758.2 12762.9 10258.6 10272.2 10288.8 10320.9 10344.9 12157.3 12162.6 12187.4 12198.9 12336.3 4357.8 5150.5 5161.6 5172.7 5197.3 1028.2 1028.2 1032.5 1062.6 1069.9 20980.1 22020.3 23179.4 23247.0 23296.3 953.2 1051.2 1100.7 1133.7 1153.8 11718.5 11836.8 11868.0 11924.0 11930.4 346587.0 346656.0 347572.0 347746.0 348441.0 50015.2 50167.0 50179.7 50226.0 50289.0 1474.2 1482.4 1530.9 1535.1 1537.9 22715.0 22731.9 22792.9 22880.1 22963.9 36468.3 36508.8 36579.8 36591.1 36640.8 320827.0 321130.8 321489.3 321697.0 322165.0 29005.0 29476.1 32399.4 33329.0 33519.5 40675.0 41163.8 41281.4 41349.6 41506.0 27615.9 28531.6 28730.3 29061.4 29863.4 28076.4 28244.0 28803.6 29265.9 29268.6 28309.0 34277.7 34332.5 34374.0 34402.7 27305.6 27846.6 28686.4 29247.4 29727.6 20411.5 21425.6 21945.7 22570.8 22586.9 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:40257.95 Median:22458.11 stddev:117713.42 (524.1%) stddev-sans-first:118005.57 14:53:17 INFO - PID 1639 | Values: 385.8 427.5 437.2 441.3 455.1 17592.9 21117.5 21912.2 22616.6 22967.4 18972.6 21941.2 22184.3 22316.2 22600.0 4269.5 5233.3 6288.2 6329.2 6331.1 6143.6 6239.7 6245.9 6247.1 6258.6 5442.6 5966.9 5967.5 6196.3 6205.0 5993.0 6123.4 6206.2 6211.6 6214.3 5426.0 5496.3 5501.2 5508.0 5519.2 21280.0 25958.1 25966.2 25982.2 26227.9 2153.3 2222.5 2226.5 2227.8 2229.5 17044.3 17219.5 17475.2 17645.5 17841.4 2119.4 2149.1 2204.1 2205.8 2208.1 143716.3 143751.8 144060.3 145761.0 167925.0 11355.8 11591.4 11615.7 12189.0 12212.9 15007.6 15094.4 15757.9 16167.7 16188.6 8197.8 8203.1 8319.6 8428.3 8575.6 7623.5 7661.2 7707.0 7795.9 7823.9 6657.2 6691.3 6994.4 7505.4 7609.2 2148.5 2158.2 2171.6 2180.9 2323.7 777.4 918.9 926.8 961.0 961.6 19730.4 20408.5 20463.7 20542.0 20709.8 940.7 951.7 971.8 983.2 983.6 10258.3 10620.2 10633.1 10687.6 10803.7 685159.0 687574.0 693685.0 718119.0 725107.0 150672.2 155234.4 157625.0 158162.0 159552.0 1118.3 1136.9 1159.6 1160.6 1168.3 17089.5 17556.6 17557.3 17632.5 17973.5 55189.2 57407.0 57990.4 58301.4 58356.0 70095.6 86070.3 86606.0 87955.0 88696.1 6915.8 8347.2 8396.6 8820.3 8848.9 13297.9 13545.0 13567.7 13928.7 13975.7 11530.7 11685.4 11851.2 11863.9 12044.6 8763.6 10743.4 10793.7 11074.1 11231.2 11059.2 11457.5 11949.8 12214.8 12260.3 7861.6 8662.9 8915.8 9083.8 9084.0 11649.7 11732.0 12028.5 12073.7 12139.3 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7107.11 Median:2540.09 stddev:4520.77 (178.0%) stddev-sans-first:4512.93 14:53:17 INFO - PID 1639 | Values: 1373.8 1408.1 1420.7 1438.4 1439.6 11283.8 11787.3 11793.5 11795.8 11806.7 11490.9 11493.9 11950.8 11963.2 11986.2 2491.7 2535.3 2542.8 2545.6 2545.6 2461.2 2474.0 2527.7 2533.1 2537.4 2396.0 2493.8 2496.6 2497.0 2510.8 2479.3 2509.5 2509.8 2528.6 2547.4 2472.4 2493.3 2501.6 2504.9 2509.1 11472.4 11820.0 11830.9 11840.6 11859.2 6427.9 6680.6 6680.8 6682.3 6691.3 3991.6 4237.7 4327.6 4332.4 4361.5 1227.9 1258.8 1312.0 1316.9 1318.0 14601.0 15088.7 16043.4 16306.0 16474.5 4707.3 5331.5 5485.6 5627.6 5634.1 12255.9 12286.4 12289.8 12300.8 12319.4 6484.5 6504.5 6505.7 6512.0 6519.2 5208.5 5958.9 6090.2 6193.2 6242.1 4055.9 4091.4 4253.7 4366.9 4427.2 1294.5 1294.5 1296.5 1314.2 1316.2 686.5 774.6 800.3 802.9 810.2 6023.5 6069.5 6175.3 6207.8 6301.2 483.3 589.9 593.5 596.2 605.8 3899.6 4030.4 4185.9 4234.9 4245.7 14514.5 15095.6 15109.3 15130.3 15142.0 14988.3 15028.5 15035.7 15048.6 15049.0 10466.6 10512.4 10918.2 10924.4 10962.3 5545.4 5753.8 6626.8 6912.7 6948.7 12865.9 12935.9 12979.8 12992.2 13037.2 13536.5 13854.2 13948.9 14037.4 14201.1 8372.2 8599.4 8600.3 8622.5 8628.3 10552.3 10651.7 10677.3 10678.4 10682.1 8753.2 9150.8 9217.1 9222.4 9289.5 8903.2 8940.5 8967.1 9012.3 9014.6 7951.7 8112.8 8129.0 8138.5 8150.8 5891.2 5905.8 6027.4 6082.6 6132.8 5902.1 5957.7 6176.0 6206.7 6330.3 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:4948.85 Median:5626.70 stddev:1537.64 (27.3%) stddev-sans-first:1503.17 14:53:17 INFO - PID 1639 | Values: 376.8 387.2 400.6 401.2 402.9 4839.2 5779.8 5903.3 5959.3 5970.7 5651.6 5666.7 5800.9 5830.3 5833.7 4289.1 4301.1 4315.5 4320.7 4325.5 3474.7 3783.7 4181.6 4275.7 4339.3 3711.0 3724.3 4236.9 4285.9 4306.9 3724.4 3799.8 4020.2 4226.8 4251.4 3568.0 3611.2 3718.5 3735.8 3759.3 5504.5 5620.3 5639.7 5648.4 5661.8 5046.9 5064.2 5078.5 5099.9 5109.7 6000.2 6028.2 6170.6 6176.4 6201.9 4192.7 4198.9 4221.1 4221.9 4223.8 4471.2 5466.3 6139.0 6351.1 6448.4 3938.3 4041.9 4189.6 4236.4 4288.4 3827.0 4345.8 4348.2 4354.5 4390.6 4415.3 4600.7 4814.7 5090.2 5091.7 4903.6 5519.2 6268.9 6269.0 6277.7 1453.7 1489.2 1490.9 1491.2 1500.5 845.3 930.4 979.4 982.6 1006.0 4926.0 5610.7 5801.5 5806.7 5816.6 6421.3 6421.4 6452.2 6460.6 6461.0 4725.3 5622.0 5728.7 5793.9 5802.7 3048.3 3286.8 3363.7 3390.4 3396.7 5443.0 5717.8 6293.5 6327.0 6596.3 6084.9 6220.5 6511.3 6570.3 6608.6 5508.5 6059.9 6512.7 6553.8 6564.4 5067.4 6309.9 6364.4 6420.4 6469.2 6266.0 6290.7 6327.9 6346.4 6370.6 5631.4 5643.7 6026.3 6041.4 6575.4 4213.2 4239.8 4243.6 4276.1 4284.3 4934.0 5323.1 5548.0 6129.6 6474.8 5349.9 6125.6 6157.5 6181.8 6217.5 6110.7 6123.2 6125.2 6152.5 6184.3 5040.4 5290.9 5674.2 6022.7 6183.3 6223.5 6234.5 6246.4 6248.2 6248.7 5801.5 5979.5 6082.4 6095.0 6108.6 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21071.04 Median:18161.50 stddev:28219.34 (155.4%) stddev-sans-first:28257.13 14:53:17 INFO - PID 1639 | Values: 721.8 760.5 874.3 877.0 886.7 13535.6 17916.7 18534.4 18573.6 18575.4 17151.9 17634.6 17770.5 17797.6 17800.6 965.1 995.7 996.4 998.2 1000.7 658.0 682.8 962.9 1007.9 1011.4 1059.0 1060.2 1061.0 1062.8 1063.1 1043.6 1045.0 1045.9 1046.8 1047.7 766.0 768.7 768.8 771.3 771.4 16477.6 16784.5 16817.1 16996.7 17268.5 16018.2 16379.3 16593.5 16614.3 16642.0 15390.5 15441.5 15676.1 15730.7 15758.6 4675.9 5270.2 5337.0 5337.7 5342.8 97957.0 100503.5 100751.0 101792.0 106370.9 11415.9 11789.1 13481.7 13749.9 13917.2 19508.1 19997.2 22423.3 24878.5 25033.9 8736.3 8740.8 8895.2 8998.8 9038.3 4508.2 4573.8 4586.9 4606.9 4614.1 4272.8 4389.6 4681.5 4817.2 4883.1 960.7 976.1 993.3 994.8 995.9 657.0 666.6 669.2 681.5 689.4 10944.3 11495.8 11839.1 11904.6 12050.6 593.7 611.9 649.6 666.3 686.8 5259.8 5306.5 5465.0 5555.2 5655.5 100658.5 100710.0 101408.0 101834.0 102608.0 89298.2 90415.0 90663.5 91540.5 92592.0 73760.6 73812.3 74317.3 74563.0 75958.9 9471.5 9992.9 10629.7 11025.2 11984.9 32249.8 40631.6 40873.0 41347.0 41910.8 49820.5 67593.3 69258.7 69439.0 69844.7 13706.6 16269.8 16506.8 16738.5 16861.0 17069.0 17233.3 17413.4 17568.5 18406.3 16274.6 16358.0 16394.3 16552.7 16708.5 16570.7 16632.3 16643.9 16786.7 16803.4 16192.9 16316.8 16346.9 16352.8 16489.3 11576.7 11615.6 11952.5 12082.2 12231.0 12274.5 12674.7 12705.6 12708.2 13052.2 14:53:17 INFO - PID 1639 | -------- Summary: end -------- 14:53:17 INFO - PID 1639 | 14:53:17 INFO - PID 1639 | 1491601997461 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:53:18 INFO - TEST-INFO | 1639: exit 0 14:53:18 INFO - TEST-OK | dromaeo_css | took 1121136ms 14:53:18 INFO - TEST-START | kraken 14:53:18 INFO - operating with platform_type : mac_ 14:53:18 INFO - Initialising browser for kraken test... 14:53:18 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpMFezEM/profile http://localhost:49242/getInfo.html) 14:53:18 INFO - PID 1648 | 1491601998796 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:53:18 INFO - PID 1648 | 1491601998797 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 14:53:18 INFO - PID 1648 | 1491601998848 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:53:20 INFO - PID 1648 | __metrics Screen width/height:1600/1200 14:53:20 INFO - PID 1648 | colorDepth:24 14:53:20 INFO - PID 1648 | Browser inner width/height: 1024/689 14:53:20 INFO - PID 1648 | __metrics 14:53:20 INFO - PID 1648 | 1491602000941 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:53:20 INFO - PID 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:53:20 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:53:21 INFO - TEST-INFO | 1648: exit 0 14:53:21 INFO - Browser initialized. 14:53:21 INFO - Running cycle 1/1 for kraken test... 14:53:21 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpMFezEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:22 INFO - PID 1649 | 1491602002340 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 14:53:22 INFO - PID 1649 | 1491602002341 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 14:53:34 INFO - PID 1649 | RSS: Main: 237350912 14:53:34 INFO - PID 1649 | 14:53:37 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:53:38 INFO - PID 1649 | RSS: Main: 291606528 14:53:38 INFO - PID 1649 | 14:53:40 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:53:41 INFO - PID 1649 | RSS: Main: 292196352 14:53:41 INFO - PID 1649 | 14:53:45 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:53:45 INFO - PID 1649 | RSS: Main: 386621440 14:53:45 INFO - PID 1649 | 14:53:47 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:53:48 INFO - PID 1649 | RSS: Main: 287653888 14:53:48 INFO - PID 1649 | 14:53:50 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:53:51 INFO - PID 1649 | RSS: Main: 290402304 14:53:51 INFO - PID 1649 | 14:53:54 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:53:55 INFO - PID 1649 | RSS: Main: 331493376 14:53:55 INFO - PID 1649 | 14:53:58 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:53:59 INFO - PID 1649 | RSS: Main: 347316224 14:53:59 INFO - PID 1649 | 14:54:02 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:54:02 INFO - PID 1649 | RSS: Main: 359362560 14:54:02 INFO - PID 1649 | 14:54:04 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:05 INFO - PID 1649 | RSS: Main: 309489664 14:54:05 INFO - PID 1649 | 14:54:07 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:07 INFO - PID 1649 | RSS: Main: 312803328 14:54:07 INFO - PID 1649 | 14:54:09 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:10 INFO - PID 1649 | RSS: Main: 315174912 14:54:10 INFO - PID 1649 | 14:54:13 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:14 INFO - PID 1649 | RSS: Main: 328290304 14:54:14 INFO - PID 1649 | 14:54:17 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:54:18 INFO - PID 1649 | RSS: Main: 316526592 14:54:18 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:54:20 INFO - PID 1649 | RSS: Main: 381820928 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | __start_tp_report 14:54:20 INFO - PID 1649 | _x_x_mozilla_page_load 14:54:20 INFO - PID 1649 | _x_x_mozilla_page_load_details 14:54:20 INFO - PID 1649 | |i|pagename|runs| 14:54:20 INFO - PID 1649 | |0;ai-astar;112;122;121;123;124;122;123;124;123;124 14:54:20 INFO - PID 1649 | |1;audio-beat-detection;144;132;152;196;119;119;118;122;141;117 14:54:20 INFO - PID 1649 | |2;audio-dft;214;214;213;209;209;219;216;213;212;217 14:54:20 INFO - PID 1649 | |3;audio-fft;85;62;66;101;66;66;63;65;84;64 14:54:20 INFO - PID 1649 | |4;audio-oscillator;100;75;95;74;75;101;129;106;74;91 14:54:20 INFO - PID 1649 | |5;imaging-gaussian-blur;92;112;94;92;94;92;93;92;93;92 14:54:20 INFO - PID 1649 | |6;imaging-darkroom;102;101;101;102;102;101;101;100;101;101 14:54:20 INFO - PID 1649 | |7;imaging-desaturate;102;101;101;101;102;102;100;101;103;101 14:54:20 INFO - PID 1649 | |8;json-parse-financial;53;52;52;52;52;52;52;52;52;53 14:54:20 INFO - PID 1649 | |9;json-stringify-tinderbox;59;61;69;73;78;67;65;67;67;65 14:54:20 INFO - PID 1649 | |10;stanford-crypto-aes;92;91;90;93;92;92;90;90;91;89 14:54:20 INFO - PID 1649 | |11;stanford-crypto-ccm;151;165;163;151;148;154;173;158;287;167 14:54:20 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;198;200;203;200;191;205;201;223;256;198 14:54:20 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;85;98;103;104;79;67;99;104;101;74 14:54:20 INFO - PID 1649 | __end_tp_report 14:54:20 INFO - PID 1649 | __start_cc_report 14:54:20 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2160 14:54:20 INFO - PID 1649 | __end_cc_report 14:54:20 INFO - PID 1649 | __startTimestamp1491602060970__endTimestamp 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | ------- Summary: start ------- 14:54:20 INFO - PID 1649 | Number of tests: 14 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:121.80 Median:123.00 stddev:3.58 (2.9%) stddev-sans-first:1.05 14:54:20 INFO - PID 1649 | Values: 112.0 122.0 121.0 123.0 124.0 122.0 123.0 124.0 123.0 124.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:136.50 stddev:24.54 (18.0%) stddev-sans-first:25.86 14:54:20 INFO - PID 1649 | Values: 144.0 132.0 152.0 196.0 119.0 119.0 118.0 122.0 141.0 117.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:213.60 Median:214.00 stddev:3.20 (1.5%) stddev-sans-first:3.40 14:54:20 INFO - PID 1649 | Values: 214.0 214.0 213.0 209.0 209.0 219.0 216.0 213.0 212.0 217.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:72.20 Median:66.00 stddev:13.15 (19.9%) stddev-sans-first:13.10 14:54:20 INFO - PID 1649 | Values: 85.0 62.0 66.0 101.0 66.0 66.0 63.0 65.0 84.0 64.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:74.50 stddev:18.09 (24.3%) stddev-sans-first:18.96 14:54:20 INFO - PID 1649 | Values: 100.0 75.0 95.0 74.0 75.0 101.0 129.0 106.0 74.0 91.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:92.50 stddev:6.17 (6.7%) stddev-sans-first:6.47 14:54:20 INFO - PID 1649 | Values: 92.0 112.0 94.0 92.0 94.0 92.0 93.0 92.0 93.0 92.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:101.20 Median:101.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 14:54:20 INFO - PID 1649 | Values: 102.0 101.0 101.0 102.0 102.0 101.0 101.0 100.0 101.0 101.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:101.40 Median:101.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 14:54:20 INFO - PID 1649 | Values: 102.0 101.0 101.0 101.0 102.0 102.0 100.0 101.0 103.0 101.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 14:54:20 INFO - PID 1649 | Values: 53.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 53.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:5.47 (8.2%) stddev-sans-first:4.95 14:54:20 INFO - PID 1649 | Values: 59.0 61.0 69.0 73.0 78.0 67.0 65.0 67.0 67.0 65.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:91.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 14:54:20 INFO - PID 1649 | Values: 92.0 91.0 90.0 93.0 92.0 92.0 90.0 90.0 91.0 89.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:171.70 Median:164.00 stddev:41.31 (25.2%) stddev-sans-first:43.13 14:54:20 INFO - PID 1649 | Values: 151.0 165.0 163.0 151.0 148.0 154.0 173.0 158.0 287.0 167.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.50 Median:202.00 stddev:18.93 (9.4%) stddev-sans-first:19.77 14:54:20 INFO - PID 1649 | Values: 198.0 200.0 203.0 200.0 191.0 205.0 201.0 223.0 256.0 198.0 14:54:20 INFO - PID 1649 | 14:54:20 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.40 Median:76.50 stddev:13.90 (18.2%) stddev-sans-first:14.55 14:54:20 INFO - PID 1649 | Values: 85.0 98.0 103.0 104.0 79.0 67.0 99.0 104.0 101.0 74.0 14:54:20 INFO - PID 1649 | -------- Summary: end -------- 14:54:20 INFO - PID 1649 | 14:54:21 INFO - PID 1649 | 1491602060995 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 14:54:22 INFO - TEST-INFO | 1649: exit 0 14:54:22 INFO - TEST-OK | kraken | took 63902ms 14:54:22 INFO - SUITE-END | took 1185s 14:54:22 INFO - Completed test suite (00:19:45) 14:54:22 INFO - javascript benchmark 14:54:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7703.433443270044, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3538.734594905382, 3542.0967653248417, 3559.697425718814, 3566.3580555500016, 3589.6589823966715, 5928.940710592893, 6111.69441527924, 6146.569740118193, 6229.906551401727, 6240.282367527736, 6159.445649891509, 6176.629402235858, 6204.069389591564, 6208.9379106209035, 6223.346548612399, 5239.240310155025, 5321.973390133044, 5412.9458705412835, 5419.430959749228, 5553.416891226424, 5484.862878428032, 5528.253685752412, 5537.390887002426, 5544.1960915667205, 5550.111982082867, 5274.55166310864, 5314.601404894648, 5335.973320133375, 5359.973200133974, 5483.0, 5341.1187154119525, 5348.625596208267, 5359.303290572239, 5360.865978350534, 5378.139497680391, 5277.12927366984, 5310.548603368718, 5329.946700532983, 5333.1733581294575, 5350.250964864922, 6132.306126318523, 6171.290301615282, 6274.654893980829, 6294.968525157345, 6295.937040629627, 6691.76578819739, 6713.899291510631, 6722.025306330604, 6725.0, 6735.831604209885, 5497.340319161686, 6338.82731694638, 6749.865002699968, 6833.965830170818, 6845.520813543054, 5291.682499050069, 6236.064590311445, 6268.341824108448, 6275.435210831047, 6277.309495955441, 5718.79984200551, 5722.828315150552, 6881.243063263037, 6895.55178913369, 6897.379235868796, 6255.624662520263, 6337.6197428154455, 6339.5562310637815, 6356.269029061717, 6573.474122070223, 6511.413972742476, 6523.64119973406, 6527.673616319165, 6528.0, 6532.248791389051, 5462.699551524624, 6412.9679351602945, 6424.871502569922, 6434.967825160844, 6445.387688169616, 6566.474682025427, 6609.239937407259, 6683.465322774166, 6690.59856408617, 6712.0, 5076.949230507722, 5257.342832145981, 5360.0, 5364.8122315718765, 5409.6213265071065, 3934.842606295716, 4709.293605959065, 4727.858164255078, 4784.856454306377, 4786.7845946932475, 6281.214848143982, 6322.462590679752, 6346.968265158737, 6349.396807303298, 6365.0452432134625, 6733.663316834139, 6775.322467753185, 6778.423833974069, 6799.4900382471515, 6809.7276108956075, 6128.295246046672, 6130.612163469723, 6157.907631385533, 6247.125402443661, 6278.811635650938, 5904.7342869570975, 5921.0, 5922.555808314393, 5961.5230781537375, 5980.312264089598, 6864.691088901011, 6867.0, 6931.341522555349, 6934.583924964519, 6939.583624982517, 6460.483161346987, 6534.8366290843105, 6684.598924064571, 6765.019072234597, 6766.966165169143, 6655.0, 6788.151481064867, 6865.656717164022, 6871.725130994704, 6884.173899132136, 6536.052272420377, 6575.572587781779, 6583.539152259296, 6586.47308215332, 6598.505112116514, 6712.295209002984, 6722.764703235363, 6726.02472641474, 6741.056252124805, 6752.122224110834, 6284.780032699016, 6351.650659213603, 6355.428011478989, 6431.614103153639, 6485.643289618927, 6255.124282600531, 6486.286508483969, 6510.18622672166, 6526.282108968105, 6558.0, 5280.3663560373, 6242.282137554058, 6269.843253918689, 6314.400131987454, 6333.6516491591565, 6312.621242725451, 6331.430171284606, 6339.1125242467015, 6342.143810585697, 6355.014972679242, 6303.086052522267, 6305.684715764285, 6355.269144048309, 6356.173697419306, 6362.236531616236], "value": 6040.926366998343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.9011373578303, 804.6097642643318, 1014.2291858187775, 1026.409814356745, 1028.2750660784143, 35379.469307960404, 35738.10654733633, 36133.45799813005, 36150.9154725358, 36180.91457256283, 37564.248715025686, 37783.62216377835, 37836.62163378365, 37928.62071379292, 38001.23997520048, 6055.2430946131735, 6195.28754193269, 8351.206635369645, 8527.530985795778, 8530.74407767768, 8321.292690121347, 8533.359998000144, 8563.35774816888, 8573.914260857406, 8584.0, 8586.656533738644, 8641.740747777576, 8650.221480066793, 8658.134186581323, 8667.349948753837, 8541.701040463586, 8609.009963854174, 8622.956885215533, 8628.007779105421, 8634.956825215897, 8413.03250126231, 8455.323574114056, 8456.0, 8457.873131903027, 8464.957675211646, 36095.63904360975, 36287.27425451476, 36296.0, 36306.0, 36422.90731278066, 3575.1955809942556, 3598.8920332389807, 3610.4584312353095, 3614.132608174046, 3618.656227658368, 29931.70068299311, 29968.85015574908, 30043.248918776986, 30053.549196762066, 30100.0, 3160.4943209086664, 3187.26692860641, 3218.1471909943884, 3222.7744057915957, 3226.6289376721743, 263671.0, 266534.0, 268853.0, 268914.6554267216, 270453.0, 39002.804985974886, 39517.40723889144, 39584.40623390651, 47310.5268947313, 47483.5251647486, 40107.0, 40112.0, 40139.79930100331, 40195.99510012273, 47596.28605570919, 12610.306433146081, 12666.050046246568, 12704.364781760874, 12758.170718903428, 12762.872371276355, 10258.58965641381, 10272.229582781321, 10288.794224115476, 10320.948395258125, 10344.896551034544, 12157.331346775836, 12162.574309899112, 12187.39063046844, 12198.939005304917, 12336.259824410565, 4357.847475338348, 5150.48495150482, 5161.612879034087, 5172.663776854492, 5197.324347834758, 1028.1671845804922, 1028.1980055556678, 1032.5353590884133, 1062.5537274344795, 1069.909057730086, 20980.05589748465, 22020.33938981833, 23179.420514486934, 23247.0, 23296.272596384497, 953.2278854128178, 1051.1748277602046, 1100.7468282295117, 1133.665568657248, 1153.8442310288171, 11718.472668729928, 11836.822447663291, 11868.0, 11924.0, 11930.403479826147, 346587.0, 346656.0, 347572.0, 347746.0, 348441.0, 50015.24977125346, 50167.0, 50179.74910125499, 50226.0, 50289.0, 1474.226031333537, 1482.392219190127, 1530.869876060525, 1535.0712818744498, 1537.9000364976241, 22715.0, 22731.88634056819, 22792.886035569714, 22880.08479660795, 22963.88518057399, 36468.27063458769, 36508.81745591255, 36579.817100914326, 36591.08522286964, 36640.81679591585, 320827.0, 321130.7886921101, 321489.31808750745, 321697.0, 322165.0, 29005.0, 29476.136437487574, 32399.35201296008, 33329.0, 33519.497207542394, 40675.0, 41163.794181028905, 41281.380779288935, 41349.586504134575, 41506.0, 27615.861920691073, 28531.572026419206, 28730.281742956595, 29061.41877162487, 29863.402731945673, 28076.438471230053, 28244.0, 28803.56794648124, 29265.853670732362, 29268.56097158502, 28309.0, 34277.65722342845, 34332.485012724326, 34373.968780936615, 34402.655973440946, 27305.590416143375, 27846.58230126509, 28686.42627147487, 29247.415051698423, 29727.55408668915, 20411.4897127573, 21425.55757975875, 21945.670814937468, 22570.7708517467, 22586.887065565224], "value": 16746.754430682926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.77432202161737, 427.53738466433356, 437.20428819548425, 441.3071477779886, 455.05802987815196, 17592.912035439822, 21117.472063198427, 21912.23307184249, 22616.643001419907, 22967.42581435465, 18972.62054758904, 21941.232056878012, 22184.33446996593, 22316.21893233733, 22600.0, 4269.466316710411, 5233.267342572033, 6288.24541055074, 6329.177206963089, 6331.050342448623, 6143.600665956721, 6239.719212635442, 6245.906311405332, 6247.094171345152, 6258.593191442542, 5442.6462279951875, 5966.910496342537, 5967.522598192134, 6196.318404975449, 6205.0, 5993.0, 6123.418275263843, 6206.193194884681, 6211.627302361872, 6214.25428948529, 5426.0, 5496.258005169291, 5501.202325662756, 5508.0, 5519.172124181365, 21280.04239809197, 25958.09146679876, 25966.221013369628, 25982.22053338403, 26227.868860655766, 2153.257126291427, 2222.466608014081, 2226.4545186429427, 2227.8440509164366, 2229.4537838229576, 17044.318227270895, 17219.483415497554, 17475.21361538734, 17645.470635880945, 17841.375551855625, 2119.448943274744, 2149.0973791007814, 2204.1183526589334, 2205.8014778669835, 2208.0726095040122, 143716.28141859328, 143751.84372234426, 144060.27969860085, 145761.0, 167925.0, 11355.829662555068, 11591.362475063785, 11615.664198617098, 12189.0, 12212.877871221352, 15007.574280443341, 15094.39622415091, 15757.921210394104, 16167.676646467005, 16188.595285117966, 8197.754067377988, 8203.138670439637, 8319.625616847135, 8428.283595894294, 8575.571221439028, 7623.504472209289, 7661.233876612294, 7707.036620422447, 7795.934077469475, 7823.887550361371, 6657.234418041987, 6691.26396096429, 6994.4404447644065, 7505.437092218105, 7609.162992070978, 2148.484363752719, 2158.2230397057047, 2171.6199665058552, 2180.9345719628436, 2323.7327707313875, 777.413053144872, 918.93108016899, 926.8100039491889, 961.0341606685377, 961.5864678921973, 19730.40808775739, 20408.489787755127, 20463.693044604344, 20541.97290135487, 20709.792902071087, 940.6519587752575, 951.6764300137986, 971.7522031881825, 983.2232536296245, 983.6311383231289, 10258.333208341433, 10620.203484738675, 10633.096186824052, 10687.625933092304, 10803.731216444477, 685159.0, 687574.0, 693685.0, 718119.0, 725107.0, 150672.2466387661, 155234.37187537568, 157625.0, 158162.0, 159552.0, 1118.2898859224451, 1136.8749437561862, 1159.5709587452527, 1160.5879912631062, 1168.2639936839907, 17089.471290107882, 17556.648867022333, 17557.297708092043, 17632.471025869243, 17973.460796176136, 55189.1721624184, 57407.0, 57990.4200957985, 58301.4169858296, 58356.0, 70095.64952175207, 86070.2785944265, 86606.0, 87955.0, 88696.11303886879, 6915.827104322432, 8347.165283471604, 8396.648938297287, 8820.25027872638, 8848.91151088481, 13297.933510332387, 13544.984126190771, 13567.728645427234, 13928.651783705489, 13975.720485590435, 11530.654080377602, 11685.357305347947, 11851.229670071763, 11863.881361186623, 12044.638660840188, 8763.554013587942, 10743.355398675792, 10793.730156746144, 11074.058705010164, 11231.15766317513, 11059.170562208028, 11457.541698331974, 11949.76100478003, 12214.816777748518, 12260.26438413698, 7861.567613781068, 8662.870056949025, 8915.821683566162, 9083.772905677411, 9084.0, 11649.708757281136, 11732.0, 12028.518859245532, 12073.698157546132, 12139.271643701406], "value": 10295.570737616335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.8488766235716, 1408.0566020766087, 1420.6945506716047, 1438.42463014794, 1439.6256973186971, 11283.830742538868, 11787.29276243425, 11793.469293881775, 11795.764084718301, 11806.704832379184, 11490.942545287262, 11493.885061149385, 11950.82073768892, 11963.1625786195, 11986.2208956418, 2491.725910149882, 2535.2521006303186, 2542.7838633716065, 2545.5672535668887, 2545.6054311581643, 2461.20010996426, 2474.035126300735, 2527.658766066585, 2533.0880882882147, 2537.4037101281183, 2395.993682653281, 2493.8004959603277, 2496.5755821510297, 2497.0261597976805, 2510.836795608289, 2479.2934013806157, 2509.498100379922, 2509.7992160627105, 2528.6459895614444, 2547.350425641468, 2472.394263405477, 2493.30187547487, 2501.562226610336, 2504.8622325772076, 2509.146890057389, 11472.369019703912, 11820.0, 11830.881691183064, 11840.644780656594, 11859.229150105215, 6427.903581446282, 6680.5991640501725, 6680.7661731839635, 6682.331766823328, 6691.297413771533, 3991.5808840071954, 4237.724547904407, 4327.567243275679, 4332.393464914914, 4361.476622805284, 1227.938603069852, 1258.7860063789178, 1312.0225432053087, 1316.9078164528487, 1318.0312470334297, 14601.0, 15088.698226035527, 16043.35826566936, 16306.0, 16474.505764827074, 4707.317438971399, 5331.493508116722, 5485.61600687956, 5627.5779316551425, 5634.070378387602, 12255.877441225473, 12286.447109880077, 12289.815652765215, 12300.81548776769, 12319.445624946899, 6484.481241500763, 6504.544681872224, 6505.739770409131, 6512.0, 6519.217693876671, 5208.453112423141, 5958.880822383528, 6090.177825993523, 6193.225846769154, 6242.1261023456755, 4055.945454181875, 4091.4067460218102, 4253.744775313491, 4366.912661746811, 4427.203103441347, 1294.5339677716015, 1294.540438144464, 1296.4878872845172, 1314.1917720601762, 1316.2036967634635, 686.4885660183096, 774.6049514747519, 800.2957397490288, 802.8996375453069, 810.1614828652316, 6023.518118550505, 6069.453749162597, 6175.258968923668, 6207.844803879939, 6301.243850737941, 483.2606112647655, 589.8525368657836, 593.483669207792, 596.2219303808572, 605.797057985571, 3899.629535194152, 4030.375291829771, 4185.853495127656, 4234.915301694011, 4245.724027938174, 14514.491992780202, 15095.622609434851, 15109.320080596399, 15130.319135638923, 15141.987373346072, 14988.250587470582, 15028.474003409829, 15035.669471231977, 15048.62378440526, 15049.0, 10466.581336746598, 10512.369257844553, 10918.1811364148, 10924.399158046384, 10962.342259464458, 5545.391836367408, 5753.827385178452, 6626.768063117768, 6912.654367281716, 6948.652567371712, 12865.935670321964, 12935.935320323339, 12979.805302920275, 12992.220466772023, 13037.217766934014, 13536.458541658223, 13854.16874987504, 13948.930255348658, 14037.438502459787, 14201.147931124166, 8372.204640559137, 8599.441036332619, 8600.311975042106, 8622.482651040958, 8628.309735221043, 10552.31409958381, 10651.680449586525, 10677.305975111592, 10678.359298442118, 10682.092022178202, 8753.212210901049, 9150.771230719285, 9217.078292170729, 9222.354435189472, 9289.535523223947, 8903.243224325746, 8940.46357218569, 8967.10328967098, 9012.2790176787, 9014.639414423613, 7951.681932722627, 8112.75661730149, 8129.0, 8138.470999385021, 8150.796230094295, 5891.1752354669525, 5905.793297234576, 6027.397260274113, 6082.60463069899, 6132.754689812357, 5902.1441890926435, 5957.702114894325, 6176.0, 6206.72069756853, 6330.272018717907], "value": 5309.795612734273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.78299093926614, 387.20236313194823, 400.6194115590189, 401.24165327530955, 402.8589993502273, 4839.2499162629765, 5779.7688092476355, 5903.26209223847, 5959.3146788119375, 5970.701464926752, 5651.5761317901115, 5666.688332141731, 5800.883982320351, 5830.329512106109, 5833.737481813318, 4289.05640759034, 4301.139772045588, 4315.503717072545, 4320.65434765218, 4325.48094228693, 3474.6525347465176, 3783.735138540303, 4181.581841815824, 4275.657947364203, 4339.291868322858, 3711.0, 3724.255148970203, 4236.851710190144, 4285.892852678677, 4306.88021114511, 3724.422714479233, 3799.8290076946605, 4020.155767288873, 4226.809793559281, 4251.4260574822465, 3568.0, 3611.2304970564232, 3718.4608231806506, 3735.7758534488016, 3759.342115129841, 5504.504594586507, 5620.269364982526, 5639.746211420496, 5648.406917273668, 5661.830145095653, 5046.899062018739, 5064.2403639454005, 5078.4921507849285, 5099.949000509984, 5109.744512774347, 6000.18997435345, 6028.153136449279, 6170.629762214281, 6176.4441200292185, 6201.875962480725, 4192.727472714294, 4198.942518166107, 4221.092465119983, 4221.936670949938, 4223.788810559459, 4471.1728330259, 5466.34403871534, 6138.956377415805, 6351.142595749515, 6448.421126274916, 3938.2517321708783, 4041.9191616167514, 4189.642771517588, 4236.364545318165, 4288.399624052635, 3826.9617303827163, 4345.760983145958, 4348.173767017797, 4354.477462704495, 4390.582894625006, 4415.315626077963, 4600.700954437951, 4814.711117332971, 5090.2364645303505, 5091.719955402488, 4903.632227582945, 5519.212797537299, 6268.862550716596, 6269.0, 6277.748890044347, 1453.731059753949, 1489.2330449818353, 1490.880729541634, 1491.2171110167249, 1500.5069955394451, 845.2688424512875, 930.3627015494408, 979.4280180310499, 982.5578489679673, 1005.9798804023878, 4926.0, 5610.691411972299, 5801.53587712982, 5806.68063256525, 5816.592838501264, 6421.29365769765, 6421.389967953037, 6452.22573291208, 6460.612363258219, 6461.0, 4725.267583524559, 5621.98804215237, 5728.713564321767, 5793.94206057934, 5802.6808525531505, 3048.268415580245, 3286.7863588867126, 3363.663633636617, 3390.423627983249, 3396.7452441066525, 5443.020256353815, 5717.770069672831, 6293.458102764852, 6326.977055468426, 6596.307387724316, 6084.908726369108, 6220.471259942956, 6511.321103576464, 6570.342965703391, 6608.570442921291, 5508.512701570554, 6059.939400605937, 6512.706928188148, 6553.8361540960905, 6564.409203171737, 5067.429096979948, 6309.886188127029, 6364.408897775556, 6420.357964203542, 6469.159009328757, 6266.023638771547, 6290.685465726604, 6327.936720632735, 6346.397092276226, 6370.617762934239, 5631.408702086222, 5643.735453646531, 6026.306974697965, 6041.365656605993, 6575.408213260829, 4213.199492096492, 4239.809208585682, 4243.554426785143, 4276.059266961263, 4284.271673815397, 4934.0, 5323.0950738373795, 5547.973624879411, 6129.578816367599, 6474.773382931575, 5349.893002140013, 6125.571210015434, 6157.507399408126, 6181.81454556364, 6217.533684973736, 6110.725017374318, 6123.234595675541, 6125.234345706786, 6152.538559608137, 6184.257889053342, 5040.445550989315, 5290.947090529199, 5674.233978412862, 6022.7289771959495, 6183.319834818257, 6223.471004964629, 6234.532410069353, 6246.4378205959865, 6248.187735594343, 6248.718807653576, 5801.506871915765, 5979.521638268841, 6082.391760823883, 6094.994325936348, 6108.57239993214], "value": 4478.076188408729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7509959064121, 760.5056713136462, 874.2874557235848, 876.9739404896271, 886.7073865624344, 13535.593932182039, 17916.731249031258, 18534.44396668102, 18573.62852742948, 18575.442736717887, 17151.91424042881, 17634.559136021573, 17770.466885993443, 17797.55506112348, 17800.64398712025, 965.0831709875629, 995.6564985080136, 996.432033740768, 998.2114129837456, 1000.6547741029333, 657.9703913323912, 682.8122266376761, 962.8700125483075, 1007.9344842585245, 1011.413380239463, 1059.0, 1060.1571750458404, 1060.9628662996797, 1062.7980683670116, 1063.0591926145378, 1043.5564884923915, 1044.9686509404692, 1045.9058684718411, 1046.7540128069897, 1047.6647472808704, 766.0156698642218, 768.6502641298196, 768.7808974442257, 771.2750014985951, 771.4098714483424, 16477.58806029847, 16784.496465106065, 16817.075060871648, 16996.745048824276, 17268.481945541655, 16018.199090045568, 16379.344826206938, 16593.50219493405, 16614.252358643767, 16642.0, 15390.461333853262, 15441.459548915846, 15676.137812420313, 15730.685386292325, 15758.606034849106, 4675.88310292242, 5270.235815806686, 5337.0, 5337.70642614656, 5342.813001544966, 97957.0204297955, 100503.49748251212, 100751.0, 101792.0, 106370.93629063688, 11415.942920285512, 11789.115816313812, 13481.662958426117, 13749.862501375059, 13917.23455209953, 19508.12213450398, 19997.200111995357, 22423.32730018102, 24878.5024299513, 25033.87483062573, 8736.301095912311, 8740.825183496421, 8895.199432051017, 8998.775030624156, 9038.322125840588, 4508.1659892919915, 4573.81704731807, 4586.862394128181, 4606.907861842745, 4614.054118905617, 4272.807723652443, 4389.604935555815, 4681.531846815291, 4817.156997525419, 4883.072216278895, 960.6925783749133, 976.0776066616979, 993.3493561717087, 994.7562847102362, 995.9053889880449, 656.9605823650596, 666.5967089910631, 669.2404121322335, 681.495693187038, 689.4449967775888, 10944.343339399662, 11495.827562586568, 11839.05287577009, 11904.583339583072, 12050.578229761917, 593.6705128653552, 611.8802591257987, 649.6199723161909, 666.3436515032689, 686.7664993902097, 5259.789608415621, 5306.52241298285, 5465.0, 5555.194496797942, 5655.462731040545, 100658.49670751746, 100710.0, 101408.0, 101834.0, 102608.0, 89298.21403571892, 90415.0, 90663.54668226617, 91540.54229728809, 92592.0, 73760.63119684368, 73812.26187738054, 74317.25682743211, 74563.0, 75958.86061709079, 9471.526423678926, 9992.850107248543, 10629.681109566725, 11025.17311201647, 11984.880151198377, 32249.838750806095, 40631.59368406396, 40873.0, 41347.0, 41910.79044604758, 49820.50179498159, 67593.32406675871, 69258.65370673114, 69439.0, 69844.6507767458, 13706.560811115089, 16269.755953660468, 16506.83493165053, 16738.497845064667, 16861.0, 17068.975861448354, 17233.310667573158, 17413.390531331344, 17568.472945811645, 18406.26374944987, 16274.593135171715, 16358.0, 16394.344226231293, 16552.66894662076, 16708.49874503767, 16570.668586628442, 16632.3347066116, 16643.91678041602, 16786.748198776782, 16803.37907075564, 16192.919035404748, 16316.755248671518, 16346.918265408596, 16352.754708679617, 16489.257983390537, 11576.652700419001, 11615.593454229062, 11952.46213920393, 12082.214656047328, 12231.0, 12274.509019639114, 12674.683132921382, 12705.618831435071, 12708.173968692005, 13052.15161014531], "value": 8437.623077183505, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 121.0, 123.0, 124.0, 122.0, 123.0, 124.0, 123.0, 124.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 152.0, 196.0, 119.0, 119.0, 118.0, 122.0, 141.0, 117.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 214.0, 213.0, 209.0, 209.0, 219.0, 216.0, 213.0, 212.0, 217.0], "value": 213.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 62.0, 66.0, 101.0, 66.0, 66.0, 63.0, 65.0, 84.0, 64.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 75.0, 95.0, 74.0, 75.0, 101.0, 129.0, 106.0, 74.0, 91.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 112.0, 94.0, 92.0, 94.0, 92.0, 93.0, 92.0, 93.0, 92.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 101.0, 102.0, 102.0, 101.0, 101.0, 100.0, 101.0, 101.0], "value": 101.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 101.0, 101.0, 102.0, 102.0, 100.0, 101.0, 103.0, 101.0], "value": 101.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 69.0, 73.0, 78.0, 67.0, 65.0, 67.0, 67.0, 65.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 93.0, 92.0, 92.0, 90.0, 90.0, 91.0, 89.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 165.0, 163.0, 151.0, 148.0, 154.0, 173.0, 158.0, 287.0, 167.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 203.0, 200.0, 191.0, 205.0, 201.0, 223.0, 256.0, 198.0], "value": 207.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 98.0, 103.0, 104.0, 79.0, 67.0, 99.0, 104.0, 101.0, 74.0], "value": 91.4, "unit": "score"}]}]} 14:54:22 INFO - Return code: 0 14:54:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:54:22 ERROR - # TBPL SUCCESS # 14:54:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:54:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:54:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:54:22 INFO - 2017-04-07 14:54:22.285 screenresolution[1653:10228] starting screenresolution argv=screenresolution get 14:54:22 INFO - 2017-04-07 14:54:22.290 screenresolution[1653:10228] Display 0: 1600x1200x32@60 14:54:22 INFO - 2017-04-07 14:54:22.296 screenresolution[1654:10231] starting screenresolution argv=screenresolution list 14:54:22 INFO - Available Modes on Display 0 14:54:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:54:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:54:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:54:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:54:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:54:22 INFO - Intel Iris: 14:54:22 INFO - Chipset Model: Intel Iris 14:54:22 INFO - Type: GPU 14:54:22 INFO - Bus: Built-In 14:54:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:54:22 INFO - Vendor: Intel (0x8086) 14:54:22 INFO - Device ID: 0x0a2e 14:54:22 INFO - Revision ID: 0x0009 14:54:22 INFO - Displays: 14:54:22 INFO - Display: 14:54:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:54:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:54:22 INFO - Display Serial Number: 1600x1200 60 14:54:22 INFO - Main Display: Yes 14:54:22 INFO - Mirror: Off 14:54:22 INFO - Online: Yes 14:54:22 INFO - Rotation: Supported 14:54:22 INFO - Return code: 0 14:54:22 INFO - Running post-action listener: _resource_record_post_action 14:54:22 INFO - [mozharness: 2017-04-07 21:54:22.544343Z] Finished run-tests step (success) 14:54:22 INFO - Running post-run listener: _resource_record_post_run 14:54:22 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 38859776; Write bytes: 515388928; Read time: 350; Write time: 1601 14:54:22 INFO - TinderboxPrint: CPU usage
53.6% 14:54:22 INFO - TinderboxPrint: I/O read bytes / time
38,859,776 / 350 14:54:22 INFO - TinderboxPrint: I/O write bytes / time
515,388,928 / 1,601 14:54:22 INFO - TinderboxPrint: CPU idle
2,237.5 (46.4%) 14:54:22 INFO - TinderboxPrint: CPU system
966.4 (20.0%) 14:54:22 INFO - TinderboxPrint: CPU user
1,617.8 (33.6%) 14:54:22 INFO - TinderboxPrint: Swap in / out
245,256,192 / 0 14:54:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205187584; Write bytes: 203879936; Read time: 15893; Write time: 421 14:54:22 INFO - run-tests - Wall time: 1186s; CPU: 54.0%; Read bytes: 36656128; Write bytes: 304308224; Read time: 326; Write time: 1152 14:54:23 INFO - Running post-run listener: _upload_blobber_files 14:54:23 INFO - Blob upload gear active. 14:54:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:54:23 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 14:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:54:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:54:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:54:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:54:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:24 INFO - (blobuploader) - INFO - Done attempting. 14:54:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:54:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:54:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:25 INFO - (blobuploader) - INFO - Done attempting. 14:54:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:54:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:26 INFO - (blobuploader) - INFO - Done attempting. 14:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:54:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:28 INFO - (blobuploader) - INFO - Done attempting. 14:54:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:54:28 INFO - Return code: 0 14:54:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:54:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:54:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34180323253d5aa5f9fc50c0afb5882298d8ee008bd32417459d9dc8f20a3d6ca7ad6a9f53fa3f1cc00ba7523f432d30d79e78b65ea2bb59e0591a5ce8f2895b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ece4c692bc4e527dc07836973c4bd73390ab1f656228d4c87e25e8a4d3250e02a97b422b57cbd3c30f82d022875c9219f09287cb333039ebd6167a1e05b1081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d017e56e9343a43446141bfb75852bc376ceb28b228113c8472a3310acc3175577d7d2fc879c9e7bdbc4f85c1066e1f6d14455b4eee8207e23f3cc65bfc8d0ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9db632d4a40b82e79f03b1f6337129199acccd759aa9ab860d392df94c7340eae070fe39ba3f37b9e6dee1cbe9e07f4c65c2891bf1ac5bd97240b79d0427f37"} 14:54:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:54:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:54:28 INFO - Contents: 14:54:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34180323253d5aa5f9fc50c0afb5882298d8ee008bd32417459d9dc8f20a3d6ca7ad6a9f53fa3f1cc00ba7523f432d30d79e78b65ea2bb59e0591a5ce8f2895b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ece4c692bc4e527dc07836973c4bd73390ab1f656228d4c87e25e8a4d3250e02a97b422b57cbd3c30f82d022875c9219f09287cb333039ebd6167a1e05b1081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d017e56e9343a43446141bfb75852bc376ceb28b228113c8472a3310acc3175577d7d2fc879c9e7bdbc4f85c1066e1f6d14455b4eee8207e23f3cc65bfc8d0ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9db632d4a40b82e79f03b1f6337129199acccd759aa9ab860d392df94c7340eae070fe39ba3f37b9e6dee1cbe9e07f4c65c2891bf1ac5bd97240b79d0427f37"} 14:54:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:54:28 INFO - Copying logs to upload dir... 14:54:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:54:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.625871 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-07 14:54:28.449702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:28.453422) ========= 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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34180323253d5aa5f9fc50c0afb5882298d8ee008bd32417459d9dc8f20a3d6ca7ad6a9f53fa3f1cc00ba7523f432d30d79e78b65ea2bb59e0591a5ce8f2895b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ece4c692bc4e527dc07836973c4bd73390ab1f656228d4c87e25e8a4d3250e02a97b422b57cbd3c30f82d022875c9219f09287cb333039ebd6167a1e05b1081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d017e56e9343a43446141bfb75852bc376ceb28b228113c8472a3310acc3175577d7d2fc879c9e7bdbc4f85c1066e1f6d14455b4eee8207e23f3cc65bfc8d0ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9db632d4a40b82e79f03b1f6337129199acccd759aa9ab860d392df94c7340eae070fe39ba3f37b9e6dee1cbe9e07f4c65c2891bf1ac5bd97240b79d0427f37"} build_url:https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/GMZh00GYQxGlVVYHeKh4vQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34180323253d5aa5f9fc50c0afb5882298d8ee008bd32417459d9dc8f20a3d6ca7ad6a9f53fa3f1cc00ba7523f432d30d79e78b65ea2bb59e0591a5ce8f2895b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ece4c692bc4e527dc07836973c4bd73390ab1f656228d4c87e25e8a4d3250e02a97b422b57cbd3c30f82d022875c9219f09287cb333039ebd6167a1e05b1081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d017e56e9343a43446141bfb75852bc376ceb28b228113c8472a3310acc3175577d7d2fc879c9e7bdbc4f85c1066e1f6d14455b4eee8207e23f3cc65bfc8d0ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9db632d4a40b82e79f03b1f6337129199acccd759aa9ab860d392df94c7340eae070fe39ba3f37b9e6dee1cbe9e07f4c65c2891bf1ac5bd97240b79d0427f37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:28.488027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:28.488357) ========= 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.Aa9RBeZOEm/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.C5zJDabGy8/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005178 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 14:54:28.536718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 14:54:28.537023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 14:54:28.537333) ========= ========= Total master_lag: 0.17 =========