builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0031 starttime: 1487163163.35 results: success (0) buildid: 20170215032545 builduid: 1c59bbda411944e4b36480690ce25b82 revision: c0807d6938c13e43add377d5838df7168a59971e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.351270) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.351733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.352012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.378375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.378720) ========= 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.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 04:52:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 50.1M=0s 2017-02-15 04:52:43 (50.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098468 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.507199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.507511) ========= 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.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.028774 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:43.557744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 04:52:43.558091) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0807d6938c13e43add377d5838df7168a59971e --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 c0807d6938c13e43add377d5838df7168a59971e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 04:52:43,657 truncating revision to first 12 chars 2017-02-15 04:52:43,657 Setting DEBUG logging. 2017-02-15 04:52:43,658 attempt 1/10 2017-02-15 04:52:43,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0807d6938c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 04:52:44,378 unpacking tar archive at: mozilla-central-c0807d6938c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 04:52:44.571069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:44.571387) ========= script_repo_revision: c0807d6938c13e43add377d5838df7168a59971e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:44.571780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:44.572040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 04:52:44.592121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-15 04:52:44.592509) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:52:44 INFO - MultiFileLogger online at 20170215 04:52:44 in /builds/slave/test 04:52:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:52:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:44 INFO - {'append_to_log': False, 04:52:44 INFO - 'base_work_dir': '/builds/slave/test', 04:52:44 INFO - 'blob_upload_branch': 'Firefox', 04:52:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:44 INFO - 'branch': 'Firefox', 04:52:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:44 INFO - 'config_files': ('talos/mac_config.py',), 04:52:44 INFO - 'default_actions': ('clobber', 04:52:44 INFO - 'read-buildbot-config', 04:52:44 INFO - 'download-and-extract', 04:52:44 INFO - 'populate-webroot', 04:52:44 INFO - 'create-virtualenv', 04:52:44 INFO - 'install', 04:52:44 INFO - 'run-tests'), 04:52:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:44 INFO - 'download_minidump_stackwalk': True, 04:52:44 INFO - 'download_symbols': 'ondemand', 04:52:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:44 INFO - 'installer_path': 'installer.exe', 04:52:44 INFO - 'log_level': 'info', 04:52:44 INFO - 'log_name': 'talos', 04:52:44 INFO - 'log_to_console': True, 04:52:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:52:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:52:44 INFO - 'opt_config_files': (), 04:52:44 INFO - 'pip_index': False, 04:52:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:44 INFO - 'cmd': ('bash', 04:52:44 INFO - '-c', 04:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:44 INFO - 'enabled': True, 04:52:44 INFO - 'halt_on_failure': False, 04:52:44 INFO - 'name': 'check_screen_resolution'},), 04:52:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:44 INFO - 'cmd': ('bash', 04:52:44 INFO - '-c', 04:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:44 INFO - 'enabled': True, 04:52:44 INFO - 'halt_on_failure': False, 04:52:44 INFO - 'name': 'check_screen_resolution'},), 04:52:44 INFO - 'run_cmd_checks_enabled': True, 04:52:44 INFO - 'sps_profile': False, 04:52:44 INFO - 'sps_profile_interval': 0, 04:52:44 INFO - 'suite': 'dromaeojs-e10s', 04:52:44 INFO - 'system_bits': '32', 04:52:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:44 INFO - 'title': 't-yosemite-r7-0031', 04:52:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:44 INFO - 'use_talos_json': True, 04:52:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:44 INFO - 'work_dir': 'build'} 04:52:44 INFO - [mozharness: 2017-02-15 12:52:44.804560Z] Running clobber step. 04:52:44 INFO - Running pre-action listener: _resource_record_pre_action 04:52:44 INFO - Running main action method: clobber 04:52:44 INFO - rmtree: /builds/slave/test/build 04:52:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:47 INFO - Running post-action listener: _resource_record_post_action 04:52:47 INFO - [mozharness: 2017-02-15 12:52:47.259833Z] Finished clobber step (success) 04:52:47 INFO - [mozharness: 2017-02-15 12:52:47.260028Z] Running read-buildbot-config step. 04:52:47 INFO - Running pre-action listener: _resource_record_pre_action 04:52:47 INFO - Running main action method: read_buildbot_config 04:52:47 INFO - Using buildbot properties: 04:52:47 INFO - { 04:52:47 INFO - "project": "", 04:52:47 INFO - "product": "firefox", 04:52:47 INFO - "script_repo_revision": "production", 04:52:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:52:47 INFO - "repository": "", 04:52:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:52:47 INFO - "buildid": "20170215032545", 04:52:47 INFO - "pgo_build": "False", 04:52:47 INFO - "basedir": "/builds/slave/test", 04:52:47 INFO - "buildnumber": 89, 04:52:47 INFO - "slavename": "t-yosemite-r7-0031", 04:52:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:52:47 INFO - "platform": "yosemite_r7", 04:52:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:52:47 INFO - "branch": "mozilla-central", 04:52:47 INFO - "repo_path": "mozilla-central", 04:52:47 INFO - "revision": "c0807d6938c13e43add377d5838df7168a59971e", 04:52:47 INFO - "stage_platform": "macosx64", 04:52:47 INFO - "builduid": "1c59bbda411944e4b36480690ce25b82", 04:52:47 INFO - "slavebuilddir": "test" 04:52:47 INFO - } 04:52:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:52:47 INFO - Running post-action listener: _resource_record_post_action 04:52:47 INFO - [mozharness: 2017-02-15 12:52:47.263361Z] Finished read-buildbot-config step (success) 04:52:47 INFO - [mozharness: 2017-02-15 12:52:47.263463Z] Running download-and-extract step. 04:52:47 INFO - Running pre-action listener: _resource_record_pre_action 04:52:47 INFO - Running main action method: download_and_extract 04:52:47 INFO - mkdir: /builds/slave/test/build/tests 04:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:47 INFO - trying https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:52:48 INFO - Downloaded 1199 bytes. 04:52:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:52:48 INFO - Using the following test package requirements: 04:52:48 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:52:48 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:48 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:52:48 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'jsshell-mac.zip'], 04:52:48 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:52:48 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:52:48 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:52:48 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:52:48 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:52:48 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:52:48 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:52:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:48 INFO - Fetch https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:52:50 INFO - Expected file size: 51446553 04:52:50 INFO - Obtained file size: 51446553 04:53:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:53:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:53:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:53:06 INFO - Fetch https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:53:07 INFO - Expected file size: 51446553 04:53:07 INFO - Obtained file size: 51446553 04:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:53:23 INFO - Expected file size: 14403647 04:53:23 INFO - Obtained file size: 14403647 04:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:24 INFO - trying https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:53:26 INFO - Downloaded 70497201 bytes. 04:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:53:26 INFO - mkdir: /builds/slave/test/properties 04:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:26 INFO - Contents: 04:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:53:26 INFO - Running post-action listener: _resource_record_post_action 04:53:26 INFO - Running post-action listener: set_extra_try_arguments 04:53:26 INFO - [mozharness: 2017-02-15 12:53:26.831104Z] Finished download-and-extract step (success) 04:53:26 INFO - [mozharness: 2017-02-15 12:53:26.831226Z] Running populate-webroot step. 04:53:26 INFO - Running pre-action listener: _resource_record_pre_action 04:53:26 INFO - Running main action method: populate_webroot 04:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:26 INFO - '--tppagecycles', 04:53:26 INFO - '7'], 04:53:26 INFO - 'tests': ['tsvgm']}}, 04:53:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['damp', 'tps']}, 04:53:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'tests': ['damp', 'tps']}, 04:53:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['dromaeo_dom']}, 04:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['basic_compositor_video']}, 04:53:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:53:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['a11yr', 04:53:26 INFO - 'ts_paint', 04:53:26 INFO - 'tpaint', 04:53:26 INFO - 'sessionrestore', 04:53:26 INFO - 'sessionrestore_no_auto_restore', 04:53:26 INFO - 'tabpaint']}, 04:53:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['tsvgx', 04:53:26 INFO - 'tsvgr_opacity', 04:53:26 INFO - 'tart', 04:53:26 INFO - 'tscrollx', 04:53:26 INFO - 'cart', 04:53:26 INFO - 'tsvg_static']}, 04:53:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:26 INFO - 'tsvgr_opacity', 04:53:26 INFO - 'tart', 04:53:26 INFO - 'tscrollx', 04:53:26 INFO - 'cart', 04:53:26 INFO - 'tsvg_static']}, 04:53:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'talos_options': ['--disable-e10s'], 04:53:26 INFO - 'tests': ['tp5o']}, 04:53:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:53:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'talos_options': ['--disable-e10s', 04:53:26 INFO - '--xperf_path', 04:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:26 INFO - 'tests': ['tp5n']}, 04:53:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:53:26 INFO - 'talos_options': ['--xperf_path', 04:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:26 INFO - 'tests': ['tp5n']}}, 04:53:26 INFO - 'talos.zip': {'path': '', 04:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:26 INFO - Running post-action listener: _resource_record_post_action 04:53:26 INFO - [mozharness: 2017-02-15 12:53:26.849863Z] Finished populate-webroot step (success) 04:53:26 INFO - [mozharness: 2017-02-15 12:53:26.849972Z] Running create-virtualenv step. 04:53:26 INFO - Running pre-action listener: _resource_record_pre_action 04:53:26 INFO - Running main action method: create_virtualenv 04:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:26 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 04:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:26 INFO - Using real prefix '/tools/python27' 04:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:30 INFO - Installing pip.................done. 04:53:30 INFO - Return code: 0 04:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:30 INFO - Reading from file tmpfile_stdout 04:53:30 INFO - Output received: 04:53:30 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) 04:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:30 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 04:53:30 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 04:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:30 INFO - 'HOME': '/Users/cltbld', 04:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:30 INFO - 'LOGNAME': 'cltbld', 04:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:30 INFO - 'MOZ_NO_REMOTE': '1', 04:53:30 INFO - 'NO_EM_RESTART': '1', 04:53:30 INFO - 'PAGER': '/bin/cat', 04:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:30 INFO - 'PWD': '/builds/slave/test', 04:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:30 INFO - 'SHELL': '/bin/bash', 04:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:30 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:30 INFO - 'USER': 'cltbld', 04:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:30 INFO - 'XPC_FLAGS': '0x0', 04:53:30 INFO - 'XPC_SERVICE_NAME': '0', 04:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:31 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 04:53:31 INFO - Cleaning up... 04:53:31 INFO - Return code: 0 04:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:31 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 04:53:31 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 04:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:31 INFO - 'HOME': '/Users/cltbld', 04:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:31 INFO - 'LOGNAME': 'cltbld', 04:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:31 INFO - 'MOZ_NO_REMOTE': '1', 04:53:31 INFO - 'NO_EM_RESTART': '1', 04:53:31 INFO - 'PAGER': '/bin/cat', 04:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:31 INFO - 'PWD': '/builds/slave/test', 04:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:31 INFO - 'SHELL': '/bin/bash', 04:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:31 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:31 INFO - 'USER': 'cltbld', 04:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:31 INFO - 'XPC_FLAGS': '0x0', 04:53:31 INFO - 'XPC_SERVICE_NAME': '0', 04:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:31 INFO - Downloading/unpacking psutil>=3.1.1 04:53:31 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 04:53:31 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 04:53:31 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 04:53:31 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 04:53:31 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 04:53:31 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 04:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:34 INFO - Installing collected packages: psutil 04:53:34 INFO - Running setup.py install for psutil 04:53:35 INFO - building 'psutil._psutil_osx' extension 04:53:35 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 04:53:35 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 04:53:35 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 04:53:35 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 04:53:35 INFO - building 'psutil._psutil_posix' extension 04:53:35 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 04:53:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:35 INFO - ^ 04:53:35 INFO - 1 warning generated. 04:53:35 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 04:53:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:36 INFO - Successfully installed psutil 04:53:36 INFO - Cleaning up... 04:53:36 INFO - Return code: 0 04:53:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:36 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:36 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 04:53:36 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 04:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:36 INFO - 'HOME': '/Users/cltbld', 04:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:36 INFO - 'LOGNAME': 'cltbld', 04:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:36 INFO - 'MOZ_NO_REMOTE': '1', 04:53:36 INFO - 'NO_EM_RESTART': '1', 04:53:36 INFO - 'PAGER': '/bin/cat', 04:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:36 INFO - 'PWD': '/builds/slave/test', 04:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:36 INFO - 'SHELL': '/bin/bash', 04:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:36 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:36 INFO - 'USER': 'cltbld', 04:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:36 INFO - 'XPC_FLAGS': '0x0', 04:53:36 INFO - 'XPC_SERVICE_NAME': '0', 04:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:39 INFO - Installing collected packages: mozsystemmonitor 04:53:39 INFO - Running setup.py install for mozsystemmonitor 04:53:39 INFO - Successfully installed mozsystemmonitor 04:53:39 INFO - Cleaning up... 04:53:39 INFO - Return code: 0 04:53:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:40 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 04:53:40 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 04:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:40 INFO - 'HOME': '/Users/cltbld', 04:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:40 INFO - 'LOGNAME': 'cltbld', 04:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:40 INFO - 'MOZ_NO_REMOTE': '1', 04:53:40 INFO - 'NO_EM_RESTART': '1', 04:53:40 INFO - 'PAGER': '/bin/cat', 04:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:40 INFO - 'PWD': '/builds/slave/test', 04:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:40 INFO - 'SHELL': '/bin/bash', 04:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:40 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:40 INFO - 'USER': 'cltbld', 04:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:40 INFO - 'XPC_FLAGS': '0x0', 04:53:40 INFO - 'XPC_SERVICE_NAME': '0', 04:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:40 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 04:53:40 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 04:53:40 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 04:53:40 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 04:53:40 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 04:53:40 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 04:53:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:43 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 04:53:43 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 04:53:43 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 04:53:43 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 04:53:43 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 04:53:43 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 04:53:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:43 INFO - warning: no files found matching '*.txt' 04:53:43 INFO - no previously-included directories found matching 'build' 04:53:43 INFO - no previously-included directories found matching 'dist' 04:53:43 INFO - no previously-included directories found matching '.git*' 04:53:43 INFO - Installing collected packages: jsonschema, functools32 04:53:43 INFO - Running setup.py install for functools32 04:53:43 INFO - warning: no files found matching '*.txt' 04:53:43 INFO - no previously-included directories found matching 'build' 04:53:43 INFO - no previously-included directories found matching 'dist' 04:53:43 INFO - no previously-included directories found matching '.git*' 04:53:43 INFO - Successfully installed jsonschema functools32 04:53:43 INFO - Cleaning up... 04:53:44 INFO - Return code: 0 04:53:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:44 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 04:53:44 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 04:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:44 INFO - 'HOME': '/Users/cltbld', 04:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:44 INFO - 'LOGNAME': 'cltbld', 04:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:44 INFO - 'MOZ_NO_REMOTE': '1', 04:53:44 INFO - 'NO_EM_RESTART': '1', 04:53:44 INFO - 'PAGER': '/bin/cat', 04:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:44 INFO - 'PWD': '/builds/slave/test', 04:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:44 INFO - 'SHELL': '/bin/bash', 04:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:44 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:44 INFO - 'USER': 'cltbld', 04:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:44 INFO - 'XPC_FLAGS': '0x0', 04:53:44 INFO - 'XPC_SERVICE_NAME': '0', 04:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:44 INFO - Cleaning up... 04:53:44 INFO - Return code: 0 04:53:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:44 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 04:53:44 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 04:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:44 INFO - 'HOME': '/Users/cltbld', 04:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:44 INFO - 'LOGNAME': 'cltbld', 04:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:44 INFO - 'MOZ_NO_REMOTE': '1', 04:53:44 INFO - 'NO_EM_RESTART': '1', 04:53:44 INFO - 'PAGER': '/bin/cat', 04:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:44 INFO - 'PWD': '/builds/slave/test', 04:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:44 INFO - 'SHELL': '/bin/bash', 04:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:44 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:44 INFO - 'USER': 'cltbld', 04:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:44 INFO - 'XPC_FLAGS': '0x0', 04:53:44 INFO - 'XPC_SERVICE_NAME': '0', 04:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - Downloading docopt-0.6.1.tar.gz 04:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:48 INFO - Running setup.py install for blobuploader 04:53:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:49 INFO - Running setup.py install for requests 04:53:49 INFO - Running setup.py install for docopt 04:53:49 INFO - Successfully installed blobuploader requests docopt 04:53:49 INFO - Cleaning up... 04:53:49 INFO - Return code: 0 04:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:49 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 04:53:49 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 04:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:49 INFO - 'HOME': '/Users/cltbld', 04:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:49 INFO - 'LOGNAME': 'cltbld', 04:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:49 INFO - 'MOZ_NO_REMOTE': '1', 04:53:49 INFO - 'NO_EM_RESTART': '1', 04:53:49 INFO - 'PAGER': '/bin/cat', 04:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:49 INFO - 'PWD': '/builds/slave/test', 04:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:49 INFO - 'SHELL': '/bin/bash', 04:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:49 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:49 INFO - 'USER': 'cltbld', 04:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:49 INFO - 'XPC_FLAGS': '0x0', 04:53:49 INFO - 'XPC_SERVICE_NAME': '0', 04:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-nEg1bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-j6hucc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-nZFEVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FO515P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ewAli_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YH23cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-EgaTtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-olOhIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-aeEJwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-mUSkVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GpvEKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-J6w9XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-RBX_Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-RUBk10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-lJC8wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kO7OYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Nl3cAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:51 INFO - Running setup.py install for manifestparser 04:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozcrash 04:53:52 INFO - Running setup.py install for mozdebug 04:53:52 INFO - Running setup.py install for mozdevice 04:53:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozfile 04:53:52 INFO - Running setup.py install for mozhttpd 04:53:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozinfo 04:53:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozInstall 04:53:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Running setup.py install for mozleak 04:53:53 INFO - Running setup.py install for mozlog 04:53:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Running setup.py install for moznetwork 04:53:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Running setup.py install for mozprocess 04:53:53 INFO - Running setup.py install for mozprofile 04:53:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Running setup.py install for mozrunner 04:53:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:54 INFO - Running setup.py install for mozscreenshot 04:53:54 INFO - Running setup.py install for moztest 04:53:54 INFO - Running setup.py install for mozversion 04:53:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:54 INFO - Cleaning up... 04:53:54 INFO - Return code: 0 04:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:54 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:54 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 04:53:54 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 04:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:54 INFO - 'HOME': '/Users/cltbld', 04:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:54 INFO - 'LOGNAME': 'cltbld', 04:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:54 INFO - 'MOZ_NO_REMOTE': '1', 04:53:54 INFO - 'NO_EM_RESTART': '1', 04:53:54 INFO - 'PAGER': '/bin/cat', 04:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:54 INFO - 'PWD': '/builds/slave/test', 04:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:54 INFO - 'SHELL': '/bin/bash', 04:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:54 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:54 INFO - 'USER': 'cltbld', 04:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:54 INFO - 'XPC_FLAGS': '0x0', 04:53:54 INFO - 'XPC_SERVICE_NAME': '0', 04:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UZtfQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:54 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)) 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5NxX9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:54 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)) 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Q9Miie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-dgdwXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-g2IhOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Abk43f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-bx4z7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7CG_Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-BVGXXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-nQzviY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Eg7EOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:55 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)) 04:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kVV45B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-lDTMUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:56 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)) 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-wLlmkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:56 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)) 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-3fD0DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:56 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)) 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Zd6LZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:56 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)) 04:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-4fG7Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:59 INFO - Downloading blessings-1.6.tar.gz 04:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:59 INFO - Installing collected packages: blessings 04:53:59 INFO - Running setup.py install for blessings 04:53:59 INFO - Successfully installed blessings 04:53:59 INFO - Cleaning up... 04:53:59 INFO - Return code: 0 04:53:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:59 INFO - Reading from file tmpfile_stdout 04:53:59 INFO - Current package versions: 04:53:59 INFO - blessings == 1.6 04:53:59 INFO - blobuploader == 1.2.4 04:53:59 INFO - docopt == 0.6.1 04:53:59 INFO - functools32 == 3.2.3-2 04:53:59 INFO - jsonschema == 2.5.1 04:53:59 INFO - manifestparser == 1.1 04:53:59 INFO - mozInstall == 1.12 04:53:59 INFO - mozcrash == 1.0 04:53:59 INFO - mozdebug == 0.1 04:53:59 INFO - mozdevice == 0.49 04:53:59 INFO - mozfile == 1.2 04:53:59 INFO - mozhttpd == 0.7 04:53:59 INFO - mozinfo == 0.9 04:53:59 INFO - mozleak == 0.1 04:53:59 INFO - mozlog == 3.4 04:53:59 INFO - moznetwork == 0.27 04:53:59 INFO - mozprocess == 0.24 04:53:59 INFO - mozprofile == 0.28 04:53:59 INFO - mozrunner == 6.13 04:53:59 INFO - mozscreenshot == 0.1 04:53:59 INFO - mozsystemmonitor == 0.3 04:53:59 INFO - moztest == 0.8 04:53:59 INFO - mozversion == 1.4 04:53:59 INFO - psutil == 3.1.1 04:53:59 INFO - requests == 1.2.3 04:53:59 INFO - wsgiref == 0.1.2 04:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:59 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')]} 04:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 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')]} 04:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:59 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 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:53:59 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 04:53:59 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 04:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:59 INFO - 'HOME': '/Users/cltbld', 04:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:59 INFO - 'LOGNAME': 'cltbld', 04:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:59 INFO - 'MOZ_NO_REMOTE': '1', 04:53:59 INFO - 'NO_EM_RESTART': '1', 04:53:59 INFO - 'PAGER': '/bin/cat', 04:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:59 INFO - 'PWD': '/builds/slave/test', 04:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:59 INFO - 'SHELL': '/bin/bash', 04:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:53:59 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:59 INFO - 'USER': 'cltbld', 04:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:59 INFO - 'XPC_FLAGS': '0x0', 04:53:59 INFO - 'XPC_SERVICE_NAME': '0', 04:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 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)) 04:54:00 INFO - Cleaning up... 04:54:00 INFO - Return code: 0 04:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b920768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85395b3920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, '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.dllb9DI8jF/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.F6Ulndz8uF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 04:54: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', 'jsonschema'] in /builds/slave/test/build 04:54: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 jsonschema 04:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:00 INFO - 'HOME': '/Users/cltbld', 04:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:00 INFO - 'LOGNAME': 'cltbld', 04:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:00 INFO - 'MOZ_NO_REMOTE': '1', 04:54:00 INFO - 'NO_EM_RESTART': '1', 04:54:00 INFO - 'PAGER': '/bin/cat', 04:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:00 INFO - 'PWD': '/builds/slave/test', 04:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:00 INFO - 'SHELL': '/bin/bash', 04:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:54:00 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:00 INFO - 'USER': 'cltbld', 04:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:00 INFO - 'XPC_FLAGS': '0x0', 04:54:00 INFO - 'XPC_SERVICE_NAME': '0', 04:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:00 INFO - Cleaning up... 04:54:00 INFO - Return code: 0 04:54:00 INFO - Running post-action listener: _resource_record_post_action 04:54:00 INFO - Running post-action listener: _start_resource_monitoring 04:54:00 INFO - Starting resource monitoring. 04:54:00 INFO - [mozharness: 2017-02-15 12:54:00.386668Z] Finished create-virtualenv step (success) 04:54:00 INFO - [mozharness: 2017-02-15 12:54:00.387601Z] Running install step. 04:54:00 INFO - Running pre-action listener: _resource_record_pre_action 04:54:00 INFO - Running main action method: install 04:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:00 INFO - Reading from file tmpfile_stdout 04:54:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:00 INFO - Reading from file tmpfile_stdout 04:54:00 INFO - Output received: 04:54:00 INFO - Usage: mozinstall [options] installer 04:54:00 INFO - Options: 04:54:00 INFO - -h, --help show this help message and exit 04:54:00 INFO - -d DEST, --destination=DEST 04:54:00 INFO - Directory to install application into. [default: 04:54:00 INFO - "/builds/slave/test"] 04:54:00 INFO - --app=APP Application being installed. [default: firefox] 04:54:00 INFO - mkdir: /builds/slave/test/build/application 04:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:54:23 INFO - Reading from file tmpfile_stdout 04:54:23 INFO - Output received: 04:54:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:54:23 INFO - Running post-action listener: _resource_record_post_action 04:54:23 INFO - [mozharness: 2017-02-15 12:54:23.400870Z] Finished install step (success) 04:54:23 INFO - [mozharness: 2017-02-15 12:54:23.401002Z] Running run-tests step. 04:54:23 INFO - Running pre-action listener: _resource_record_pre_action 04:54:23 INFO - Running main action method: run_tests 04:54:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:23 INFO - 2017-02-15 04:54:23.415 screenresolution[1623:7547] starting screenresolution argv=screenresolution get 04:54:23 INFO - 2017-02-15 04:54:23.418 screenresolution[1623:7547] Display 0: 1600x1200x32@60 04:54:23 INFO - 2017-02-15 04:54:23.424 screenresolution[1624:7550] starting screenresolution argv=screenresolution list 04:54:23 INFO - Available Modes on Display 0 04:54:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:23 INFO - Intel Iris: 04:54:23 INFO - Chipset Model: Intel Iris 04:54:23 INFO - Type: GPU 04:54:23 INFO - Bus: Built-In 04:54:23 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:23 INFO - Vendor: Intel (0x8086) 04:54:23 INFO - Device ID: 0x0a2e 04:54:23 INFO - Revision ID: 0x0009 04:54:23 INFO - Displays: 04:54:23 INFO - Display: 04:54:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:23 INFO - Display Serial Number: 1600x1200 60 04:54:23 INFO - Main Display: Yes 04:54:23 INFO - Mirror: Off 04:54:23 INFO - Online: Yes 04:54:23 INFO - Rotation: Supported 04:54:23 INFO - Return code: 0 04:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:23 INFO - Python 2.7.3 04:54:23 INFO - Return code: 0 04:54:23 INFO - grabbing minidump binary from tooltool 04:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6fbd30>, '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 0x10b622db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:54:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:54:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:23 INFO - Return code: 0 04:54:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:23 INFO - ENV: RUST_BACKTRACE is now 1 04:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dllb9DI8jF/Render', 04:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:23 INFO - 'HOME': '/Users/cltbld', 04:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:23 INFO - 'LOGNAME': 'cltbld', 04:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:23 INFO - 'MOZ_NO_REMOTE': '1', 04:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:23 INFO - 'NO_EM_RESTART': '1', 04:54:23 INFO - 'PAGER': '/bin/cat', 04:54:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:23 INFO - 'PWD': '/builds/slave/test', 04:54:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:23 INFO - 'RUST_BACKTRACE': '1', 04:54:23 INFO - 'SHELL': '/bin/bash', 04:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F6Ulndz8uF/Listeners', 04:54:23 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 04:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:23 INFO - 'USER': 'cltbld', 04:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:23 INFO - 'XPC_FLAGS': '0x0', 04:54:23 INFO - 'XPC_SERVICE_NAME': '0', 04:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:54:24 INFO - mozversion application_buildid: 20170215032545 04:54:24 INFO - mozversion application_changeset: c0807d6938c13e43add377d5838df7168a59971e 04:54:24 INFO - mozversion application_display_name: Nightly 04:54:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:24 INFO - mozversion application_name: Firefox 04:54:24 INFO - mozversion application_remotingname: firefox 04:54:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:54:24 INFO - mozversion application_vendor: Mozilla 04:54:24 INFO - mozversion application_version: 54.0a1 04:54:24 INFO - mozversion platform_buildid: 20170215032545 04:54:24 INFO - mozversion platform_changeset: c0807d6938c13e43add377d5838df7168a59971e 04:54:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:54:24 INFO - mozversion platform_version: 54.0a1 04:54:24 INFO - using testdate: 1487163264 04:54:24 INFO - actual date: 1487163264 04:54:24 INFO - starting webserver on 'localhost:49237' 04:54:24 INFO - SUITE-START | Running 2 tests 04:54:24 INFO - TEST-START | dromaeo_css 04:54:24 INFO - operating with platform_type : mac_ 04:54:24 INFO - Initialising browser for dromaeo_css test... 04:54:24 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp9eczDq/profile http://localhost:49237/getInfo.html) 04:54:26 INFO - PROCESS | 1634 | 2017-02-15 04:54:26.916 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 04:54:26 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:26 INFO - PROCESS | 1634 | 2017-02-15 04:54:26.919 plugin-container[1636:7717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 04:54:26 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:26 INFO - PROCESS | 1634 | 2017-02-15 04:54:26.920 plugin-container[1636:7717] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:26 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 04:54:26 INFO - PROCESS | 1634 | colorDepth:24 04:54:26 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 04:54:26 INFO - PROCESS | 1634 | __metrics 04:54:27 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:54:27 INFO - TEST-INFO | 1634: exit 0 04:54:27 INFO - Browser initialized. 04:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:27 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp9eczDq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:30 INFO - PROCESS | 1637 | 2017-02-15 04:54:30.256 plugin-container[1638:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 04:54:30 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:30 INFO - PROCESS | 1637 | 2017-02-15 04:54:30.256 plugin-container[1638:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:54:30 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:30 INFO - PROCESS | 1637 | 2017-02-15 04:54:30.256 plugin-container[1638:7839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:40 INFO - PROCESS | 1637 | RSS: Main: 233979904 04:54:40 INFO - PROCESS | 1637 | 04:57:43 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 04:57:45 INFO - PROCESS | 1637 | RSS: Main: 255528960 04:57:45 INFO - PROCESS | 1637 | 04:59:28 INFO - PROCESS | 1637 | ************************* 04:59:28 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:59:28 INFO - PROCESS | 1637 | 04:59:28 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:59:28 INFO - PROCESS | 1637 | Full stack: 04:59:28 INFO - PROCESS | 1637 | ************************* 05:00:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 05:00:48 INFO - PROCESS | 1637 | RSS: Main: 261357568 05:00:48 INFO - PROCESS | 1637 | 05:03:50 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 05:03:51 INFO - PROCESS | 1637 | RSS: Main: 272654336 05:03:51 INFO - PROCESS | 1637 | 05:06:53 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 05:06:53 INFO - PROCESS | 1637 | RSS: Main: 264069120 05:06:53 INFO - PROCESS | 1637 | 05:09:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 05:09:57 INFO - PROCESS | 1637 | RSS: Main: 272080896 05:09:57 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 05:13:00 INFO - PROCESS | 1637 | RSS: Main: 273932288 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | __start_tp_report 05:13:00 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 05:13:00 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 05:13:00 INFO - PROCESS | 1637 | |i|pagename|runs| 05:13:00 INFO - PROCESS | 1637 | |0;dojo.html;3103.705148010939;3346.6653334666535;3374.2407958209405;3396.1509622594353;3436.1753179236985;4491.955080449195;4737.620990320779;5556.86107847304;5581.358143813458;5690.089585666295;5585.022621041312;5633.352164501083;5672.773089076442;5704.686242256675;5767.5962682612235;5126.7183204198955;5163.948360516394;5182.404023537285;5202.089634313998;5321.909008653217;5165.76754046067;5285.392179899303;5328.653637513568;5337.599680023995;5358.115910874701;5076.390833100015;5099.847004589868;5276.5251127398715;5294.655847369909;5335.7865685372535;5060.645754797166;5109.974450127763;5110.8466745997675;5128.71792051437;5130.358705161855;5035.697858128524;5054.671446355975;5087.211482220262;5101.438841727407;5129.589632829365;3995.1210733638845;4422.513523512411;5300.178472336794;5570.805021824257;5608.663480191201;6026.306974697922;6066.514678825683;6096.298925623566;6101.792513241549;6114.2968558615885;6127.662978536178;6155.907661385083;6177.81466556004;6187.690615469253;6192.225971753531;4898.706077635354;5856.0630299151935;5860.413958604106;5872.11918212263;5881.941180588225;6104.004449388181;6123.510119190454;6234.625922444668;6301.117843501914;6311.601591395241;6008;6097.8475538111015;6100.8779824404155;6118.771466971993;6138.539609529304;5730.054541000772;5765.106408506688;6174;6218.657973811393;6278.089676996809;6117.785877494266;6194.5973511721595;6196.411340922605;6264.9976003839165;6268.373162683695;6026;6106.236720409949;6113.786017489367;6142.468080853438;6149.692515374213;4934.1611925972675;4971.651984361132;4975.203967365276;5005.024020316004;5092.083424983539;4449.7775111244955;4462;4471.709338893027;4485.641148708096;4488;5472.781088756406;5848.385919478478;5888.735006924699;5912.320083190402;5945.672987985616;6120.44915957566;6199.318075011745;6205.503559715212;6212.565120441616;6220.315765265817;4649.349091127245;4872.926906096412;5176.430592634807;5917.082852157922;5991.340952495222;4563.315502674559;4690.366800481959;5477.123660214346;5478.780848766084;5493.2034854945805;5143.691378517301;6248;6250.4374606285655;6333;6444.548881578432;6087.512998960161;6132.814448934826;6185.443310102112;6215.471684906834;6282.874342513032;6201.937980620136;6215.378462153749;6243.7814676486105;6295.653739044396;6370.076338930921;6140.600860944024;6223.408776166257;6245.406686364788;6246.875062498815;6260.436560709558;5424.728763561885;5786.189933409242;6248.343923887926;6259.6870156492905;6272.341404152681;5969.76120955157;6049.30433000193;6056.454919057306;6067.362926892612;6069.605475644069;6024.9397506026135;6050.45545900871;6052.697365131814;6072.240969878765;6173.351798061139;4878.756062196947;5112.309838171948;5707.8858422832145;5991.910121348096;5995.2206213192;6076.817695469143;6122.877542449215;6149.96925015372;6155.507559395327;6170.444659980623;5768.221290125779;5810.622309549865;5815.302163740378;5987.43119403656;6016.42843929826 05:13:00 INFO - PROCESS | 1637 | |1;ext.html;496.1515807968374;517.6635187128364;521.0776924843028;553.5875772549449;590.512826917793;37697.43453848191;38432.03919902004;40342.39486407706;40377.79811100948;40468;34855.4771678425;41602.58397416025;42165;42437;42556;9327.6735314264;10947.34315941046;11244.550217991271;11305.378204198765;11499.540018399253;11287.435628218598;11348.546058157704;11394.25937314072;11401.942990285037;11425.600103996361;11094.057005154531;11108.61119860805;11121;11181.608643697473;11183.217174797768;11304.491297891615;11385.430728463543;11405.030572401272;11405.54377824886;11413.885861141365;11205.21563490556;11224.719382015433;11236.325820450716;11265.662030139109;11285.887141128565;36903.63096369029;36927.63072369296;37183.62816371856;37289.62710372916;37309.62690373116;2999.8350090745002;3462.9653703462895;3761.322961866863;3781.9243615127543;3810.333191691443;27265.318367040785;27852.303692407648;28081.578776318373;28193;28807.855960720273;3054.480738274499;3116.0807561769334;3117.7505799535984;3131.060681795452;3207.8075315481146;448595;449947;454438;456415;458027;44843.55156448394;45362.546374535836;54513;54972.45027549753;55190;57855.132173016595;57906;57998.420015799304;58041.70979145162;58098.838023239296;14276;14299.78550321746;14418.783718244234;14460.710785784437;14465.27673616336;10957.56169753201;10978.615748448925;11038.668839934815;11123;11147;17177.31290748381;17391.56521086983;17453.65092698139;17453.91273043652;17487.213075411637;7665.961670191613;7794.2985131338455;7813.10149332834;7848.077221080872;7855.5286682799215;834.6202477872554;836.2515548583983;844.1263292492364;854.3165467625874;872.4852337121129;22540.32379028632;26597;28079;28493;29786;890.7238755985536;1021.5352014833232;1058.3385384134915;1063.712797544674;1170.403094421851;14540.49108281205;14776.630584235265;15135.924320378328;15239.806358237172;15532.767008494882;573553;577524;577770;579477;584691;43549;52873.149439769426;53509.929801404534;53566.92866142733;53700;1338.625184948216;1345.5425155447194;1378.3935068569797;1378.9241591712353;1380.344336440203;23906;27593.44813103767;27611.861940690167;28417.005404810734;29044.27389315284;37767.244655106195;45694;46444.53555464402;46471.535284648075;46488.302675460574;518376;521737;521866;522000.38999804755;522070;24189;24877.87561062183;24961.251162465156;25101.74898250994;25103.497930040932;35068.298634027684;40933.56732514348;41742.79128604459;41896.95257618584;41987;33107;33908.49137262993;33967.66032339645;35137.29725405529;35300.47049294314;28525.857370713013;29352.70647293585;33738.831305844295;34091.488627671104;35930.10174745652;26057.609135862596;27761.583576246776;33913.66086339105;34640.82679586586;34961.12597185091;28268.010619628214;30156;30219.244518887204;30323.393532129674;30794.846025770625;19869;21223.469413264793;22644.320670379915;23372.298831035096;23567.764322356557 05:13:00 INFO - PROCESS | 1637 | |2;jquery.html;326.51349489260997;340.2361697988017;371.528159237768;385.24299750989303;409.83811394499173;19602;20217.191312347524;20549.794502054974;20603.896980515114;20843;17160.914195429006;20820.791792082076;21262;21269.14923403062;21601;5521.3926468088475;5808.925348810483;5950.494207992326;6068.726907289182;6213;6010.068439391901;6113.572049956505;6120.785772497963;6123.326434092246;7487.2887075727995;7507.474476786627;7865.803354916145;7921.366290696759;8030.879536806952;8063.838723225532;6993.720251189946;7733.304002639761;7989.520628762293;7996.800079997988;8073.434859559804;6809.557378770364;7373.373263272575;7753.263439973193;7823.726169584094;7914.862986993479;28420.573691394646;28547.71452285492;28894.855525722447;28976;29349.559756603667;2806.2984253936515;2890.4363649088436;2911.694272101441;2924.6051783009234;2938.9412211755857;15910;16301.918490407472;16548.58628534284;16981.405650802288;17399.913000435045;2001.6597178479694;2012.4566367080952;2025.878447293167;2052.7126202331688;2070.430631576329;139042;144808;145304;147071;165813.9999999988;18566;21049.78950210509;22650;22975;23499.20063948868;39268.80365598154;39363.60636393657;39478.60521394749;39549.60450395459;39567.208655826726;10334.638287659896;10608.416537090534;10769.030787229187;10840.891591084146;10995.670129896116;8540.829183416297;8558.957205213934;8579.14208579137;8686.218240358397;8716.215540601377;10119.898801011896;10968.894180681744;10978.966139030223;11011.174161937886;11100.167487438475;3972.3842804365368;4283.785810709452;4326.329418940069;4327.697061205686;4332.505285676437;746.4700062955254;838.1241602525375;839.3998291221684;866.8743032260287;876.1939016105199;15738.606534836492;16644;16744.748828767577;20722.378328650164;20961.790382095984;843.2663582683105;874.696701914156;884.6638277454526;897.5018864530249;900.2617853360313;9779;10558.260921735558;10721.142308615292;10758.139348852073;10802.89197108019;660747;667820.9134314946;668272;676621;686122;117292;139450;146216;152478;155512.22243888708;848.1391387741447;950.6530116507563;999.5352161245056;1012.2661070723666;1029.9948500257601;19525.51186220356;19699;19824.90962997049;19856.10647520894;19857.304994325128;49254.26118608152;49380;51429.48570514397;56280;57016;55673.44326556844;59088.70455647866;68387.3161268381;76544.61727691325;76923;8106.351491880753;8147.75556733299;8411.200935911078;8470.618822152896;8493.065762766215;10868.891311087104;11705.648830535098;12586.370681466073;13040.282784446947;13187.670308241986;10865.348079114961;11131.721706957067;11285.71785705364;11315.603953861575;11336.6032188873;10429.739256518647;10666.73333166677;10888.836667450152;11239.887601123884;11260.718482038015;11165.609203677832;11351.54593816238;11445.828312575484;11579.536818527165;11691.766164676488;7119.572825630479;7533.849323013399;7548.584827834522;7650.846983060196;8696.565171741515;9616;10990.340579565252;11124.944375278072;11441.42792860337;11514.19400641947 05:13:00 INFO - PROCESS | 1637 | |3;mootools.html;1339.1429485129515;1441.1209162410928;1441.5170917742555;1448.550949205747;1462.7732701431275;7276.235995220505;8129.065157506881;8185.263326300632;8520;8529.701460448894;7898.5260884346835;8432.451890627104;8451.070382257947;8480.32157427406;8781.473111613308;2231.475603233243;2263.0155882191216;2268.8071513921336;2268.8638681679154;2268.9092436302526;2238.977610223901;2274.1812947338944;2276.5788329159077;2279.1453205048106;2283.1552325639536;2130.1479408236673;2133.5839511295303;2142.73215848019;2154.946126346846;2162.1891790578534;2139.411661793004;2213.8339624528144;2229.264342766883;2236.2285011670947;2243.55128974205;1680.4706517447087;1899.705545640428;2188.0919418441326;2299.413649519362;2301.42464383904;8187.508749474991;8392.118827523143;8422.410431269813;8450.661973521052;8484.236418722345;5002.7248501332415;5146.511081447256;5151.5878729701535;5153.201253805666;5166.328377310925;3414.9829250853836;3424.6404127566743;3433.901151631479;3479.704225140866;3504.3867323218333;995.2485873165714;1051.2536099369456;1173.3194747046693;1212.6180253220296;1238.2199214494901;10704.250702450832;10744.892551074545;10784;10804.891951080468;10839.620613278497;3707.3882809336696;4101.318459431619;4395.164918665443;4411;4418.513963464016;8260.215279548433;8263.462874913112;8581.742547723577;8605.65577376898;8615.310775137974;5037;5055.87360315995;5065.518775716301;5071.949280507148;5089.3638295213095;4476.306172543261;4557.225271703818;4644.976775116171;4737.478877323491;4750.8337208197545;3566.6789988901123;3605.963940360563;3656.305301992613;3668.8715894944085;3671.3575124353133;1114.1393872233389;1125.6172901213627;1142.7600203957095;1142.7714457108611;1146.4267866066966;831.5094094484283;837.7570504553611;858.8454078265972;874.501534125555;899.4288626722079;5377.193420986883;5392.352917649829;5421.186821976735;5487.478689524489;5570.86072848182;897.2239013253619;927.703134996808;931.1759093202429;939.6664184214505;976.6776963601994;3440.7247420206822;3614.9277014459562;3624.05774498627;3676.209614932802;3744.925101497955;9400.90599094014;9468.90531094694;9690.933997260296;9778.853317200248;9785.972472890244;9717.93102758696;9781.266405019509;9810.950945245371;9817.969113243149;9827.262955278382;7718.266764657348;7876.842463150705;7900.328472079823;7915.050193976645;7917.722879699068;4578.2664361757825;5227.372715274039;5491.835244942658;5559.138333558305;5631.774729010957;8930.642774289216;8946.776330591787;9084.772880678036;9170.312226582899;9191.678291259774;8880.955595222242;9088;9268;9408.482533460452;9410.29422793307;7034.718611255493;7246.1666908306215;7251.1298644163035;7295.8540829184185;7335.156457007299;7663.1570527243075;7748.7675369739;7814.843703125792;7852.332551733167;7868.763937081668;7099.645017749195;7158.2841715828;7194.892076618959;7215.098112735908;7230.6384680766805;6981.755638552626;7069.505134640526;7073.2219455858785;7111.857762844611;7171.390431813355;6217.253929528486;6326.588771729823;6335.049742538472;6354.3963323484195;6360.173177486897;4844.103840789465;4876.561109500162;4932.778024988956;4964;5067.77195026232;4764.2615394613895;4863.683860549053;4934.457209706858;4951.8266860659705;5029.5221953914315 05:13:00 INFO - PROCESS | 1637 | |4;prototype.html;341.8991397537726;346.5823682462633;355.2982858853764;360.8971443138705;361.90771353304905;4224.767637779921;5247.895042099156;5410.729463526827;5410.917816436714;5454.699991500466;4751.311059896313;4776.307435421871;5032.8993420131665;5084.949150508493;5315.973420132904;3629.2922880038404;3857.633524815138;4000.9997500624845;4195.8741237762915;4221.366794980747;3687.244114956441;3911.8044097795137;4222.0922501662135;4224.72539284947;4263.936040959388;4081.3061779497407;4118.629323360897;4133.524644665857;4143.316352801784;4157.48031496063;3833.674137698271;3920.411938209263;4010.418489319062;4129.132882094764;4135.379693046037;3229.8708051677904;3646.978845923146;3652.7443078984484;3662.688671462929;3681.37416639172;4133.1940271647045;4264.23243816113;5019.749012549358;5224.555912747421;5252.3171987641745;4235.195312890572;4420.778961051967;4608.115397678438;4790.233562629997;4832;5659.51894089003;5661.5187709044785;5693.430656934315;5693.914591281134;5700.002499562602;3592.5868525119686;3839.2705385976574;3982.820773065219;4027.1004876488882;4035.556088830226;4903.4851340609075;4994.351863884909;5457.372402173722;5604.113881351107;5853.770708151251;3440.385307166521;3907.0623050468253;4073.6537394321813;4079.1229885574744;4086.059121917125;3342.359535966608;3526.6297038811067;4151.398047283127;4160.292750232467;4176.4570605821655;4611.239145541015;4688.789004494806;4752.95247047532;4791.730191499256;4826.686265392738;4808.422989241313;5564.443555644403;5651.717414129277;5716.971415142898;5724.885502290014;1097.6816723150198;1251.2367455851922;1256.378092844048;1353.6006877971022;1356.077867050415;877.087828658201;956.1394744729798;961.9807603847884;970.9755160490315;972.9659461918799;4482.148391805546;4988.254111061099;5018.347614810052;5033.672811267256;5043.697378157249;4505.504394516601;4733.644976626698;5165.535101840777;5472.50747432733;5609.411011843697;4197.76912269822;4488.483824360241;4927.975360123177;5063.442961304591;5073.746312684351;2513.748625137508;2598.3244356467076;2680.517506848786;2871.3970066285897;2889.8242040252053;5001.799928002839;5631.915521267184;5763.538916886639;5795.739191736382;5801.88396232073;4800.687955282965;5332.893342133136;5431.538319242909;5718.256626638594;5745.540356771448;4820.746605882426;5114.718690471986;5131.512506311969;5723.3418156912485;5765.682887441231;4920.975395123001;5080.974595127001;5557.4158016522515;5569.526590239875;5581.162825576196;4568.406107206042;4840.273958906051;5265.4997775211295;5340.412554619066;5442.12925931849;5286.1762691871245;5532.640378375393;5826.883462330815;5839.591228613956;6040.879182416239;3341.4486609710098;3931.587183345822;4010.9398359024053;4070.9185816284103;4077.368007958771;4839.612830973443;5659.085570931056;5787.623804452697;5800.5208671790115;5821.388754180919;4517.97741011306;4675.76621168947;4906.852794416173;5175.792968281377;5538.280023596906;4769.993205707223;5391.002664507078;5566.4135721320845;5607.607467477401;5607.971960140173;4554.132805549709;4554.134714404253;4607.285870690049;5352.705601191972;5454.172852094593;4513.977430112828;5336.879255356419;5551.278333816578;5570.41243245673;5609.663420194802;4812.951870481391;5439.728013599383;5475.753591088331;5491.588130890279;5492.286002819608 05:13:00 INFO - PROCESS | 1637 | |5;yui.html;670.6981858163828;688.8794460969335;772.8724760414532;777.5839925639782;785.2265518464312;14368.994170408076;14767.261636918165;15163.39346426143;15175.92412037941;15201.467948621786;13954.302284885765;14161.008729388946;14207.076540024891;14370.784438233435;14455.56633301;872.2237208884098;876.9342299327544;882.3206131278912;883.4919921045424;884.5400391796262;860.513809697522;871.7864123289803;872.7469033980138;873.1704880363649;895.4716717136888;927.0405130689737;938.0103990290241;938.3384713776771;940.1773448232797;940.219617717293;920.1580553793272;932.7854593443478;934.6635211323918;936.6815282803811;936.8266870628921;690.4752388184966;692.1659400422479;692.4425837201051;692.7506097804786;692.9861402771917;15335.923320383437;15345;15415.691686166214;15459.845401546065;15743.527694169194;13700.45198192071;13880.51418200358;13939.930300348433;13941.745242928084;13972.301384930714;11275.943620281929;11376.146788990858;11540.422978851024;11543.249688770204;11763.470643821049;3583.812731626373;3606.536226634162;3639.2175682228185;3666.651668091527;3791.317562838688;92113.53943230308;101928;103642;105045.47477262642;105704.41443378432;9952.701418957442;10358.482075896174;10613.204009699304;10724.624638137628;10848.349099054081;22408.887955560444;22416.215432459787;22417.10331586751;22448.887755561118;22488.875556222123;7386.187519372865;7404;7549.245075492407;7615.314621684075;7655.885161722578;4080.836766529365;4166.291730405838;4201.957980420218;4223.936640950388;4257.5529569395385;3178.6185657720757;3601.117726157056;3606.1525541497726;3710.7588006779474;3720.7023438124884;656.9047488114197;659.6404959297195;664.1432552007856;667.0561155964256;667.9966600167065;632.5824955529329;641.7304732012473;662.5494663628682;693.7051753004953;711.7580022792275;7399.408047356199;9429.15137637616;9617.326787124974;9641.132298093065;9794.595880027387;477.6895018238173;556.0380541662946;642.4154019842015;673.7843889955266;706.2090458686304;3326.534285200074;4016.116454380032;4048.6356227939627;4129.607687269705;4828.330468843634;73736;94271;94626.58060129103;95342;95706.52146739361;63357.68321158457;69268.65365673139;69592;76087.85868211981;77628;53142.20286695703;53229.66925826808;67952.6023698823;69197.65401172962;71958;10170.898291016994;10440;10489.737756555842;10544.876570804214;10683.57265709363;45110;47195.292070618285;47281.76359118182;47765;49028.019439610296;53702.92594148017;62084;62415;62688.37311627008;64782.35217647763;12538.683438238853;12769.808452873029;12816.479326171539;12827.166234194747;13393.66515837112;12628.926541243729;13727.519536816164;14077;14220.786688199478;14750.63123421923;13372.130811497222;13396.397162127923;13397.732045359233;13519;13690.726185476435;12061.15571909993;13147.934260328637;13473.124246923919;13627.318634068455;13752.862471375158;12644.557440489538;12947.223166610034;13058.608241752763;13193.20840749558;13543.155937252894;10734;10972.341659500136;11003.779924401628;11120.277181983469;11314.773704526027;6633.5704011505495;9892.901070989197;10706.89293107059;10726.195535334726;10847.67456976292 05:13:00 INFO - PROCESS | 1637 | __end_tp_report 05:13:00 INFO - PROCESS | 1637 | __start_cc_report 05:13:00 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,426 05:13:00 INFO - PROCESS | 1637 | __end_cc_report 05:13:00 INFO - PROCESS | 1637 | __startTimestamp1487164380534__endTimestamp 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | ------- Summary: start ------- 05:13:00 INFO - PROCESS | 1637 | Number of tests: 6 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5637.32 Median:5912.32 stddev:681.72 (11.5%) stddev-sans-first:654.20 05:13:00 INFO - PROCESS | 1637 | Values: 3103.7 3346.7 3374.2 3396.2 3436.2 4492.0 4737.6 5556.9 5581.4 5690.1 5585.0 5633.4 5672.8 5704.7 5767.6 5126.7 5163.9 5182.4 5202.1 5321.9 5165.8 5285.4 5328.7 5337.6 5358.1 5076.4 5099.8 5276.5 5294.7 5335.8 5060.6 5110.0 5110.8 5128.7 5130.4 5035.7 5054.7 5087.2 5101.4 5129.6 3995.1 4422.5 5300.2 5570.8 5608.7 6026.3 6066.5 6096.3 6101.8 6114.3 6127.7 6155.9 6177.8 6187.7 6192.2 4898.7 5856.1 5860.4 5872.1 5881.9 6104.0 6123.5 6234.6 6301.1 6311.6 6008.0 6097.8 6100.9 6118.8 6138.5 5730.1 5765.1 6174.0 6218.7 6278.1 6117.8 6194.6 6196.4 6265.0 6268.4 6026.0 6106.2 6113.8 6142.5 6149.7 4934.2 4971.7 4975.2 5005.0 5092.1 4449.8 4462.0 4471.7 4485.6 4488.0 5472.8 5848.4 5888.7 5912.3 5945.7 6120.4 6199.3 6205.5 6212.6 6220.3 4649.3 4872.9 5176.4 5917.1 5991.3 4563.3 4690.4 5477.1 5478.8 5493.2 5143.7 6248.0 6250.4 6333.0 6444.5 6087.5 6132.8 6185.4 6215.5 6282.9 6201.9 6215.4 6243.8 6295.7 6370.1 6140.6 6223.4 6245.4 6246.9 6260.4 5424.7 5786.2 6248.3 6259.7 6272.3 5969.8 6049.3 6056.5 6067.4 6069.6 6024.9 6050.5 6052.7 6072.2 6173.4 4878.8 5112.3 5707.9 5991.9 5995.2 6076.8 6122.9 6150.0 6155.5 6170.4 5768.2 5810.6 5815.3 5987.4 6016.4 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:64042.05 Median:3124.41 stddev:138874.10 (4444.8%) stddev-sans-first:139181.72 05:13:00 INFO - PROCESS | 1637 | Values: 496.2 517.7 521.1 553.6 590.5 37697.4 38432.0 40342.4 40377.8 40468.0 34855.5 41602.6 42165.0 42437.0 42556.0 9327.7 10947.3 11244.6 11305.4 11499.5 11287.4 11348.5 11394.3 11401.9 11425.6 11094.1 11108.6 11121.0 11181.6 11183.2 11304.5 11385.4 11405.0 11405.5 11413.9 11205.2 11224.7 11236.3 11265.7 11285.9 36903.6 36927.6 37183.6 37289.6 37309.6 2999.8 3463.0 3761.3 3781.9 3810.3 27265.3 27852.3 28081.6 28193.0 28807.9 3054.5 3116.1 3117.8 3131.1 3207.8 448595.0 449947.0 454438.0 456415.0 458027.0 44843.6 45362.5 54513.0 54972.5 55190.0 57855.1 57906.0 57998.4 58041.7 58098.8 14276.0 14299.8 14418.8 14460.7 14465.3 10957.6 10978.6 11038.7 11123.0 11147.0 17177.3 17391.6 17453.7 17453.9 17487.2 7666.0 7794.3 7813.1 7848.1 7855.5 834.6 836.3 844.1 854.3 872.5 22540.3 26597.0 28079.0 28493.0 29786.0 890.7 1021.5 1058.3 1063.7 1170.4 14540.5 14776.6 15135.9 15239.8 15532.8 573553.0 577524.0 577770.0 579477.0 584691.0 43549.0 52873.1 53509.9 53566.9 53700.0 1338.6 1345.5 1378.4 1378.9 1380.3 23906.0 27593.4 27611.9 28417.0 29044.3 37767.2 45694.0 46444.5 46471.5 46488.3 518376.0 521737.0 521866.0 522000.4 522070.0 24189.0 24877.9 24961.3 25101.7 25103.5 35068.3 40933.6 41742.8 41897.0 41987.0 33107.0 33908.5 33967.7 35137.3 35300.5 28525.9 29352.7 33738.8 34091.5 35930.1 26057.6 27761.6 33913.7 34640.8 34961.1 28268.0 30156.0 30219.2 30323.4 30794.8 19869.0 21223.5 22644.3 23372.3 23567.8 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39694.86 Median:15943.85 stddev:112228.63 (703.9%) stddev-sans-first:112504.53 05:13:00 INFO - PROCESS | 1637 | Values: 326.5 340.2 371.5 385.2 409.8 19602.0 20217.2 20549.8 20603.9 20843.0 17160.9 20820.8 21262.0 21269.1 21601.0 5521.4 5808.9 5950.5 6068.7 6213.0 6010.1 6113.6 6120.8 6123.3 7487.3 7507.5 7865.8 7921.4 8030.9 8063.8 6993.7 7733.3 7989.5 7996.8 8073.4 6809.6 7373.4 7753.3 7823.7 7914.9 28420.6 28547.7 28894.9 28976.0 29349.6 2806.3 2890.4 2911.7 2924.6 2938.9 15910.0 16301.9 16548.6 16981.4 17399.9 2001.7 2012.5 2025.9 2052.7 2070.4 139042.0 144808.0 145304.0 147071.0 165814.0 18566.0 21049.8 22650.0 22975.0 23499.2 39268.8 39363.6 39478.6 39549.6 39567.2 10334.6 10608.4 10769.0 10840.9 10995.7 8540.8 8559.0 8579.1 8686.2 8716.2 10119.9 10968.9 10979.0 11011.2 11100.2 3972.4 4283.8 4326.3 4327.7 4332.5 746.5 838.1 839.4 866.9 876.2 15738.6 16644.0 16744.7 20722.4 20961.8 843.3 874.7 884.7 897.5 900.3 9779.0 10558.3 10721.1 10758.1 10802.9 660747.0 667820.9 668272.0 676621.0 686122.0 117292.0 139450.0 146216.0 152478.0 155512.2 848.1 950.7 999.5 1012.3 1030.0 19525.5 19699.0 19824.9 19856.1 19857.3 49254.3 49380.0 51429.5 56280.0 57016.0 55673.4 59088.7 68387.3 76544.6 76923.0 8106.4 8147.8 8411.2 8470.6 8493.1 10868.9 11705.6 12586.4 13040.3 13187.7 10865.3 11131.7 11285.7 11315.6 11336.6 10429.7 10666.7 10888.8 11239.9 11260.7 11165.6 11351.5 11445.8 11579.5 11691.8 7119.6 7533.8 7548.6 7650.8 8696.6 9616.0 10990.3 11124.9 11441.4 11514.2 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5336.21 Median:5302.28 stddev:2934.98 (55.4%) stddev-sans-first:2927.84 05:13:00 INFO - PROCESS | 1637 | Values: 1339.1 1441.1 1441.5 1448.6 1462.8 7276.2 8129.1 8185.3 8520.0 8529.7 7898.5 8432.5 8451.1 8480.3 8781.5 2231.5 2263.0 2268.8 2268.9 2268.9 2239.0 2274.2 2276.6 2279.1 2283.2 2130.1 2133.6 2142.7 2154.9 2162.2 2139.4 2213.8 2229.3 2236.2 2243.6 1680.5 1899.7 2188.1 2299.4 2301.4 8187.5 8392.1 8422.4 8450.7 8484.2 5002.7 5146.5 5151.6 5153.2 5166.3 3415.0 3424.6 3433.9 3479.7 3504.4 995.2 1051.3 1173.3 1212.6 1238.2 10704.3 10744.9 10784.0 10804.9 10839.6 3707.4 4101.3 4395.2 4411.0 4418.5 8260.2 8263.5 8581.7 8605.7 8615.3 5037.0 5055.9 5065.5 5071.9 5089.4 4476.3 4557.2 4645.0 4737.5 4750.8 3566.7 3606.0 3656.3 3668.9 3671.4 1114.1 1125.6 1142.8 1142.8 1146.4 831.5 837.8 858.8 874.5 899.4 5377.2 5392.4 5421.2 5487.5 5570.9 897.2 927.7 931.2 939.7 976.7 3440.7 3614.9 3624.1 3676.2 3744.9 9400.9 9468.9 9690.9 9778.9 9786.0 9717.9 9781.3 9811.0 9818.0 9827.3 7718.3 7876.8 7900.3 7915.1 7917.7 4578.3 5227.4 5491.8 5559.1 5631.8 8930.6 8946.8 9084.8 9170.3 9191.7 8881.0 9088.0 9268.0 9408.5 9410.3 7034.7 7246.2 7251.1 7295.9 7335.2 7663.2 7748.8 7814.8 7852.3 7868.8 7099.6 7158.3 7194.9 7215.1 7230.6 6981.8 7069.5 7073.2 7111.9 7171.4 6217.3 6326.6 6335.0 6354.4 6360.2 4844.1 4876.6 4932.8 4964.0 5067.8 4764.3 4863.7 4934.5 4951.8 5029.5 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4446.61 Median:4829.34 stddev:1326.71 (27.5%) stddev-sans-first:1294.16 05:13:00 INFO - PROCESS | 1637 | Values: 341.9 346.6 355.3 360.9 361.9 4224.8 5247.9 5410.7 5410.9 5454.7 4751.3 4776.3 5032.9 5084.9 5316.0 3629.3 3857.6 4001.0 4195.9 4221.4 3687.2 3911.8 4222.1 4224.7 4263.9 4081.3 4118.6 4133.5 4143.3 4157.5 3833.7 3920.4 4010.4 4129.1 4135.4 3229.9 3647.0 3652.7 3662.7 3681.4 4133.2 4264.2 5019.7 5224.6 5252.3 4235.2 4420.8 4608.1 4790.2 4832.0 5659.5 5661.5 5693.4 5693.9 5700.0 3592.6 3839.3 3982.8 4027.1 4035.6 4903.5 4994.4 5457.4 5604.1 5853.8 3440.4 3907.1 4073.7 4079.1 4086.1 3342.4 3526.6 4151.4 4160.3 4176.5 4611.2 4688.8 4753.0 4791.7 4826.7 4808.4 5564.4 5651.7 5717.0 5724.9 1097.7 1251.2 1256.4 1353.6 1356.1 877.1 956.1 962.0 971.0 973.0 4482.1 4988.3 5018.3 5033.7 5043.7 4505.5 4733.6 5165.5 5472.5 5609.4 4197.8 4488.5 4928.0 5063.4 5073.7 2513.7 2598.3 2680.5 2871.4 2889.8 5001.8 5631.9 5763.5 5795.7 5801.9 4800.7 5332.9 5431.5 5718.3 5745.5 4820.7 5114.7 5131.5 5723.3 5765.7 4921.0 5081.0 5557.4 5569.5 5581.2 4568.4 4840.3 5265.5 5340.4 5442.1 5286.2 5532.6 5826.9 5839.6 6040.9 3341.4 3931.6 4010.9 4070.9 4077.4 4839.6 5659.1 5787.6 5800.5 5821.4 4518.0 4675.8 4906.9 5175.8 5538.3 4770.0 5391.0 5566.4 5607.6 5608.0 4554.1 4554.1 4607.3 5352.7 5454.2 4514.0 5336.9 5551.3 5570.4 5609.7 4813.0 5439.7 5475.8 5491.6 5492.3 05:13:00 INFO - PROCESS | 1637 | 05:13:00 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:18750.24 Median:4147.95 stddev:25984.41 (626.4%) stddev-sans-first:26021.84 05:13:00 INFO - PROCESS | 1637 | Values: 670.7 688.9 772.9 777.6 785.2 14369.0 14767.3 15163.4 15175.9 15201.5 13954.3 14161.0 14207.1 14370.8 14455.6 872.2 876.9 882.3 883.5 884.5 860.5 871.8 872.7 873.2 895.5 927.0 938.0 938.3 940.2 940.2 920.2 932.8 934.7 936.7 936.8 690.5 692.2 692.4 692.8 693.0 15335.9 15345.0 15415.7 15459.8 15743.5 13700.5 13880.5 13939.9 13941.7 13972.3 11275.9 11376.1 11540.4 11543.2 11763.5 3583.8 3606.5 3639.2 3666.7 3791.3 92113.5 101928.0 103642.0 105045.5 105704.4 9952.7 10358.5 10613.2 10724.6 10848.3 22408.9 22416.2 22417.1 22448.9 22488.9 7386.2 7404.0 7549.2 7615.3 7655.9 4080.8 4166.3 4202.0 4223.9 4257.6 3178.6 3601.1 3606.2 3710.8 3720.7 656.9 659.6 664.1 667.1 668.0 632.6 641.7 662.5 693.7 711.8 7399.4 9429.2 9617.3 9641.1 9794.6 477.7 556.0 642.4 673.8 706.2 3326.5 4016.1 4048.6 4129.6 4828.3 73736.0 94271.0 94626.6 95342.0 95706.5 63357.7 69268.7 69592.0 76087.9 77628.0 53142.2 53229.7 67952.6 69197.7 71958.0 10170.9 10440.0 10489.7 10544.9 10683.6 45110.0 47195.3 47281.8 47765.0 49028.0 53702.9 62084.0 62415.0 62688.4 64782.4 12538.7 12769.8 12816.5 12827.2 13393.7 12628.9 13727.5 14077.0 14220.8 14750.6 13372.1 13396.4 13397.7 13519.0 13690.7 12061.2 13147.9 13473.1 13627.3 13752.9 12644.6 12947.2 13058.6 13193.2 13543.2 10734.0 10972.3 11003.8 11120.3 11314.8 6633.6 9892.9 10706.9 10726.2 10847.7 05:13:00 INFO - PROCESS | 1637 | -------- Summary: end -------- 05:13:00 INFO - PROCESS | 1637 | 05:13:01 INFO - TEST-INFO | 1637: exit 0 05:13:01 INFO - TEST-OK | dromaeo_css | took 1117206ms 05:13:01 INFO - TEST-START | kraken 05:13:01 INFO - operating with platform_type : mac_ 05:13:01 INFO - Initialising browser for kraken test... 05:13:01 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpLQm_9w/profile http://localhost:49237/getInfo.html) 05:13:03 INFO - PROCESS | 1651 | 2017-02-15 05:13:03.894 plugin-container[1652:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 05:13:03 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:03 INFO - PROCESS | 1651 | 2017-02-15 05:13:03.898 plugin-container[1652:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481f, name = 'com.apple.CFPasteboardClient' 05:13:03 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:03 INFO - PROCESS | 1651 | 2017-02-15 05:13:03.898 plugin-container[1652:10456] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:13:03 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 05:13:03 INFO - PROCESS | 1651 | colorDepth:24 05:13:03 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 05:13:03 INFO - PROCESS | 1651 | __metrics 05:13:04 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:13:04 INFO - TEST-INFO | 1651: exit 0 05:13:04 INFO - Browser initialized. 05:13:04 INFO - Running cycle 1/1 for kraken test... 05:13:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpLQm_9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:07 INFO - PROCESS | 1653 | 2017-02-15 05:13:07.250 plugin-container[1654:10574] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 05:13:07 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:07 INFO - PROCESS | 1653 | 2017-02-15 05:13:07.251 plugin-container[1654:10574] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 05:13:07 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:13:07 INFO - PROCESS | 1653 | 2017-02-15 05:13:07.251 plugin-container[1654:10574] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:13:17 INFO - PROCESS | 1653 | RSS: Main: 233619456 05:13:17 INFO - PROCESS | 1653 | 05:13:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:20 INFO - PROCESS | 1653 | RSS: Main: 247570432 05:13:20 INFO - PROCESS | 1653 | 05:13:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 05:13:24 INFO - PROCESS | 1653 | RSS: Main: 255602688 05:13:24 INFO - PROCESS | 1653 | 05:13:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 05:13:28 INFO - PROCESS | 1653 | RSS: Main: 258310144 05:13:28 INFO - PROCESS | 1653 | 05:13:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 05:13:30 INFO - PROCESS | 1653 | RSS: Main: 259596288 05:13:30 INFO - PROCESS | 1653 | 05:13:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:33 INFO - PROCESS | 1653 | RSS: Main: 261242880 05:13:33 INFO - PROCESS | 1653 | 05:13:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:37 INFO - PROCESS | 1653 | RSS: Main: 266780672 05:13:37 INFO - PROCESS | 1653 | 05:13:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:41 INFO - PROCESS | 1653 | RSS: Main: 266219520 05:13:41 INFO - PROCESS | 1653 | 05:13:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 05:13:44 INFO - PROCESS | 1653 | RSS: Main: 265908224 05:13:44 INFO - PROCESS | 1653 | 05:13:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:47 INFO - PROCESS | 1653 | RSS: Main: 265310208 05:13:47 INFO - PROCESS | 1653 | 05:13:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:49 INFO - PROCESS | 1653 | RSS: Main: 265400320 05:13:49 INFO - PROCESS | 1653 | 05:13:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:52 INFO - PROCESS | 1653 | RSS: Main: 265433088 05:13:52 INFO - PROCESS | 1653 | 05:13:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:56 INFO - PROCESS | 1653 | RSS: Main: 265977856 05:13:56 INFO - PROCESS | 1653 | 05:13:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:00 INFO - PROCESS | 1653 | RSS: Main: 265490432 05:14:00 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 05:14:02 INFO - PROCESS | 1653 | RSS: Main: 268709888 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | __start_tp_report 05:14:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:14:02 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:14:02 INFO - PROCESS | 1653 | |i|pagename|runs| 05:14:02 INFO - PROCESS | 1653 | |0;ai-astar;106;118;118;119;114;119;118;119;118;119 05:14:02 INFO - PROCESS | 1653 | |1;audio-beat-detection;146;119;120;189;144;113;116;113;137;120 05:14:02 INFO - PROCESS | 1653 | |2;audio-dft;209;214;207;224;198;198;198;195;202;192 05:14:02 INFO - PROCESS | 1653 | |3;audio-fft;83;63;61;87;87;50;84;53;74;76 05:14:02 INFO - PROCESS | 1653 | |4;audio-oscillator;82;72;84;71;72;70;83;71;98;114 05:14:02 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;119;92;92;90;93;118;100;136;135;91 05:14:02 INFO - PROCESS | 1653 | |6;imaging-darkroom;127;137;156;140;98;99;98;121;151;154 05:14:02 INFO - PROCESS | 1653 | |7;imaging-desaturate;94;96;93;92;94;76;147;144;93;91 05:14:02 INFO - PROCESS | 1653 | |8;json-parse-financial;54;69;92;88;90;63;65;64;63;63 05:14:02 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;72;83;102;70;63;100;100;62;107 05:14:02 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;103;108;94;92;101;113;90;88;95;89 05:14:02 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;162;158;163;150;157;158;155;161;193;150 05:14:02 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;211;159;226;208;214;236;186;173;207;233 05:14:02 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;69;70;70;68;70;69;70;84;87;87 05:14:02 INFO - PROCESS | 1653 | __end_tp_report 05:14:02 INFO - PROCESS | 1653 | __start_cc_report 05:14:02 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,999 05:14:02 INFO - PROCESS | 1653 | __end_cc_report 05:14:02 INFO - PROCESS | 1653 | __startTimestamp1487164442628__endTimestamp 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:14:02 INFO - PROCESS | 1653 | Number of tests: 14 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:116.80 Median:118.50 stddev:4.08 (3.4%) stddev-sans-first:1.58 05:14:02 INFO - PROCESS | 1653 | Values: 106.0 118.0 118.0 119.0 114.0 119.0 118.0 119.0 118.0 119.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:128.50 stddev:23.68 (18.4%) stddev-sans-first:24.55 05:14:02 INFO - PROCESS | 1653 | Values: 146.0 119.0 120.0 189.0 144.0 113.0 116.0 113.0 137.0 120.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:203.70 Median:204.50 stddev:9.83 (4.8%) stddev-sans-first:10.24 05:14:02 INFO - PROCESS | 1653 | Values: 209.0 214.0 207.0 224.0 198.0 198.0 198.0 195.0 202.0 192.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:71.80 Median:79.50 stddev:14.07 (17.7%) stddev-sans-first:14.33 05:14:02 INFO - PROCESS | 1653 | Values: 83.0 63.0 61.0 87.0 87.0 50.0 84.0 53.0 74.0 76.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:77.00 stddev:14.41 (18.7%) stddev-sans-first:15.29 05:14:02 INFO - PROCESS | 1653 | Values: 82.0 72.0 84.0 71.0 72.0 70.0 83.0 71.0 98.0 114.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:106.60 Median:90.50 stddev:18.64 (20.6%) stddev-sans-first:19.23 05:14:02 INFO - PROCESS | 1653 | Values: 119.0 92.0 92.0 90.0 93.0 118.0 100.0 136.0 135.0 91.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:128.10 Median:155.00 stddev:23.34 (15.1%) stddev-sans-first:24.76 05:14:02 INFO - PROCESS | 1653 | Values: 127.0 137.0 156.0 140.0 98.0 99.0 98.0 121.0 151.0 154.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:93.00 stddev:23.60 (25.4%) stddev-sans-first:24.85 05:14:02 INFO - PROCESS | 1653 | Values: 94.0 96.0 93.0 92.0 94.0 76.0 147.0 144.0 93.0 91.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:67.00 stddev:13.58 (20.3%) stddev-sans-first:12.92 05:14:02 INFO - PROCESS | 1653 | Values: 54.0 69.0 92.0 88.0 90.0 63.0 65.0 64.0 63.0 63.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:65.00 stddev:17.95 (27.6%) stddev-sans-first:18.13 05:14:02 INFO - PROCESS | 1653 | Values: 67.0 72.0 83.0 102.0 70.0 63.0 100.0 100.0 62.0 107.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:89.50 stddev:8.56 (9.6%) stddev-sans-first:8.83 05:14:02 INFO - PROCESS | 1653 | Values: 103.0 108.0 94.0 92.0 101.0 113.0 90.0 88.0 95.0 89.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:160.70 Median:159.50 stddev:12.20 (7.7%) stddev-sans-first:12.93 05:14:02 INFO - PROCESS | 1653 | Values: 162.0 158.0 163.0 150.0 157.0 158.0 155.0 161.0 193.0 150.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.30 Median:212.50 stddev:25.42 (12.0%) stddev-sans-first:26.88 05:14:02 INFO - PROCESS | 1653 | Values: 211.0 159.0 226.0 208.0 214.0 236.0 186.0 173.0 207.0 233.0 05:14:02 INFO - PROCESS | 1653 | 05:14:02 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:70.00 stddev:8.07 (11.5%) stddev-sans-first:8.32 05:14:02 INFO - PROCESS | 1653 | Values: 69.0 70.0 70.0 68.0 70.0 69.0 70.0 84.0 87.0 87.0 05:14:02 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:14:02 INFO - PROCESS | 1653 | 05:14:03 INFO - TEST-INFO | 1653: exit 0 05:14:03 INFO - TEST-OK | kraken | took 62354ms 05:14:03 INFO - SUITE-END | took 1179s 05:14:03 INFO - Completed test suite (00:19:39) 05:14:03 INFO - javascript benchmark 05:14:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7286.213700105759, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.705148010939, 3346.6653334666535, 3374.2407958209405, 3396.1509622594353, 3436.1753179236985, 4491.955080449195, 4737.620990320779, 5556.86107847304, 5581.358143813458, 5690.089585666295, 5585.022621041312, 5633.352164501083, 5672.773089076442, 5704.686242256675, 5767.5962682612235, 5126.7183204198955, 5163.948360516394, 5182.404023537285, 5202.089634313998, 5321.909008653217, 5165.76754046067, 5285.392179899303, 5328.653637513568, 5337.599680023995, 5358.115910874701, 5076.390833100015, 5099.847004589868, 5276.5251127398715, 5294.655847369909, 5335.7865685372535, 5060.645754797166, 5109.974450127763, 5110.8466745997675, 5128.71792051437, 5130.358705161855, 5035.697858128524, 5054.671446355975, 5087.211482220262, 5101.438841727407, 5129.589632829365, 3995.1210733638845, 4422.513523512411, 5300.178472336794, 5570.805021824257, 5608.663480191201, 6026.306974697922, 6066.514678825683, 6096.298925623566, 6101.792513241549, 6114.2968558615885, 6127.662978536178, 6155.907661385083, 6177.81466556004, 6187.690615469253, 6192.225971753531, 4898.706077635354, 5856.0630299151935, 5860.413958604106, 5872.11918212263, 5881.941180588225, 6104.004449388181, 6123.510119190454, 6234.625922444668, 6301.117843501914, 6311.601591395241, 6008.0, 6097.8475538111015, 6100.8779824404155, 6118.771466971993, 6138.539609529304, 5730.054541000772, 5765.106408506688, 6174.0, 6218.657973811393, 6278.089676996809, 6117.785877494266, 6194.5973511721595, 6196.411340922605, 6264.9976003839165, 6268.373162683695, 6026.0, 6106.236720409949, 6113.786017489367, 6142.468080853438, 6149.692515374213, 4934.1611925972675, 4971.651984361132, 4975.203967365276, 5005.024020316004, 5092.083424983539, 4449.7775111244955, 4462.0, 4471.709338893027, 4485.641148708096, 4488.0, 5472.781088756406, 5848.385919478478, 5888.735006924699, 5912.320083190402, 5945.672987985616, 6120.44915957566, 6199.318075011745, 6205.503559715212, 6212.565120441616, 6220.315765265817, 4649.349091127245, 4872.926906096412, 5176.430592634807, 5917.082852157922, 5991.340952495222, 4563.315502674559, 4690.366800481959, 5477.123660214346, 5478.780848766084, 5493.2034854945805, 5143.691378517301, 6248.0, 6250.4374606285655, 6333.0, 6444.548881578432, 6087.512998960161, 6132.814448934826, 6185.443310102112, 6215.471684906834, 6282.874342513032, 6201.937980620136, 6215.378462153749, 6243.7814676486105, 6295.653739044396, 6370.076338930921, 6140.600860944024, 6223.408776166257, 6245.406686364788, 6246.875062498815, 6260.436560709558, 5424.728763561885, 5786.189933409242, 6248.343923887926, 6259.6870156492905, 6272.341404152681, 5969.76120955157, 6049.30433000193, 6056.454919057306, 6067.362926892612, 6069.605475644069, 6024.9397506026135, 6050.45545900871, 6052.697365131814, 6072.240969878765, 6173.351798061139, 4878.756062196947, 5112.309838171948, 5707.8858422832145, 5991.910121348096, 5995.2206213192, 6076.817695469143, 6122.877542449215, 6149.96925015372, 6155.507559395327, 6170.444659980623, 5768.221290125779, 5810.622309549865, 5815.302163740378, 5987.43119403656, 6016.42843929826], "value": 5595.823108629713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.1515807968374, 517.6635187128364, 521.0776924843028, 553.5875772549449, 590.512826917793, 37697.43453848191, 38432.03919902004, 40342.39486407706, 40377.79811100948, 40468.0, 34855.4771678425, 41602.58397416025, 42165.0, 42437.0, 42556.0, 9327.6735314264, 10947.34315941046, 11244.550217991271, 11305.378204198765, 11499.540018399253, 11287.435628218598, 11348.546058157704, 11394.25937314072, 11401.942990285037, 11425.600103996361, 11094.057005154531, 11108.61119860805, 11121.0, 11181.608643697473, 11183.217174797768, 11304.491297891615, 11385.430728463543, 11405.030572401272, 11405.54377824886, 11413.885861141365, 11205.21563490556, 11224.719382015433, 11236.325820450716, 11265.662030139109, 11285.887141128565, 36903.63096369029, 36927.63072369296, 37183.62816371856, 37289.62710372916, 37309.62690373116, 2999.8350090745002, 3462.9653703462895, 3761.322961866863, 3781.9243615127543, 3810.333191691443, 27265.318367040785, 27852.303692407648, 28081.578776318373, 28193.0, 28807.855960720273, 3054.480738274499, 3116.0807561769334, 3117.7505799535984, 3131.060681795452, 3207.8075315481146, 448595.0, 449947.0, 454438.0, 456415.0, 458027.0, 44843.55156448394, 45362.546374535836, 54513.0, 54972.45027549753, 55190.0, 57855.132173016595, 57906.0, 57998.420015799304, 58041.70979145162, 58098.838023239296, 14276.0, 14299.78550321746, 14418.783718244234, 14460.710785784437, 14465.27673616336, 10957.56169753201, 10978.615748448925, 11038.668839934815, 11123.0, 11147.0, 17177.31290748381, 17391.56521086983, 17453.65092698139, 17453.91273043652, 17487.213075411637, 7665.961670191613, 7794.2985131338455, 7813.10149332834, 7848.077221080872, 7855.5286682799215, 834.6202477872554, 836.2515548583983, 844.1263292492364, 854.3165467625874, 872.4852337121129, 22540.32379028632, 26597.0, 28079.0, 28493.0, 29786.0, 890.7238755985536, 1021.5352014833232, 1058.3385384134915, 1063.712797544674, 1170.403094421851, 14540.49108281205, 14776.630584235265, 15135.924320378328, 15239.806358237172, 15532.767008494882, 573553.0, 577524.0, 577770.0, 579477.0, 584691.0, 43549.0, 52873.149439769426, 53509.929801404534, 53566.92866142733, 53700.0, 1338.625184948216, 1345.5425155447194, 1378.3935068569797, 1378.9241591712353, 1380.344336440203, 23906.0, 27593.44813103767, 27611.861940690167, 28417.005404810734, 29044.27389315284, 37767.244655106195, 45694.0, 46444.53555464402, 46471.535284648075, 46488.302675460574, 518376.0, 521737.0, 521866.0, 522000.38999804755, 522070.0, 24189.0, 24877.87561062183, 24961.251162465156, 25101.74898250994, 25103.497930040932, 35068.298634027684, 40933.56732514348, 41742.79128604459, 41896.95257618584, 41987.0, 33107.0, 33908.49137262993, 33967.66032339645, 35137.29725405529, 35300.47049294314, 28525.857370713013, 29352.70647293585, 33738.831305844295, 34091.488627671104, 35930.10174745652, 26057.609135862596, 27761.583576246776, 33913.66086339105, 34640.82679586586, 34961.12597185091, 28268.010619628214, 30156.0, 30219.244518887204, 30323.393532129674, 30794.846025770625, 19869.0, 21223.469413264793, 22644.320670379915, 23372.298831035096, 23567.764322356557], "value": 19005.99561349607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.51349489260997, 340.2361697988017, 371.528159237768, 385.24299750989303, 409.83811394499173, 19602.0, 20217.191312347524, 20549.794502054974, 20603.896980515114, 20843.0, 17160.914195429006, 20820.791792082076, 21262.0, 21269.14923403062, 21601.0, 5521.3926468088475, 5808.925348810483, 5950.494207992326, 6068.726907289182, 6213.0, 6010.068439391901, 6113.572049956505, 6120.785772497963, 6123.326434092246, 7487.2887075727995, 7507.474476786627, 7865.803354916145, 7921.366290696759, 8030.879536806952, 8063.838723225532, 6993.720251189946, 7733.304002639761, 7989.520628762293, 7996.800079997988, 8073.434859559804, 6809.557378770364, 7373.373263272575, 7753.263439973193, 7823.726169584094, 7914.862986993479, 28420.573691394646, 28547.71452285492, 28894.855525722447, 28976.0, 29349.559756603667, 2806.2984253936515, 2890.4363649088436, 2911.694272101441, 2924.6051783009234, 2938.9412211755857, 15910.0, 16301.918490407472, 16548.58628534284, 16981.405650802288, 17399.913000435045, 2001.6597178479694, 2012.4566367080952, 2025.878447293167, 2052.7126202331688, 2070.430631576329, 139042.0, 144808.0, 145304.0, 147071.0, 165813.9999999988, 18566.0, 21049.78950210509, 22650.0, 22975.0, 23499.20063948868, 39268.80365598154, 39363.60636393657, 39478.60521394749, 39549.60450395459, 39567.208655826726, 10334.638287659896, 10608.416537090534, 10769.030787229187, 10840.891591084146, 10995.670129896116, 8540.829183416297, 8558.957205213934, 8579.14208579137, 8686.218240358397, 8716.215540601377, 10119.898801011896, 10968.894180681744, 10978.966139030223, 11011.174161937886, 11100.167487438475, 3972.3842804365368, 4283.785810709452, 4326.329418940069, 4327.697061205686, 4332.505285676437, 746.4700062955254, 838.1241602525375, 839.3998291221684, 866.8743032260287, 876.1939016105199, 15738.606534836492, 16644.0, 16744.748828767577, 20722.378328650164, 20961.790382095984, 843.2663582683105, 874.696701914156, 884.6638277454526, 897.5018864530249, 900.2617853360313, 9779.0, 10558.260921735558, 10721.142308615292, 10758.139348852073, 10802.89197108019, 660747.0, 667820.9134314946, 668272.0, 676621.0, 686122.0, 117292.0, 139450.0, 146216.0, 152478.0, 155512.22243888708, 848.1391387741447, 950.6530116507563, 999.5352161245056, 1012.2661070723666, 1029.9948500257601, 19525.51186220356, 19699.0, 19824.90962997049, 19856.10647520894, 19857.304994325128, 49254.26118608152, 49380.0, 51429.48570514397, 56280.0, 57016.0, 55673.44326556844, 59088.70455647866, 68387.3161268381, 76544.61727691325, 76923.0, 8106.351491880753, 8147.75556733299, 8411.200935911078, 8470.618822152896, 8493.065762766215, 10868.891311087104, 11705.648830535098, 12586.370681466073, 13040.282784446947, 13187.670308241986, 10865.348079114961, 11131.721706957067, 11285.71785705364, 11315.603953861575, 11336.6032188873, 10429.739256518647, 10666.73333166677, 10888.836667450152, 11239.887601123884, 11260.718482038015, 11165.609203677832, 11351.54593816238, 11445.828312575484, 11579.536818527165, 11691.766164676488, 7119.572825630479, 7533.849323013399, 7548.584827834522, 7650.846983060196, 8696.565171741515, 9616.0, 10990.340579565252, 11124.944375278072, 11441.42792860337, 11514.19400641947], "value": 11110.933300373406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.1429485129515, 1441.1209162410928, 1441.5170917742555, 1448.550949205747, 1462.7732701431275, 7276.235995220505, 8129.065157506881, 8185.263326300632, 8520.0, 8529.701460448894, 7898.5260884346835, 8432.451890627104, 8451.070382257947, 8480.32157427406, 8781.473111613308, 2231.475603233243, 2263.0155882191216, 2268.8071513921336, 2268.8638681679154, 2268.9092436302526, 2238.977610223901, 2274.1812947338944, 2276.5788329159077, 2279.1453205048106, 2283.1552325639536, 2130.1479408236673, 2133.5839511295303, 2142.73215848019, 2154.946126346846, 2162.1891790578534, 2139.411661793004, 2213.8339624528144, 2229.264342766883, 2236.2285011670947, 2243.55128974205, 1680.4706517447087, 1899.705545640428, 2188.0919418441326, 2299.413649519362, 2301.42464383904, 8187.508749474991, 8392.118827523143, 8422.410431269813, 8450.661973521052, 8484.236418722345, 5002.7248501332415, 5146.511081447256, 5151.5878729701535, 5153.201253805666, 5166.328377310925, 3414.9829250853836, 3424.6404127566743, 3433.901151631479, 3479.704225140866, 3504.3867323218333, 995.2485873165714, 1051.2536099369456, 1173.3194747046693, 1212.6180253220296, 1238.2199214494901, 10704.250702450832, 10744.892551074545, 10784.0, 10804.891951080468, 10839.620613278497, 3707.3882809336696, 4101.318459431619, 4395.164918665443, 4411.0, 4418.513963464016, 8260.215279548433, 8263.462874913112, 8581.742547723577, 8605.65577376898, 8615.310775137974, 5037.0, 5055.87360315995, 5065.518775716301, 5071.949280507148, 5089.3638295213095, 4476.306172543261, 4557.225271703818, 4644.976775116171, 4737.478877323491, 4750.8337208197545, 3566.6789988901123, 3605.963940360563, 3656.305301992613, 3668.8715894944085, 3671.3575124353133, 1114.1393872233389, 1125.6172901213627, 1142.7600203957095, 1142.7714457108611, 1146.4267866066966, 831.5094094484283, 837.7570504553611, 858.8454078265972, 874.501534125555, 899.4288626722079, 5377.193420986883, 5392.352917649829, 5421.186821976735, 5487.478689524489, 5570.86072848182, 897.2239013253619, 927.703134996808, 931.1759093202429, 939.6664184214505, 976.6776963601994, 3440.7247420206822, 3614.9277014459562, 3624.05774498627, 3676.209614932802, 3744.925101497955, 9400.90599094014, 9468.90531094694, 9690.933997260296, 9778.853317200248, 9785.972472890244, 9717.93102758696, 9781.266405019509, 9810.950945245371, 9817.969113243149, 9827.262955278382, 7718.266764657348, 7876.842463150705, 7900.328472079823, 7915.050193976645, 7917.722879699068, 4578.2664361757825, 5227.372715274039, 5491.835244942658, 5559.138333558305, 5631.774729010957, 8930.642774289216, 8946.776330591787, 9084.772880678036, 9170.312226582899, 9191.678291259774, 8880.955595222242, 9088.0, 9268.0, 9408.482533460452, 9410.29422793307, 7034.718611255493, 7246.1666908306215, 7251.1298644163035, 7295.8540829184185, 7335.156457007299, 7663.1570527243075, 7748.7675369739, 7814.843703125792, 7852.332551733167, 7868.763937081668, 7099.645017749195, 7158.2841715828, 7194.892076618959, 7215.098112735908, 7230.6384680766805, 6981.755638552626, 7069.505134640526, 7073.2219455858785, 7111.857762844611, 7171.390431813355, 6217.253929528486, 6326.588771729823, 6335.049742538472, 6354.3963323484195, 6360.173177486897, 4844.103840789465, 4876.561109500162, 4932.778024988956, 4964.0, 5067.77195026232, 4764.2615394613895, 4863.683860549053, 4934.457209706858, 4951.8266860659705, 5029.5221953914315], "value": 4311.666413411356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8991397537726, 346.5823682462633, 355.2982858853764, 360.8971443138705, 361.90771353304905, 4224.767637779921, 5247.895042099156, 5410.729463526827, 5410.917816436714, 5454.699991500466, 4751.311059896313, 4776.307435421871, 5032.8993420131665, 5084.949150508493, 5315.973420132904, 3629.2922880038404, 3857.633524815138, 4000.9997500624845, 4195.8741237762915, 4221.366794980747, 3687.244114956441, 3911.8044097795137, 4222.0922501662135, 4224.72539284947, 4263.936040959388, 4081.3061779497407, 4118.629323360897, 4133.524644665857, 4143.316352801784, 4157.48031496063, 3833.674137698271, 3920.411938209263, 4010.418489319062, 4129.132882094764, 4135.379693046037, 3229.8708051677904, 3646.978845923146, 3652.7443078984484, 3662.688671462929, 3681.37416639172, 4133.1940271647045, 4264.23243816113, 5019.749012549358, 5224.555912747421, 5252.3171987641745, 4235.195312890572, 4420.778961051967, 4608.115397678438, 4790.233562629997, 4832.0, 5659.51894089003, 5661.5187709044785, 5693.430656934315, 5693.914591281134, 5700.002499562602, 3592.5868525119686, 3839.2705385976574, 3982.820773065219, 4027.1004876488882, 4035.556088830226, 4903.4851340609075, 4994.351863884909, 5457.372402173722, 5604.113881351107, 5853.770708151251, 3440.385307166521, 3907.0623050468253, 4073.6537394321813, 4079.1229885574744, 4086.059121917125, 3342.359535966608, 3526.6297038811067, 4151.398047283127, 4160.292750232467, 4176.4570605821655, 4611.239145541015, 4688.789004494806, 4752.95247047532, 4791.730191499256, 4826.686265392738, 4808.422989241313, 5564.443555644403, 5651.717414129277, 5716.971415142898, 5724.885502290014, 1097.6816723150198, 1251.2367455851922, 1256.378092844048, 1353.6006877971022, 1356.077867050415, 877.087828658201, 956.1394744729798, 961.9807603847884, 970.9755160490315, 972.9659461918799, 4482.148391805546, 4988.254111061099, 5018.347614810052, 5033.672811267256, 5043.697378157249, 4505.504394516601, 4733.644976626698, 5165.535101840777, 5472.50747432733, 5609.411011843697, 4197.76912269822, 4488.483824360241, 4927.975360123177, 5063.442961304591, 5073.746312684351, 2513.748625137508, 2598.3244356467076, 2680.517506848786, 2871.3970066285897, 2889.8242040252053, 5001.799928002839, 5631.915521267184, 5763.538916886639, 5795.739191736382, 5801.88396232073, 4800.687955282965, 5332.893342133136, 5431.538319242909, 5718.256626638594, 5745.540356771448, 4820.746605882426, 5114.718690471986, 5131.512506311969, 5723.3418156912485, 5765.682887441231, 4920.975395123001, 5080.974595127001, 5557.4158016522515, 5569.526590239875, 5581.162825576196, 4568.406107206042, 4840.273958906051, 5265.4997775211295, 5340.412554619066, 5442.12925931849, 5286.1762691871245, 5532.640378375393, 5826.883462330815, 5839.591228613956, 6040.879182416239, 3341.4486609710098, 3931.587183345822, 4010.9398359024053, 4070.9185816284103, 4077.368007958771, 4839.612830973443, 5659.085570931056, 5787.623804452697, 5800.5208671790115, 5821.388754180919, 4517.97741011306, 4675.76621168947, 4906.852794416173, 5175.792968281377, 5538.280023596906, 4769.993205707223, 5391.002664507078, 5566.4135721320845, 5607.607467477401, 5607.971960140173, 4554.132805549709, 4554.134714404253, 4607.285870690049, 5352.705601191972, 5454.172852094593, 4513.977430112828, 5336.879255356419, 5551.278333816578, 5570.41243245673, 5609.663420194802, 4812.951870481391, 5439.728013599383, 5475.753591088331, 5491.588130890279, 5492.286002819608], "value": 4042.9585096294327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.6981858163828, 688.8794460969335, 772.8724760414532, 777.5839925639782, 785.2265518464312, 14368.994170408076, 14767.261636918165, 15163.39346426143, 15175.92412037941, 15201.467948621786, 13954.302284885765, 14161.008729388946, 14207.076540024891, 14370.784438233435, 14455.56633301, 872.2237208884098, 876.9342299327544, 882.3206131278912, 883.4919921045424, 884.5400391796262, 860.513809697522, 871.7864123289803, 872.7469033980138, 873.1704880363649, 895.4716717136888, 927.0405130689737, 938.0103990290241, 938.3384713776771, 940.1773448232797, 940.219617717293, 920.1580553793272, 932.7854593443478, 934.6635211323918, 936.6815282803811, 936.8266870628921, 690.4752388184966, 692.1659400422479, 692.4425837201051, 692.7506097804786, 692.9861402771917, 15335.923320383437, 15345.0, 15415.691686166214, 15459.845401546065, 15743.527694169194, 13700.45198192071, 13880.51418200358, 13939.930300348433, 13941.745242928084, 13972.301384930714, 11275.943620281929, 11376.146788990858, 11540.422978851024, 11543.249688770204, 11763.470643821049, 3583.812731626373, 3606.536226634162, 3639.2175682228185, 3666.651668091527, 3791.317562838688, 92113.53943230308, 101928.0, 103642.0, 105045.47477262642, 105704.41443378432, 9952.701418957442, 10358.482075896174, 10613.204009699304, 10724.624638137628, 10848.349099054081, 22408.887955560444, 22416.215432459787, 22417.10331586751, 22448.887755561118, 22488.875556222123, 7386.187519372865, 7404.0, 7549.245075492407, 7615.314621684075, 7655.885161722578, 4080.836766529365, 4166.291730405838, 4201.957980420218, 4223.936640950388, 4257.5529569395385, 3178.6185657720757, 3601.117726157056, 3606.1525541497726, 3710.7588006779474, 3720.7023438124884, 656.9047488114197, 659.6404959297195, 664.1432552007856, 667.0561155964256, 667.9966600167065, 632.5824955529329, 641.7304732012473, 662.5494663628682, 693.7051753004953, 711.7580022792275, 7399.408047356199, 9429.15137637616, 9617.326787124974, 9641.132298093065, 9794.595880027387, 477.6895018238173, 556.0380541662946, 642.4154019842015, 673.7843889955266, 706.2090458686304, 3326.534285200074, 4016.116454380032, 4048.6356227939627, 4129.607687269705, 4828.330468843634, 73736.0, 94271.0, 94626.58060129103, 95342.0, 95706.52146739361, 63357.68321158457, 69268.65365673139, 69592.0, 76087.85868211981, 77628.0, 53142.20286695703, 53229.66925826808, 67952.6023698823, 69197.65401172962, 71958.0, 10170.898291016994, 10440.0, 10489.737756555842, 10544.876570804214, 10683.57265709363, 45110.0, 47195.292070618285, 47281.76359118182, 47765.0, 49028.019439610296, 53702.92594148017, 62084.0, 62415.0, 62688.37311627008, 64782.35217647763, 12538.683438238853, 12769.808452873029, 12816.479326171539, 12827.166234194747, 13393.66515837112, 12628.926541243729, 13727.519536816164, 14077.0, 14220.786688199478, 14750.63123421923, 13372.130811497222, 13396.397162127923, 13397.732045359233, 13519.0, 13690.726185476435, 12061.15571909993, 13147.934260328637, 13473.124246923919, 13627.318634068455, 13752.862471375158, 12644.557440489538, 12947.223166610034, 13058.608241752763, 13193.20840749558, 13543.155937252894, 10734.0, 10972.341659500136, 11003.779924401628, 11120.277181983469, 11314.773704526027, 6633.5704011505495, 9892.901070989197, 10706.89293107059, 10726.195535334726, 10847.67456976292], "value": 7262.932406280492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1633.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 119.0, 114.0, 119.0, 118.0, 119.0, 118.0, 119.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 120.0, 189.0, 144.0, 113.0, 116.0, 113.0, 137.0, 120.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 214.0, 207.0, 224.0, 198.0, 198.0, 198.0, 195.0, 202.0, 192.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 63.0, 61.0, 87.0, 87.0, 50.0, 84.0, 53.0, 74.0, 76.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 84.0, 71.0, 72.0, 70.0, 83.0, 71.0, 98.0, 114.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 92.0, 92.0, 90.0, 93.0, 118.0, 100.0, 136.0, 135.0, 91.0], "value": 106.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 137.0, 156.0, 140.0, 98.0, 99.0, 98.0, 121.0, 151.0, 154.0], "value": 128.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 93.0, 92.0, 94.0, 76.0, 147.0, 144.0, 93.0, 91.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 69.0, 92.0, 88.0, 90.0, 63.0, 65.0, 64.0, 63.0, 63.0], "value": 71.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 83.0, 102.0, 70.0, 63.0, 100.0, 100.0, 62.0, 107.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 94.0, 92.0, 101.0, 113.0, 90.0, 88.0, 95.0, 89.0], "value": 97.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 163.0, 150.0, 157.0, 158.0, 155.0, 161.0, 193.0, 150.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 159.0, 226.0, 208.0, 214.0, 236.0, 186.0, 173.0, 207.0, 233.0], "value": 205.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 70.0, 69.0, 70.0, 84.0, 87.0, 87.0], "value": 74.4, "unit": "score"}]}]} 05:14:03 INFO - Return code: 0 05:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:03 ERROR - # TBPL SUCCESS # 05:14:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:03 INFO - 2017-02-15 05:14:03.983 screenresolution[1658:10958] starting screenresolution argv=screenresolution get 05:14:03 INFO - 2017-02-15 05:14:03.986 screenresolution[1658:10958] Display 0: 1600x1200x32@60 05:14:03 INFO - 2017-02-15 05:14:03.993 screenresolution[1659:10961] starting screenresolution argv=screenresolution list 05:14:03 INFO - Available Modes on Display 0 05:14:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:04 INFO - Intel Iris: 05:14:04 INFO - Chipset Model: Intel Iris 05:14:04 INFO - Type: GPU 05:14:04 INFO - Bus: Built-In 05:14:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:04 INFO - Vendor: Intel (0x8086) 05:14:04 INFO - Device ID: 0x0a2e 05:14:04 INFO - Revision ID: 0x0009 05:14:04 INFO - Displays: 05:14:04 INFO - Display: 05:14:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:04 INFO - Display Serial Number: 1600x1200 60 05:14:04 INFO - Main Display: Yes 05:14:04 INFO - Mirror: Off 05:14:04 INFO - Online: Yes 05:14:04 INFO - Rotation: Supported 05:14:04 INFO - Return code: 0 05:14:04 INFO - Running post-action listener: _resource_record_post_action 05:14:04 INFO - [mozharness: 2017-02-15 13:14:04.230676Z] Finished run-tests step (success) 05:14:04 INFO - Running post-run listener: _resource_record_post_run 05:14:04 INFO - Total resource usage - Wall time: 1204s; CPU: 55.0%; Read bytes: 41126400; Write bytes: 559499264; Read time: 402; Write time: 1879 05:14:04 INFO - TinderboxPrint: CPU usage
54.6% 05:14:04 INFO - TinderboxPrint: I/O read bytes / time
41,126,400 / 402 05:14:04 INFO - TinderboxPrint: I/O write bytes / time
559,499,264 / 1,879 05:14:04 INFO - TinderboxPrint: CPU idle
2,185.5 (45.4%) 05:14:04 INFO - TinderboxPrint: CPU system
968.9 (20.1%) 05:14:04 INFO - TinderboxPrint: CPU user
1,659.3 (34.5%) 05:14:04 INFO - TinderboxPrint: Swap in / out
292,806,656 / 0 05:14:04 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 327680; Write bytes: 254765056; Read time: 8; Write time: 534 05:14:04 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 36284928; Write bytes: 303128576; Read time: 366; Write time: 1340 05:14:04 INFO - Running post-run listener: _upload_blobber_files 05:14:04 INFO - Blob upload gear active. 05:14:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:04 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 05:14:04 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'] 05:14:04 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 05:14:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:06 INFO - (blobuploader) - INFO - Done attempting. 05:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:07 INFO - (blobuploader) - INFO - Done attempting. 05:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:08 INFO - (blobuploader) - INFO - Done attempting. 05:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:10 INFO - (blobuploader) - INFO - Done attempting. 05:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:10 INFO - Return code: 0 05:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9778c69335b3316d0099ef14757ac1653933d8e7e3f79e09a95bbb8247d44d7cc69c5a222892a873e033413b4f817275659e3ee92afbab4081bdba6a4d77dffc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfe3186f78461564e5b10f5dbd6caba0f1d4e72371a74f1f70f68393d33d6e02ac25057e3f120f37be70d7a9a483503f292d102f324817838e5f5b481b290a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b001abea33a9c0455514b713a6be1a8d607fca87c0584895666762fafdeef724ac2c41c8ff97ecc3c9638cde4fa3d5ee3faa044ecfbc60d7892330f09bb821f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c0b508ece43ae27f5fd4c10d025c05386b92a7793eaeced174858c45805dec4e217a81807746d0c21af919865b8025a4d330e5284686cb194774f28544fb2b"} 05:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:10 INFO - Contents: 05:14:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9778c69335b3316d0099ef14757ac1653933d8e7e3f79e09a95bbb8247d44d7cc69c5a222892a873e033413b4f817275659e3ee92afbab4081bdba6a4d77dffc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfe3186f78461564e5b10f5dbd6caba0f1d4e72371a74f1f70f68393d33d6e02ac25057e3f120f37be70d7a9a483503f292d102f324817838e5f5b481b290a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b001abea33a9c0455514b713a6be1a8d607fca87c0584895666762fafdeef724ac2c41c8ff97ecc3c9638cde4fa3d5ee3faa044ecfbc60d7892330f09bb821f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c0b508ece43ae27f5fd4c10d025c05386b92a7793eaeced174858c45805dec4e217a81807746d0c21af919865b8025a4d330e5284686cb194774f28544fb2b"} 05:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:10 INFO - Copying logs to upload dir... 05:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.136127 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-15 05:14:10.771672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 05:14:10.775019) ========= 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.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9778c69335b3316d0099ef14757ac1653933d8e7e3f79e09a95bbb8247d44d7cc69c5a222892a873e033413b4f817275659e3ee92afbab4081bdba6a4d77dffc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfe3186f78461564e5b10f5dbd6caba0f1d4e72371a74f1f70f68393d33d6e02ac25057e3f120f37be70d7a9a483503f292d102f324817838e5f5b481b290a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b001abea33a9c0455514b713a6be1a8d607fca87c0584895666762fafdeef724ac2c41c8ff97ecc3c9638cde4fa3d5ee3faa044ecfbc60d7892330f09bb821f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c0b508ece43ae27f5fd4c10d025c05386b92a7793eaeced174858c45805dec4e217a81807746d0c21af919865b8025a4d330e5284686cb194774f28544fb2b"} build_url:https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/RsgYy5joQ52L1nrdDQDD3g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9778c69335b3316d0099ef14757ac1653933d8e7e3f79e09a95bbb8247d44d7cc69c5a222892a873e033413b4f817275659e3ee92afbab4081bdba6a4d77dffc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39dfe3186f78461564e5b10f5dbd6caba0f1d4e72371a74f1f70f68393d33d6e02ac25057e3f120f37be70d7a9a483503f292d102f324817838e5f5b481b290a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b001abea33a9c0455514b713a6be1a8d607fca87c0584895666762fafdeef724ac2c41c8ff97ecc3c9638cde4fa3d5ee3faa044ecfbc60d7892330f09bb821f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c0b508ece43ae27f5fd4c10d025c05386b92a7793eaeced174858c45805dec4e217a81807746d0c21af919865b8025a4d330e5284686cb194774f28544fb2b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 05:14:10.812789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:14:10.813119) ========= 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.dllb9DI8jF/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.F6Ulndz8uF/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:14:10.861357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 05:14:10.861687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 05:14:10.862013) ========= ========= Total master_lag: 0.19 =========