builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1488205970.2 results: success (0) buildid: 20170227052808 builduid: 6d86f114caaf4e57b309794560ce201d revision: 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.203489) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.204090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.204434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.241870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.242295) ========= 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.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-27 06:32:50-- 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% 190M=0s 2017-02-27 06:32:50 (190 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095295 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.421319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.421643) ========= 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.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.029376 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:50.474172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 06:32:50.474562) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-27 06:32:51,222 truncating revision to first 12 chars 2017-02-27 06:32:51,223 Setting DEBUG logging. 2017-02-27 06:32:51,223 attempt 1/10 2017-02-27 06:32:51,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0934029f7f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 06:32:52,200 unpacking tar archive at: mozilla-aurora-0934029f7f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247084 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 06:32:51.747135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:51.747571) ========= script_repo_revision: 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:51.748179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:51.748486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 06:32:51.770205) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-27 06:32:51.770934) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:32:52 INFO - MultiFileLogger online at 20170227 06:32:52 in /builds/slave/test 06:32:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:32:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:52 INFO - {'append_to_log': False, 06:32:52 INFO - 'base_work_dir': '/builds/slave/test', 06:32:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:32:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:52 INFO - 'branch': 'Mozilla-Aurora', 06:32:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:52 INFO - 'config_files': ('talos/mac_config.py',), 06:32:52 INFO - 'default_actions': ('clobber', 06:32:52 INFO - 'read-buildbot-config', 06:32:52 INFO - 'download-and-extract', 06:32:52 INFO - 'populate-webroot', 06:32:52 INFO - 'create-virtualenv', 06:32:52 INFO - 'install', 06:32:52 INFO - 'run-tests'), 06:32:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:52 INFO - 'download_minidump_stackwalk': True, 06:32:52 INFO - 'download_symbols': 'ondemand', 06:32:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:52 INFO - 'installer_path': 'installer.exe', 06:32:52 INFO - 'log_level': 'info', 06:32:52 INFO - 'log_name': 'talos', 06:32:52 INFO - 'log_to_console': True, 06:32:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:32:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:32:52 INFO - 'opt_config_files': (), 06:32:52 INFO - 'pip_index': False, 06:32:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:52 INFO - 'cmd': ('bash', 06:32:52 INFO - '-c', 06:32:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:52 INFO - 'enabled': True, 06:32:52 INFO - 'halt_on_failure': False, 06:32:52 INFO - 'name': 'check_screen_resolution'},), 06:32:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:52 INFO - 'cmd': ('bash', 06:32:52 INFO - '-c', 06:32:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:52 INFO - 'enabled': True, 06:32:52 INFO - 'halt_on_failure': False, 06:32:52 INFO - 'name': 'check_screen_resolution'},), 06:32:52 INFO - 'run_cmd_checks_enabled': True, 06:32:52 INFO - 'sps_profile': False, 06:32:52 INFO - 'sps_profile_interval': 0, 06:32:52 INFO - 'suite': 'dromaeojs', 06:32:52 INFO - 'system_bits': '32', 06:32:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:52 INFO - 'title': 't-yosemite-r7-0037', 06:32:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:52 INFO - 'use_talos_json': True, 06:32:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:52 INFO - 'work_dir': 'build'} 06:32:52 INFO - [mozharness: 2017-02-27 14:32:52.629216Z] Running clobber step. 06:32:52 INFO - Running pre-action listener: _resource_record_pre_action 06:32:52 INFO - Running main action method: clobber 06:32:52 INFO - rmtree: /builds/slave/test/build 06:32:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:55 INFO - Running post-action listener: _resource_record_post_action 06:32:55 INFO - [mozharness: 2017-02-27 14:32:55.214780Z] Finished clobber step (success) 06:32:55 INFO - [mozharness: 2017-02-27 14:32:55.214911Z] Running read-buildbot-config step. 06:32:55 INFO - Running pre-action listener: _resource_record_pre_action 06:32:55 INFO - Running main action method: read_buildbot_config 06:32:55 INFO - Using buildbot properties: 06:32:55 INFO - { 06:32:55 INFO - "project": "", 06:32:55 INFO - "product": "firefox", 06:32:55 INFO - "script_repo_revision": "production", 06:32:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:32:55 INFO - "repository": "", 06:32:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:32:55 INFO - "buildid": "20170227052808", 06:32:55 INFO - "pgo_build": "False", 06:32:55 INFO - "basedir": "/builds/slave/test", 06:32:55 INFO - "buildnumber": 5, 06:32:55 INFO - "slavename": "t-yosemite-r7-0037", 06:32:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:32:55 INFO - "platform": "yosemite_r7", 06:32:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:32:55 INFO - "branch": "mozilla-aurora", 06:32:55 INFO - "repo_path": "releases/mozilla-aurora", 06:32:55 INFO - "revision": "0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec", 06:32:55 INFO - "stage_platform": "macosx64", 06:32:55 INFO - "builduid": "6d86f114caaf4e57b309794560ce201d", 06:32:55 INFO - "slavebuilddir": "test" 06:32:55 INFO - } 06:32:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 06:32:55 INFO - Running post-action listener: _resource_record_post_action 06:32:55 INFO - [mozharness: 2017-02-27 14:32:55.218101Z] Finished read-buildbot-config step (success) 06:32:55 INFO - [mozharness: 2017-02-27 14:32:55.218233Z] Running download-and-extract step. 06:32:55 INFO - Running pre-action listener: _resource_record_pre_action 06:32:55 INFO - Running main action method: download_and_extract 06:32:55 INFO - mkdir: /builds/slave/test/build/tests 06:32:55 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')]} 06:32:55 INFO - trying https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 06:32:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 06:32:56 INFO - Downloaded 1199 bytes. 06:32:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:32:56 INFO - Using the following test package requirements: 06:32:56 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:32:56 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 06:32:56 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 06:32:56 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'jsshell-mac.zip'], 06:32:56 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 06:32:56 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:32:56 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 06:32:56 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 06:32:56 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 06:32:56 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:32:56 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 06:32:56 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:32:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:32:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:32:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:32:57 INFO - Expected file size: 16357810 06:32:57 INFO - Obtained file size: 16357810 06:33:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:33:04 INFO - Expected file size: 16357810 06:33:04 INFO - Obtained file size: 16357810 06:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 06:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 06:33:12 INFO - Expected file size: 14403472 06:33:12 INFO - Obtained file size: 14403472 06:33:12 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')]} 06:33:12 INFO - trying https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:33:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 06:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 06:33:14 INFO - Downloaded 73925564 bytes. 06:33:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:33:14 INFO - mkdir: /builds/slave/test/properties 06:33:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:33:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:33:14 INFO - Contents: 06:33:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:33:15 INFO - Running post-action listener: _resource_record_post_action 06:33:15 INFO - Running post-action listener: set_extra_try_arguments 06:33:15 INFO - [mozharness: 2017-02-27 14:33:15.566475Z] Finished download-and-extract step (success) 06:33:15 INFO - [mozharness: 2017-02-27 14:33:15.566594Z] Running populate-webroot step. 06:33:15 INFO - Running pre-action listener: _resource_record_pre_action 06:33:15 INFO - Running main action method: populate_webroot 06:33:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:33:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:33:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:33:15 INFO - '--tppagecycles', 06:33:15 INFO - '7'], 06:33:15 INFO - 'tests': ['tsvgm']}}, 06:33:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:33:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:33:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:33:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:33:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['damp', 'tps']}, 06:33:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'tests': ['damp', 'tps']}, 06:33:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['dromaeo_dom']}, 06:33:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:33:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['basic_compositor_video']}, 06:33:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:33:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['a11yr', 06:33:15 INFO - 'ts_paint', 06:33:15 INFO - 'tpaint', 06:33:15 INFO - 'sessionrestore', 06:33:15 INFO - 'sessionrestore_no_auto_restore', 06:33:15 INFO - 'tabpaint']}, 06:33:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['tsvgx', 06:33:15 INFO - 'tsvgr_opacity', 06:33:15 INFO - 'tart', 06:33:15 INFO - 'tscrollx', 06:33:15 INFO - 'cart', 06:33:15 INFO - 'tsvg_static']}, 06:33:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:33:15 INFO - 'tsvgr_opacity', 06:33:15 INFO - 'tart', 06:33:15 INFO - 'tscrollx', 06:33:15 INFO - 'cart', 06:33:15 INFO - 'tsvg_static']}, 06:33:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'talos_options': ['--disable-e10s'], 06:33:15 INFO - 'tests': ['tp5o']}, 06:33:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:33:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'talos_options': ['--disable-e10s', 06:33:15 INFO - '--xperf_path', 06:33:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:15 INFO - 'tests': ['tp5n']}, 06:33:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:33:15 INFO - 'talos_options': ['--xperf_path', 06:33:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:15 INFO - 'tests': ['tp5n']}}, 06:33:15 INFO - 'talos.zip': {'path': '', 06:33:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:33:15 INFO - Running post-action listener: _resource_record_post_action 06:33:15 INFO - [mozharness: 2017-02-27 14:33:15.585198Z] Finished populate-webroot step (success) 06:33:15 INFO - [mozharness: 2017-02-27 14:33:15.585331Z] Running create-virtualenv step. 06:33:15 INFO - Running pre-action listener: _resource_record_pre_action 06:33:15 INFO - Running main action method: create_virtualenv 06:33:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:33:15 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 06:33:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:33:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:33:15 INFO - Using real prefix '/tools/python27' 06:33:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:33:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:33:19 INFO - Installing pip.................done. 06:33:19 INFO - Return code: 0 06:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:33:19 INFO - Reading from file tmpfile_stdout 06:33:19 INFO - Output received: 06:33:19 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) 06:33:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:33:19 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')]} 06:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:19 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')]} 06:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:19 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:19 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 06:33:19 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 06:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:19 INFO - 'HOME': '/Users/cltbld', 06:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:19 INFO - 'LOGNAME': 'cltbld', 06:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:19 INFO - 'MOZ_NO_REMOTE': '1', 06:33:19 INFO - 'NO_EM_RESTART': '1', 06:33:19 INFO - 'PAGER': '/bin/cat', 06:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:19 INFO - 'PWD': '/builds/slave/test', 06:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:19 INFO - 'SHELL': '/bin/bash', 06:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:19 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:19 INFO - 'USER': 'cltbld', 06:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:19 INFO - 'XPC_FLAGS': '0x0', 06:33:19 INFO - 'XPC_SERVICE_NAME': '0', 06:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:19 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 06:33:19 INFO - Cleaning up... 06:33:19 INFO - Return code: 0 06:33:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:33:19 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')]} 06:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:19 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')]} 06:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:19 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:19 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 06:33:19 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 06:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:19 INFO - 'HOME': '/Users/cltbld', 06:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:19 INFO - 'LOGNAME': 'cltbld', 06:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:19 INFO - 'MOZ_NO_REMOTE': '1', 06:33:19 INFO - 'NO_EM_RESTART': '1', 06:33:19 INFO - 'PAGER': '/bin/cat', 06:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:19 INFO - 'PWD': '/builds/slave/test', 06:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:19 INFO - 'SHELL': '/bin/bash', 06:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:19 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:19 INFO - 'USER': 'cltbld', 06:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:19 INFO - 'XPC_FLAGS': '0x0', 06:33:19 INFO - 'XPC_SERVICE_NAME': '0', 06:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:20 INFO - Downloading/unpacking psutil>=3.1.1 06:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:23 INFO - Installing collected packages: psutil 06:33:23 INFO - Running setup.py install for psutil 06:33:23 INFO - building 'psutil._psutil_osx' extension 06:33:23 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 06:33:24 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 06:33:24 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 06:33:24 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 06:33:24 INFO - building 'psutil._psutil_posix' extension 06:33:24 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 06:33:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:33:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:33:24 INFO - ^ 06:33:24 INFO - 1 warning generated. 06:33:24 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 06:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:24 INFO - Successfully installed psutil 06:33:24 INFO - Cleaning up... 06:33:24 INFO - Return code: 0 06:33:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:24 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:24 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 06:33:24 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 06:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:24 INFO - 'HOME': '/Users/cltbld', 06:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:24 INFO - 'LOGNAME': 'cltbld', 06:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:24 INFO - 'MOZ_NO_REMOTE': '1', 06:33:24 INFO - 'NO_EM_RESTART': '1', 06:33:24 INFO - 'PAGER': '/bin/cat', 06:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:24 INFO - 'PWD': '/builds/slave/test', 06:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:24 INFO - 'SHELL': '/bin/bash', 06:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:24 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:24 INFO - 'USER': 'cltbld', 06:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:24 INFO - 'XPC_FLAGS': '0x0', 06:33:24 INFO - 'XPC_SERVICE_NAME': '0', 06:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:33:27 INFO - Installing collected packages: mozsystemmonitor 06:33:27 INFO - Running setup.py install for mozsystemmonitor 06:33:27 INFO - Successfully installed mozsystemmonitor 06:33:27 INFO - Cleaning up... 06:33:27 INFO - Return code: 0 06:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:27 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:27 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 06:33:27 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 06:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:27 INFO - 'HOME': '/Users/cltbld', 06:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:27 INFO - 'LOGNAME': 'cltbld', 06:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:27 INFO - 'MOZ_NO_REMOTE': '1', 06:33:27 INFO - 'NO_EM_RESTART': '1', 06:33:27 INFO - 'PAGER': '/bin/cat', 06:33:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:27 INFO - 'PWD': '/builds/slave/test', 06:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:27 INFO - 'SHELL': '/bin/bash', 06:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:27 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:27 INFO - 'USER': 'cltbld', 06:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:27 INFO - 'XPC_FLAGS': '0x0', 06:33:27 INFO - 'XPC_SERVICE_NAME': '0', 06:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:28 INFO - Downloading/unpacking jsonschema==2.5.1 06:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:33:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:31 INFO - Downloading functools32-3.2.3-2.tar.gz 06:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:33:31 INFO - warning: no files found matching '*.txt' 06:33:31 INFO - no previously-included directories found matching 'build' 06:33:31 INFO - no previously-included directories found matching 'dist' 06:33:31 INFO - no previously-included directories found matching '.git*' 06:33:31 INFO - Installing collected packages: jsonschema, functools32 06:33:31 INFO - Running setup.py install for functools32 06:33:31 INFO - warning: no files found matching '*.txt' 06:33:31 INFO - no previously-included directories found matching 'build' 06:33:31 INFO - no previously-included directories found matching 'dist' 06:33:31 INFO - no previously-included directories found matching '.git*' 06:33:31 INFO - Successfully installed jsonschema functools32 06:33:31 INFO - Cleaning up... 06:33:31 INFO - Return code: 0 06:33:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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', '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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:33: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 functools32==3.2.3-2 06:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:31 INFO - 'HOME': '/Users/cltbld', 06:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:31 INFO - 'LOGNAME': 'cltbld', 06:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:31 INFO - 'MOZ_NO_REMOTE': '1', 06:33:31 INFO - 'NO_EM_RESTART': '1', 06:33:31 INFO - 'PAGER': '/bin/cat', 06:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:31 INFO - 'PWD': '/builds/slave/test', 06:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:31 INFO - 'SHELL': '/bin/bash', 06:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:31 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:31 INFO - 'USER': 'cltbld', 06:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:31 INFO - 'XPC_FLAGS': '0x0', 06:33:31 INFO - 'XPC_SERVICE_NAME': '0', 06:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:33:31 INFO - Cleaning up... 06:33:31 INFO - Return code: 0 06:33:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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', '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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:33: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 blobuploader==1.2.4 06:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:31 INFO - 'HOME': '/Users/cltbld', 06:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:31 INFO - 'LOGNAME': 'cltbld', 06:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:31 INFO - 'MOZ_NO_REMOTE': '1', 06:33:31 INFO - 'NO_EM_RESTART': '1', 06:33:31 INFO - 'PAGER': '/bin/cat', 06:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:31 INFO - 'PWD': '/builds/slave/test', 06:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:31 INFO - 'SHELL': '/bin/bash', 06:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:31 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:31 INFO - 'USER': 'cltbld', 06:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:31 INFO - 'XPC_FLAGS': '0x0', 06:33:31 INFO - 'XPC_SERVICE_NAME': '0', 06:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:33:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:33:34 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 06:33:34 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 06:33:34 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 06:33:34 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 06:33:34 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 06:33:34 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 06:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:33:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:33:35 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 06:33:35 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 06:33:35 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 06:33:35 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 06:33:35 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 06:33:35 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 06:33:35 INFO - Downloading docopt-0.6.1.tar.gz 06:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:33:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:33:35 INFO - Running setup.py install for blobuploader 06:33:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:33:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:33:36 INFO - Running setup.py install for requests 06:33:36 INFO - Running setup.py install for docopt 06:33:36 INFO - Successfully installed blobuploader requests docopt 06:33:36 INFO - Cleaning up... 06:33:36 INFO - Return code: 0 06:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:36 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:36 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 06:33:36 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 06:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:36 INFO - 'HOME': '/Users/cltbld', 06:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:36 INFO - 'LOGNAME': 'cltbld', 06:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:36 INFO - 'MOZ_NO_REMOTE': '1', 06:33:36 INFO - 'NO_EM_RESTART': '1', 06:33:36 INFO - 'PAGER': '/bin/cat', 06:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:36 INFO - 'PWD': '/builds/slave/test', 06:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:36 INFO - 'SHELL': '/bin/bash', 06:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:36 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:36 INFO - 'USER': 'cltbld', 06:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:36 INFO - 'XPC_FLAGS': '0x0', 06:33:36 INFO - 'XPC_SERVICE_NAME': '0', 06:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-EXPzbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-yEmz2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-C2Dg7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-QKUxRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tSdahJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZBvSHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gkutDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-J_ZOnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-14nzjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9LxdFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RkM3Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-FNCZP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lnizsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-6obKHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-NIKP4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-76zwDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9WJKIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:38 INFO - Running setup.py install for manifestparser 06:33:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:39 INFO - Running setup.py install for mozcrash 06:33:39 INFO - Running setup.py install for mozdebug 06:33:39 INFO - Running setup.py install for mozdevice 06:33:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:33:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:39 INFO - Running setup.py install for mozfile 06:33:39 INFO - Running setup.py install for mozhttpd 06:33:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:39 INFO - Running setup.py install for mozinfo 06:33:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:39 INFO - Running setup.py install for mozInstall 06:33:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Running setup.py install for mozleak 06:33:40 INFO - Running setup.py install for mozlog 06:33:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Running setup.py install for moznetwork 06:33:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Running setup.py install for mozprocess 06:33:40 INFO - Running setup.py install for mozprofile 06:33:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:40 INFO - Running setup.py install for mozrunner 06:33:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:41 INFO - Running setup.py install for mozscreenshot 06:33:41 INFO - Running setup.py install for moztest 06:33:41 INFO - Running setup.py install for mozversion 06:33:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:41 INFO - Cleaning up... 06:33:41 INFO - Return code: 0 06:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:41 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')]} 06:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:41 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')]} 06:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:41 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:41 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 06:33:41 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 06:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:41 INFO - 'HOME': '/Users/cltbld', 06:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:41 INFO - 'LOGNAME': 'cltbld', 06:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:41 INFO - 'MOZ_NO_REMOTE': '1', 06:33:41 INFO - 'NO_EM_RESTART': '1', 06:33:41 INFO - 'PAGER': '/bin/cat', 06:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:41 INFO - 'PWD': '/builds/slave/test', 06:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:41 INFO - 'SHELL': '/bin/bash', 06:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:41 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:41 INFO - 'USER': 'cltbld', 06:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:41 INFO - 'XPC_FLAGS': '0x0', 06:33:41 INFO - 'XPC_SERVICE_NAME': '0', 06:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rQXrQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:41 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)) 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-WFUbcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:41 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)) 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-V4VE2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gN7VDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CWQQ4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-N2xyUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-PrXkTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ALuyvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-4oRQLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-w0ApNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-z1P5sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:42 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)) 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:42 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-I1IThB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:43 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)) 06:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sJv_vJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:43 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)) 06:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-zjw5gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:43 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)) 06:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Wd2qOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:43 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)) 06:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UrAx0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:43 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)) 06:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-y40Bpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:43 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)) 06:33:43 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)) 06:33:43 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)) 06:33:43 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)) 06:33:43 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)) 06:33:43 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)) 06:33:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33: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 06:33: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 06:33: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 06:33: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 06:33: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 06:33: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 06:33:46 INFO - Downloading blessings-1.6.tar.gz 06:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:46 INFO - Installing collected packages: blessings 06:33:46 INFO - Running setup.py install for blessings 06:33:46 INFO - Successfully installed blessings 06:33:46 INFO - Cleaning up... 06:33:46 INFO - Return code: 0 06:33:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:46 INFO - Reading from file tmpfile_stdout 06:33:46 INFO - Current package versions: 06:33:46 INFO - blessings == 1.6 06:33:46 INFO - blobuploader == 1.2.4 06:33:46 INFO - docopt == 0.6.1 06:33:46 INFO - functools32 == 3.2.3-2 06:33:46 INFO - jsonschema == 2.5.1 06:33:46 INFO - manifestparser == 1.1 06:33:46 INFO - mozInstall == 1.12 06:33:46 INFO - mozcrash == 1.0 06:33:46 INFO - mozdebug == 0.1 06:33:46 INFO - mozdevice == 0.49 06:33:46 INFO - mozfile == 1.2 06:33:46 INFO - mozhttpd == 0.7 06:33:46 INFO - mozinfo == 0.9 06:33:46 INFO - mozleak == 0.1 06:33:46 INFO - mozlog == 3.4 06:33:46 INFO - moznetwork == 0.27 06:33:46 INFO - mozprocess == 0.24 06:33:46 INFO - mozprofile == 0.28 06:33:46 INFO - mozrunner == 6.13 06:33:46 INFO - mozscreenshot == 0.1 06:33:46 INFO - mozsystemmonitor == 0.3 06:33:46 INFO - moztest == 0.8 06:33:46 INFO - mozversion == 1.4 06:33:46 INFO - psutil == 3.1.1 06:33:46 INFO - requests == 1.2.3 06:33:46 INFO - wsgiref == 0.1.2 06:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:47 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 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:47 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 06:33:47 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 06:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:47 INFO - 'HOME': '/Users/cltbld', 06:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:47 INFO - 'LOGNAME': 'cltbld', 06:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:47 INFO - 'MOZ_NO_REMOTE': '1', 06:33:47 INFO - 'NO_EM_RESTART': '1', 06:33:47 INFO - 'PAGER': '/bin/cat', 06:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:47 INFO - 'PWD': '/builds/slave/test', 06:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:47 INFO - 'SHELL': '/bin/bash', 06:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:47 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:47 INFO - 'USER': 'cltbld', 06:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:47 INFO - 'XPC_FLAGS': '0x0', 06:33:47 INFO - 'XPC_SERVICE_NAME': '0', 06:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 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)) 06:33:47 INFO - Cleaning up... 06:33:47 INFO - Return code: 0 06:33:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0e3c6e450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, '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.v6cq0nOfY8/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.2kN8TESSVx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:48 INFO - 'HOME': '/Users/cltbld', 06:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:48 INFO - 'LOGNAME': 'cltbld', 06:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:48 INFO - 'MOZ_NO_REMOTE': '1', 06:33:48 INFO - 'NO_EM_RESTART': '1', 06:33:48 INFO - 'PAGER': '/bin/cat', 06:33:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:48 INFO - 'PWD': '/builds/slave/test', 06:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:48 INFO - 'SHELL': '/bin/bash', 06:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:33:48 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:48 INFO - 'USER': 'cltbld', 06:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:48 INFO - 'XPC_FLAGS': '0x0', 06:33:48 INFO - 'XPC_SERVICE_NAME': '0', 06:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:33:48 INFO - Cleaning up... 06:33:48 INFO - Return code: 0 06:33:48 INFO - Running post-action listener: _resource_record_post_action 06:33:48 INFO - Running post-action listener: _start_resource_monitoring 06:33:48 INFO - Starting resource monitoring. 06:33:48 INFO - [mozharness: 2017-02-27 14:33:48.617973Z] Finished create-virtualenv step (success) 06:33:48 INFO - [mozharness: 2017-02-27 14:33:48.618972Z] Running install step. 06:33:48 INFO - Running pre-action listener: _resource_record_pre_action 06:33:48 INFO - Running main action method: install 06:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:48 INFO - Reading from file tmpfile_stdout 06:33:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:33:48 INFO - Reading from file tmpfile_stdout 06:33:48 INFO - Output received: 06:33:48 INFO - Usage: mozinstall [options] installer 06:33:48 INFO - Options: 06:33:48 INFO - -h, --help show this help message and exit 06:33:48 INFO - -d DEST, --destination=DEST 06:33:48 INFO - Directory to install application into. [default: 06:33:48 INFO - "/builds/slave/test"] 06:33:48 INFO - --app=APP Application being installed. [default: firefox] 06:33:48 INFO - mkdir: /builds/slave/test/build/application 06:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:34:08 INFO - Reading from file tmpfile_stdout 06:34:08 INFO - Output received: 06:34:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:34:08 INFO - Running post-action listener: _resource_record_post_action 06:34:08 INFO - [mozharness: 2017-02-27 14:34:08.902505Z] Finished install step (success) 06:34:08 INFO - [mozharness: 2017-02-27 14:34:08.902665Z] Running run-tests step. 06:34:08 INFO - Running pre-action listener: _resource_record_pre_action 06:34:08 INFO - Running main action method: run_tests 06:34:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:08 INFO - 2017-02-27 06:34:08.917 screenresolution[1630:7309] starting screenresolution argv=screenresolution get 06:34:08 INFO - 2017-02-27 06:34:08.919 screenresolution[1630:7309] Display 0: 1600x1200x32@60 06:34:08 INFO - 2017-02-27 06:34:08.925 screenresolution[1631:7311] starting screenresolution argv=screenresolution list 06:34:08 INFO - Available Modes on Display 0 06:34:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:09 INFO - Intel Iris: 06:34:09 INFO - Chipset Model: Intel Iris 06:34:09 INFO - Type: GPU 06:34:09 INFO - Bus: Built-In 06:34:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:09 INFO - Vendor: Intel (0x8086) 06:34:09 INFO - Device ID: 0x0a2e 06:34:09 INFO - Revision ID: 0x0009 06:34:09 INFO - Displays: 06:34:09 INFO - Display: 06:34:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:09 INFO - Display Serial Number: 1600x1200 60 06:34:09 INFO - Main Display: Yes 06:34:09 INFO - Mirror: Off 06:34:09 INFO - Online: Yes 06:34:09 INFO - Rotation: Supported 06:34:09 INFO - Return code: 0 06:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:34:09 INFO - Python 2.7.3 06:34:09 INFO - Return code: 0 06:34:09 INFO - grabbing minidump binary from tooltool 06:34:09 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')]} 06:34:09 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 0x10cd0ad30>, '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 0x10cc31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccffbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:34:09 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 06:34:09 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 06:34:09 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 06:34:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:34:09 INFO - Return code: 0 06:34:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:34:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:34:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:34:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:34:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6cq0nOfY8/Render', 06:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:09 INFO - 'HOME': '/Users/cltbld', 06:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:09 INFO - 'LOGNAME': 'cltbld', 06:34:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:34:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:09 INFO - 'MOZ_NO_REMOTE': '1', 06:34:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:34:09 INFO - 'NO_EM_RESTART': '1', 06:34:09 INFO - 'PAGER': '/bin/cat', 06:34:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:09 INFO - 'PWD': '/builds/slave/test', 06:34:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:09 INFO - 'SHELL': '/bin/bash', 06:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kN8TESSVx/Listeners', 06:34:09 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:09 INFO - 'USER': 'cltbld', 06:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:09 INFO - 'XPC_FLAGS': '0x0', 06:34:09 INFO - 'XPC_SERVICE_NAME': '0', 06:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:34:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:34:09 INFO - mozversion application_buildid: 20170227052808 06:34:09 INFO - mozversion application_changeset: 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec 06:34:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:34:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:34:09 INFO - mozversion application_name: Firefox 06:34:09 INFO - mozversion application_remotingname: firefox-dev 06:34:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:34:09 INFO - mozversion application_vendor: Mozilla 06:34:09 INFO - mozversion application_version: 53.0a2 06:34:09 INFO - mozversion platform_buildid: 20170227052808 06:34:09 INFO - mozversion platform_changeset: 0934029f7f0c8b1c7fe66b14ce1c8ed15c6892ec 06:34:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:34:09 INFO - mozversion platform_version: 53.0a2 06:34:09 INFO - using testdate: 1488206049 06:34:09 INFO - actual date: 1488206049 06:34:09 INFO - starting webserver on 'localhost:49241' 06:34:09 INFO - SUITE-START | Running 2 tests 06:34:09 INFO - TEST-START | dromaeo_css 06:34:09 INFO - operating with platform_type : mac_ 06:34:09 INFO - Initialising browser for dromaeo_css test... 06:34:09 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp3l1D9a/profile http://localhost:49241/getInfo.html) 06:34:10 INFO - PROCESS | 1641 | 1488206050065 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 06:34:10 INFO - PROCESS | 1641 | 1488206050066 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 06:34:10 INFO - PROCESS | 1641 | 1488206050102 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 06:34:11 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 06:34:11 INFO - PROCESS | 1641 | colorDepth:24 06:34:11 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 06:34:11 INFO - PROCESS | 1641 | __metrics 06:34:12 INFO - PROCESS | 1641 | 1488206052018 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 06:34:12 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:34:12 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:12 INFO - TEST-INFO | 1641: exit 0 06:34:12 INFO - Browser initialized. 06:34:12 INFO - Running cycle 1/1 for dromaeo_css test... 06:34:12 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp3l1D9a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:13 INFO - PROCESS | 1643 | 1488206053123 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 06:34:13 INFO - PROCESS | 1643 | 1488206053123 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 06:34:24 INFO - PROCESS | 1643 | RSS: Main: 213102592 06:34:24 INFO - PROCESS | 1643 | 06:37:28 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:37:29 INFO - PROCESS | 1643 | RSS: Main: 340365312 06:37:29 INFO - PROCESS | 1643 | 06:39:14 INFO - PROCESS | 1643 | ************************* 06:39:14 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 06:39:14 INFO - PROCESS | 1643 | 06:39:14 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:39:14 INFO - PROCESS | 1643 | Full stack: 06:39:14 INFO - PROCESS | 1643 | ************************* 06:40:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:40:33 INFO - PROCESS | 1643 | RSS: Main: 359157760 06:40:33 INFO - PROCESS | 1643 | 06:43:35 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:43:36 INFO - PROCESS | 1643 | RSS: Main: 318787584 06:43:36 INFO - PROCESS | 1643 | 06:46:38 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:46:39 INFO - PROCESS | 1643 | RSS: Main: 342945792 06:46:39 INFO - PROCESS | 1643 | 06:49:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:49:43 INFO - PROCESS | 1643 | RSS: Main: 312549376 06:49:43 INFO - PROCESS | 1643 | 06:52:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:52:47 INFO - PROCESS | 1643 | RSS: Main: 362262528 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | __start_tp_report 06:52:47 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 06:52:47 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 06:52:47 INFO - PROCESS | 1643 | |i|pagename|runs| 06:52:47 INFO - PROCESS | 1643 | |0;dojo.html;2899.623049003629;3025.3193031567885;3392.151962009497;3399.354122716684;3448.1724386147316;5747.396523365044;5755.827325180241;5771.942280577193;5774.2782152230975;5779.017567013607;5754.482096611304;5798.217240672508;5815.15680226368;5840.182374467568;5848.941510584893;5288.127458969266;5306.681599104057;5309.62832601718;5344.385395679507;5356.758945847446;5247.973760131194;5250.3699556053325;5257.369115706101;5274.630775845692;5401.891962160755;5358.490943360394;5375.16684913839;5384.0847056000575;5397.325334333208;5420.512153906147;5383.81156659517;5385.2999110115825;5390.51485366319;5402.702851343174;5414.10667239905;5139.665921715076;5177.534021938006;5237.9476205238225;5305.734713264322;5313.229581710669;5698.715064246812;5717.742701578439;5794.391588883191;5806.042003069489;5877.324107727623;5247.186686063628;6193.256809182882;6292.339304373067;6375.203099612549;6399.456046236076;4909.337239472661;6306.369363063657;6345.777897773602;6358.491320694333;6364.172657554488;5711.000574899376;5809.651420914759;5869.354371019184;5879.235699359141;5890.322612899486;6336.809895703136;6337.302896681362;6340.714667839959;6347.143135676624;6368.713407896656;6231.781887634002;6233.158523599256;6235.875282494325;6241.063840423882;6263.530235232376;6173.753049877954;6173.84565385869;6204.689765511706;6209.285932117864;6214.098955651496;5344.251804747339;6135.048937646369;6219.129321894939;6221.377862213742;6222.595531290452;6154.907676384858;6194.039923811816;6207.906881396782;6215.689215539295;6221.09794079865;4981.003799240167;4988.625853061035;5008.198688209869;5034.647574669812;5069.670471419419;4549.408576884984;4561.863144105682;4563.566461186182;4598.97700511502;4607.884802879955;5831.212786273799;5973.01445261527;5975.79084732041;5975.880482390415;5979.133025711334;5410.431904650034;5926.525877929756;6180.258368995749;6242.188515493048;6273.686315684197;5887.116932460165;5891.23413956183;5904.7342869570975;5909.8227053188475;5944.7324870380935;5540.612157149041;5543.2793736814765;5550.167474878801;5557.5553955683445;5561.888762224733;4969.6769709970185;6287.968560157353;6299.275583307978;6370.904436433457;6386.7764628236855;6306.779262725782;6325.620462772248;6328.208973878265;6351.491880649629;6378.298387177314;6351.174347334817;6379.425851673372;6400.871982560416;6430.871382572416;6491.610503369624;6125.540584456095;6152.78465253714;6206.968965155145;6273.592216505913;6316.842078948063;5642.322921249476;6232.844178895564;6323.20959880015;6326.2092238470195;6391.744330226739;6172.537059720449;6186.876262474815;6194.907076393948;6199.380061993765;6200.441960223601;6044.576879618385;6154.353792851686;6175.84560385994;6205.81382558524;6215.627062376091;4996.825111121093;5921.585489015728;6023.819285421444;6045.758169673164;6089.238845144357;6196.7018199438835;6238.376162383907;6242.282137554058;6246.219222597176;6260.812175634738;6035.124906888389;6054.90917636227;6060.090986351906;6062.120992456157;6096.993995990611 06:52:47 INFO - PROCESS | 1643 | |1;ext.html;456.0468620582983;461.9491855895853;476.60679939050294;503.9319691841601;505.59047171790854;30553.38893222137;37933.62066379336;39848.40227396584;39993.60006399935;40031.999200020015;40139.79580612579;43002.7849860751;43022;43026;43109.568904311025;8335.95832020839;9117.726468205949;9344.159025687686;9357.95321023394;9415.670451534197;8352.665893364288;9166.54167291636;11269.830952535718;11295.152863535226;11457.5416983321;11316.038136758385;11381.772364552704;11384.260023098514;11413.828792568118;11438;11192.66422007337;11279.830802537886;11282.999999999958;11294;11316.660500185008;8352.83294334116;8529.53087580183;8534.658613655447;8642.092580279043;8651.610677519528;39132.41301380481;39642.80178599117;39683;41658.1668366631;41754.582454175375;3821.5987321331418;3931.9410208846602;3957.28768821612;3963.3460479021214;4015.2371049500794;30021.39957200844;30048.248793780112;31097.689023109706;31131.844340778378;31386.21534461634;2833.2775142338573;3143.0256620447735;3167.3823604397153;3238.2228265216413;3251;506481;507075;508566;509535;510391;65998.34001659922;66597;66692.33307666861;66726;66741.6662916692;69325.49384290005;69335;69434.65282673555;69482.30517694859;69488.6525567369;16168.838311616733;16364.427245046367;16784.412545561092;16805;16897.15514224284;11645.184837061324;12954.67613309656;13053;13066.54267100647;13077.280749558675;15995.360185592446;16533.6693266134;18348.990805505557;18675.252989880526;18799.15403806832;6863.691133898987;6956.339147780953;6991.510594258353;6993.685284162225;7007.194172670106;865.4201684871151;866.7789713622985;884.6682494064726;898.6315610599622;918.7106061590712;21644.891775541022;28610.427791444472;28641.997530086763;30320.483975801122;30614.081577552708;1071.2608300272943;1073.4149888310733;1098.2861140258897;1110.1230028277732;1211.4487908001838;15259.389624415122;15663.138527380876;15742.527724168292;16093.597660058358;16137.515874523782;624377;625186;628594;629947;630380;61415.165559271794;61528.38471615316;61561;61654.69172654108;62014.0697889532;1415.83010038796;1458.693674328403;1472.256510462231;1475.0928179169734;1475.5794598539364;27718.307042323297;29120.854395727885;29394.55908161422;30181.245468862577;30334.69665303407;43730;52761;53501.4649853512;53506.46493535015;53561;522386;537779;553879;556398;556403;40341.1931761369;40816.591834082465;41824.16351673011;41908.371374428796;41912.74261772152;46264.30603541017;47252.29121563111;47419.81450463766;47831;47918.76040619914;28822.42355152927;33174;38405.23189536249;38432.615673842905;40482.987925302106;28134.71865281321;38558;39812.80093599513;40046.799766000986;40312.39531406973;37083.44374834433;37387;38081.619183808914;38107.047323817125;38377;32195;33033.66966330306;33833.66166338305;33909.321813564085;34035.65964340325;23144.3056708299;24405.38986525351;24776.504469910862;24840.079984878423;25108.24675259745 06:52:47 INFO - PROCESS | 1643 | |2;jquery.html;369.30386221971577;388.8988862895647;391.06730447881796;400.1576681086313;425.25155725922366;14311.855051595874;15613.453529126482;18901.71647425288;20524.38426847197;21130.366089017352;20606.278780242694;20954.476138096554;21165.365039048815;21543.13827446904;21621.3513594592;4525.230710779159;4564.315352697089;5546.306711661043;5757.222774925394;5843.883122337551;5077.441481437039;5626.578006649518;5655.462731040545;5730.541556675476;5772.855678608026;4143.834246630131;4382.452193475816;4424.756638384888;5696.743646535895;6550.443212326934;5657.2928383952;6583.177102862142;6583.374579414948;6601.042848786947;6601.2408573014;5513.61404701671;5514.95215908976;5573.052581061189;5575.804846830341;5638.971805140989;22697.546049078926;23139.84300784954;26066.218013459627;26140.738592614212;26449.47101057968;2679.089109702691;2692.9192124236306;2729.9454010919867;2734.934011766582;2769.1830909881633;15444.227788610637;15501.992370495882;15518.612034699223;15654.608634784221;16008.919955400264;1756.6135450200936;1798.2896755781394;1811.4837271377726;1816;1840.8067152948881;103440;120552;127313.72686273111;128042.3597882014;131045;9455.76360590977;11519.193656444137;11671.649850504498;11677.357745324089;11873.762524749456;14699;14734.263286835616;14741.705165896621;14752.63118422048;14764.114153150846;8342.582870856433;8752;8759.693410730593;8788.91211087881;8807;8686.86969695455;8695.478271303615;8700.30397568193;8835.514046727363;8881.33389995753;5915.438033386821;7134.430425306425;7138.750143744944;7145.6784444700115;7150.96424517874;1865.869389142747;1914.387396033256;1946.1339703831943;1961.254723205173;1963.4404194804413;861.8319427711662;890.7684002159485;891.9163216691751;894.932880034;930.9441433514011;16582.17089145538;21247.893760531097;22126.557468850853;22129.225477108546;22138.225162119572;911.8905731312152;936.166811537732;936.7096200177966;940.7601061729215;960.3853533738413;11028.613998510174;11455.599054033235;11522.942385288019;11570.42147892602;11650.825237621442;432254;555585;655448;774430;787282;117145.41427292979;127676.36161819317;130378;131228;131503;972.6984634763246;1004.9849252261222;1029.2897900448665;1040.484959944832;1046.2885238038054;19647.803521964597;19783.40649780509;20534;20563.58872822505;20580.588388232452;61642;62068;62125.68937155466;63511.36488635239;64313;90678;93137.534312328;93165;94373;94376.52811736173;8172.959135204286;8187.631556580087;8466.830663386574;8501.362397820065;8503.404761666625;8654.264387527131;8785.780355491164;8991.505467199368;9042.457452552868;9175.357724959189;7621.771346859603;8132.227438393344;8249.546274954935;8272.17278272192;8430.15698430152;7062.576245425291;7808.219178082373;7886.605669716606;8253.546054967035;8377;7563.659635316314;8416.242538171595;8456.619452124545;8458.450200736932;8489.575521224038;12429.50845898498;12862.485500579873;12928.7324432113;13373.598792036255;13539.59381218565;11674.299542027506;11706.648800535997;12130.514779408724;12226.877731222574;12246.510139594317 06:52:47 INFO - PROCESS | 1643 | |3;mootools.html;1432.333964706412;1445.2990299704643;1451.7314296855077;1452.8474510176438;1456.6940942402096;7815.960920195405;8463.619137138829;8481.151884811523;8484.91515084849;8491.872621910661;7372.004779354799;7622.618869056552;7623.390128789697;7636.503627264224;7642.273983971514;2101.7898210178973;2139.0267428320076;2231.3306008197474;2304.078368652544;2308.1805958884606;2351.071326825903;2357.9410514737096;2358.6933698619155;2359.528094381131;2363.4682196505732;2268.625676763332;2302.5855346037706;2304.2050492580033;2306.411864974438;2310.919117830876;2258.830587705929;2264.275431861813;2290.576243394977;2291.0835665733675;2291.8281128915396;2015.647261729206;2200.4938864061196;2241.8318626102946;2310.688057112285;2311.0986715181093;8371.16288371164;8400.579971001487;8402.78993025173;8403.915960840435;8421.199986001382;5076.213186956028;5224.242484839715;5226.764795584208;5231.973840130813;5252.422233554306;3256.4301247281633;3453.5165076889257;3521.0845180253064;3527.682508574215;3533.522974398449;1185.7535623342008;1189.3874654552912;1249.1256120715536;1253.6552448076761;1268.6130730127306;10754.892451075468;10873.075788557982;10893.965073318022;10900.182486313479;10918.836217456745;4509.098180363941;4674.158651442773;4687.6249900007915;4780.426348838162;4795.352627395327;8846.380753347332;8924.8661270081;8925.285977121815;8943.955280223558;8956.462612243156;4469.9776501117285;5097.668651537638;5191.97404012985;5205.141151710001;5212.895742085213;4598.149342371672;4787.8563643090765;4863.10032643962;4867.0995865764235;4889.731064791471;3480.773749706261;3589.8384572693767;3594.8382322795537;3606.9819650901577;3609.3322735294055;962.5091203486132;1086.9619563315246;1147.862256529222;1169.7543515861594;1177.2289150606366;863.684755064397;880.6859035708376;884.2130503851578;894.1058941058941;923.0492592629603;4944.653874228769;5456.863578410492;5511.889762204733;5674.319081710221;5725.541956643458;973.8587904753913;982.7346616413671;995.323180237431;1004.7940172264668;1025.620520407454;3620.6198349173483;3671.834767435472;3735.589085200626;3787.981060094682;3836.846526138979;9886.752831179134;10126.848097278547;10209.846852297222;10221;10228.53971571281;9998.400095994119;10161.288709790391;10183.490825458697;10328.380297182193;10404.895951040393;6769.593824370553;7763.883541746765;7873.448858579959;7966.800829979297;8003.19968003195;5704.486596206361;5828.504577110993;5881.617694849821;5950.077737950624;5951.940480595312;8858.29133669292;8949.507777072324;9225.815483690154;9421.644588852787;9467.053294670477;8487.957560212159;9222.538873056454;9332.813343733224;9466.715998520056;9470.384425012353;7150.499465037397;7193.0289410930945;7334.779956601311;7335.559866408033;7347.26527347261;7863.646135924012;7871.48835325702;7960.681572737258;7967.641456134604;7991.680332786624;7025.894611580932;7053.964730176522;7076;7191.964040179766;7269.563826170447;7078.115235595551;7099.2190859006505;7135.928640713526;7154.749583764543;7221.133463984355;6389.233292004989;6431.099646049463;6460.160179176677;6509.1863517060365;6531.444827189552;4957.405111386656;4958.876028099182;4995.775190116527;5046.495350464924;5063;4962.578180854668;4974.676646017997;5000.199968005102;5062.493750624908;5220.451852555427 06:52:47 INFO - PROCESS | 1643 | |4;prototype.html;330.7387164140329;346.4871989455606;351.60238053736396;354.9680528752412;357.17492592112205;4644.164050470914;5054.545090941814;5230.293910322105;5234.267202591631;5295.285136506575;5009.974950125254;5180.844574662757;5235.947640523594;5241.42344342122;5241.889158070879;3222.3555288942307;3505.526753888231;3906.433567132764;4047.8785636430953;4097.713160078795;3101.4727496325677;3232.65844674461;3951.4467974483596;3963.483188175515;4029.3955906614096;3399.847006884696;3906.8084234308526;3968.305546529346;3974;4004.599540046001;3978.9801050994847;3981.2634662587516;3991.7804520751347;3995.180987897474;4012.558618551957;3178.396104740115;3239.8616912837415;3465.081753335368;3477.4088404971217;3477.6522347765276;3991.9201615967518;5088.4148322942965;5175.842735931079;5209.791608335662;5210.931758989398;3843.8846834595006;4791.5687588117235;4795.848996240912;4799.856004319876;4840.927386089212;5591.944080559183;5629.662220266797;5634.6337488063145;5649.406812284733;5666.3766985631955;3644.5444319460066;3914.9608503914883;3947.723659343847;3955.802209889494;3995.9410756149646;4999.825006124768;5520.757829488333;5653.9151912721345;5707.800226992035;5841.824745257649;4107.507099148122;4176.895577610523;4194.643455306272;4215.524566401735;4216.599423054805;3938.1926705025403;4239.47006624172;4246.893827654333;4267.061246525759;4279.930017495626;4441.933370999438;4513.909721805546;4782.928256076161;4819.5782244238035;4855.465898751135;4733;5379.390995367244;5618.213450116987;5655.745491452894;5674.978503869261;1303.6349822049842;1346.8585798491017;1352.3373546962114;1390.2770559309104;1426.4436869620856;890.1365675294953;896.9416089015025;909.3676850054169;938.7700013496737;982.268210183418;4529.818807247739;4821.373221481185;4934.358533390637;4942.640773787237;4943.65394422387;4473.753943533072;4803.255495398219;4866.878328041827;5058.342415486037;5314.92027619586;4150.302303502747;4358.259095953696;4486.68593198473;4846.801111266547;5012.373453318335;2527.54504189244;2792.4554711830997;2805.9859700701772;2889.537673972154;2892.6673432555526;5171.896562068738;5452.372977107683;5502.98194833957;5669.206311116447;5709.914351284734;5123.2827404163445;5206.5376524611465;5543.223948647193;5623.919149914558;5670.206171136044;5128.025675121715;5641.643222282735;5643.463870932255;5648.74580643872;5671.602987790898;4779.617630589475;5217.3217881394285;5321;5468.781248750005;5543.8891222176135;5335;5408.78364865401;5702.144678298123;5757.769689212385;5769.394213607511;4762.857114286577;4931.9753401232765;5621.80323688669;5774.892164360062;5876.853078673067;3513.9297214055064;3549.840257188381;3859.575446700917;3860.749051311656;3886.611338866204;4305.590968857953;5072.923906141337;5685.943140568541;5771.509421699203;5781.640195784603;4825.734584597881;5041.630433696157;5525.198846167203;5531.612787104864;5534.308211473566;4711.646626502958;4883.926741098958;5490.419502833662;5513.641613295123;5514.367930938031;5079.339685840817;5212.296339994053;5442.129259318648;5499.340079190522;5510.972445137909;4144.564820693904;5078.847634570969;5521.923224971092;5525.834224973257;5538.040301184672;4594.287885377772;4841.225403935354;5201.609879258995;5243.449437808975;5431.447219806684 06:52:47 INFO - PROCESS | 1643 | |5;yui.html;691.9723211071557;725.8512005038967;751.1511991449661;803.6142651527267;803.8874557561942;14824.703505929874;14961;15796.447124350636;15809.762853557206;15910.363585456567;13835.723285534283;14409.855901440982;14551;14581.34383952722;14622.195779232137;837.9999999999985;868.9044205137429;869.1525762381691;869.4783130121908;871.1941454154913;687.8933765266391;858.4677499950039;863.1541089732067;864.5590748718167;864.7059999600135;730.8757511223105;742.0946445336681;878;912.7216199059284;914.6295750221171;868.3617541107282;883.1477624092781;884.4958373726978;903.9819203615924;905.5019739143445;673.2896793882452;674.642439507062;675.4630069095081;675.787127054976;675.8073948924582;11080.61217857371;11887.762244755142;12172.878271217352;12326.07554433412;14999.100053996686;12469.251844889335;14644.70710585793;14727.779083313759;14775.187364694937;14903.70192596142;11532.192746507748;11618.651440456715;11642.94178529102;11649.534018639244;11739.47172377245;3660.963390366089;3709.914168428909;3766.2655782122497;3904.511936007999;3907.0623050467684;100170.46474071422;104953;106291.46854265679;106877.465612673;109983.90016099896;10556.47217639115;11109.611163609397;11199.552017919355;11419.20065595417;11491.310521368745;23495.88252058763;23500.882495587754;23608.64587031196;23872;24082.759172408052;7813.531188128731;7817.687292508236;7851.646675899598;7892.960535197287;7979.72070977513;4211.115665710174;4235.486671789725;4309.1381723655395;4329.783510824446;4337.9783101084295;3530.593981692087;3620.5474315710535;3639.1629925117372;3652.543432070991;3662.011256960606;642.7557528139371;648.7673420501086;653.3205466315075;667.813012356541;667.9599224046573;653.5261935097017;658.6527288101144;664.5514277862424;683.733343995842;728.3590440412403;9737.853932191023;10096.848547271797;10171.186305095574;10216.540255688511;10232.948835255926;651.7458191305394;675.2167485716545;699.174973531238;705.7882635209417;708.1113202930393;4684.484706682262;4903.117438861039;4916.434610019822;4934.481879402611;4941.209406494943;75970;108732;108736;108964.36553451704;110644.34033489504;69895.65052174707;72124;74461.6276918612;75908.62045689847;83122.58438707767;72891.54216915739;74834.62582687051;75546;76046;76729.61635191788;10507.89492105069;10796.514156863117;10800.627629698516;10926;11036.834447483134;47796.76101619609;48043.75978120087;49143;50375.49624503708;50482.74758626183;60921.39078609157;61774;62294.75410491855;63544.72910541671;64967;12377.133600648229;12578.685532861751;12603.558875439316;12706.110572259853;12812;13883.514077007256;14121.2939353034;14280.285985700466;15001.024933379296;15010.849891500946;10945.60968704848;13204.471821127046;13305.933470332586;13508.86491135076;13621.455141794217;12689.047947051467;12880;12909.289989050316;13292.667683307995;13308.93345533266;12311.75376492483;13161.210327380388;13168.539101131415;13354;13669.931650341685;10372.27394082407;10742.785144296913;10966.835497467384;11040.847034828132;11378.487968041292;9091.772705682411;9375.561276417475;10025;10562.419066951392;10611.151107911193 06:52:47 INFO - PROCESS | 1643 | __end_tp_report 06:52:47 INFO - PROCESS | 1643 | __start_cc_report 06:52:47 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1447 06:52:47 INFO - PROCESS | 1643 | __end_cc_report 06:52:47 INFO - PROCESS | 1643 | __startTimestamp1488207167027__endTimestamp 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | ------- Summary: start ------- 06:52:47 INFO - PROCESS | 1643 | Number of tests: 6 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5784.62 Median:5975.88 stddev:652.51 (10.9%) stddev-sans-first:614.01 06:52:47 INFO - PROCESS | 1643 | Values: 2899.6 3025.3 3392.2 3399.4 3448.2 5747.4 5755.8 5771.9 5774.3 5779.0 5754.5 5798.2 5815.2 5840.2 5848.9 5288.1 5306.7 5309.6 5344.4 5356.8 5248.0 5250.4 5257.4 5274.6 5401.9 5358.5 5375.2 5384.1 5397.3 5420.5 5383.8 5385.3 5390.5 5402.7 5414.1 5139.7 5177.5 5237.9 5305.7 5313.2 5698.7 5717.7 5794.4 5806.0 5877.3 5247.2 6193.3 6292.3 6375.2 6399.5 4909.3 6306.4 6345.8 6358.5 6364.2 5711.0 5809.7 5869.4 5879.2 5890.3 6336.8 6337.3 6340.7 6347.1 6368.7 6231.8 6233.2 6235.9 6241.1 6263.5 6173.8 6173.8 6204.7 6209.3 6214.1 5344.3 6135.0 6219.1 6221.4 6222.6 6154.9 6194.0 6207.9 6215.7 6221.1 4981.0 4988.6 5008.2 5034.6 5069.7 4549.4 4561.9 4563.6 4599.0 4607.9 5831.2 5973.0 5975.8 5975.9 5979.1 5410.4 5926.5 6180.3 6242.2 6273.7 5887.1 5891.2 5904.7 5909.8 5944.7 5540.6 5543.3 5550.2 5557.6 5561.9 4969.7 6288.0 6299.3 6370.9 6386.8 6306.8 6325.6 6328.2 6351.5 6378.3 6351.2 6379.4 6400.9 6430.9 6491.6 6125.5 6152.8 6207.0 6273.6 6316.8 5642.3 6232.8 6323.2 6326.2 6391.7 6172.5 6186.9 6194.9 6199.4 6200.4 6044.6 6154.4 6175.8 6205.8 6215.6 4996.8 5921.6 6023.8 6045.8 6089.2 6196.7 6238.4 6242.3 6246.2 6260.8 6035.1 6054.9 6060.1 6062.1 6097.0 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:70223.58 Median:21803.07 stddev:150154.80 (688.7%) stddev-sans-first:150484.65 06:52:47 INFO - PROCESS | 1643 | Values: 456.0 461.9 476.6 503.9 505.6 30553.4 37933.6 39848.4 39993.6 40032.0 40139.8 43002.8 43022.0 43026.0 43109.6 8336.0 9117.7 9344.2 9358.0 9415.7 8352.7 9166.5 11269.8 11295.2 11457.5 11316.0 11381.8 11384.3 11413.8 11438.0 11192.7 11279.8 11283.0 11294.0 11316.7 8352.8 8529.5 8534.7 8642.1 8651.6 39132.4 39642.8 39683.0 41658.2 41754.6 3821.6 3931.9 3957.3 3963.3 4015.2 30021.4 30048.2 31097.7 31131.8 31386.2 2833.3 3143.0 3167.4 3238.2 3251.0 506481.0 507075.0 508566.0 509535.0 510391.0 65998.3 66597.0 66692.3 66726.0 66741.7 69325.5 69335.0 69434.7 69482.3 69488.7 16168.8 16364.4 16784.4 16805.0 16897.2 11645.2 12954.7 13053.0 13066.5 13077.3 15995.4 16533.7 18349.0 18675.3 18799.2 6863.7 6956.3 6991.5 6993.7 7007.2 865.4 866.8 884.7 898.6 918.7 21644.9 28610.4 28642.0 30320.5 30614.1 1071.3 1073.4 1098.3 1110.1 1211.4 15259.4 15663.1 15742.5 16093.6 16137.5 624377.0 625186.0 628594.0 629947.0 630380.0 61415.2 61528.4 61561.0 61654.7 62014.1 1415.8 1458.7 1472.3 1475.1 1475.6 27718.3 29120.9 29394.6 30181.2 30334.7 43730.0 52761.0 53501.5 53506.5 53561.0 522386.0 537779.0 553879.0 556398.0 556403.0 40341.2 40816.6 41824.2 41908.4 41912.7 46264.3 47252.3 47419.8 47831.0 47918.8 28822.4 33174.0 38405.2 38432.6 40483.0 28134.7 38558.0 39812.8 40046.8 40312.4 37083.4 37387.0 38081.6 38107.0 38377.0 32195.0 33033.7 33833.7 33909.3 34035.7 23144.3 24405.4 24776.5 24840.1 25108.2 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:37036.77 Median:4403.60 stddev:109274.90 (2481.5%) stddev-sans-first:109546.76 06:52:47 INFO - PROCESS | 1643 | Values: 369.3 388.9 391.1 400.2 425.3 14311.9 15613.5 18901.7 20524.4 21130.4 20606.3 20954.5 21165.4 21543.1 21621.4 4525.2 4564.3 5546.3 5757.2 5843.9 5077.4 5626.6 5655.5 5730.5 5772.9 4143.8 4382.5 4424.8 5696.7 6550.4 5657.3 6583.2 6583.4 6601.0 6601.2 5513.6 5515.0 5573.1 5575.8 5639.0 22697.5 23139.8 26066.2 26140.7 26449.5 2679.1 2692.9 2729.9 2734.9 2769.2 15444.2 15502.0 15518.6 15654.6 16008.9 1756.6 1798.3 1811.5 1816.0 1840.8 103440.0 120552.0 127313.7 128042.4 131045.0 9455.8 11519.2 11671.6 11677.4 11873.8 14699.0 14734.3 14741.7 14752.6 14764.1 8342.6 8752.0 8759.7 8788.9 8807.0 8686.9 8695.5 8700.3 8835.5 8881.3 5915.4 7134.4 7138.8 7145.7 7151.0 1865.9 1914.4 1946.1 1961.3 1963.4 861.8 890.8 891.9 894.9 930.9 16582.2 21247.9 22126.6 22129.2 22138.2 911.9 936.2 936.7 940.8 960.4 11028.6 11455.6 11522.9 11570.4 11650.8 432254.0 555585.0 655448.0 774430.0 787282.0 117145.4 127676.4 130378.0 131228.0 131503.0 972.7 1005.0 1029.3 1040.5 1046.3 19647.8 19783.4 20534.0 20563.6 20580.6 61642.0 62068.0 62125.7 63511.4 64313.0 90678.0 93137.5 93165.0 94373.0 94376.5 8173.0 8187.6 8466.8 8501.4 8503.4 8654.3 8785.8 8991.5 9042.5 9175.4 7621.8 8132.2 8249.5 8272.2 8430.2 7062.6 7808.2 7886.6 8253.5 8377.0 7563.7 8416.2 8456.6 8458.5 8489.6 12429.5 12862.5 12928.7 13373.6 13539.6 11674.3 11706.6 12130.5 12226.9 12246.5 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5426.60 Median:5086.94 stddev:2959.30 (58.2%) stddev-sans-first:2952.38 06:52:47 INFO - PROCESS | 1643 | Values: 1432.3 1445.3 1451.7 1452.8 1456.7 7816.0 8463.6 8481.2 8484.9 8491.9 7372.0 7622.6 7623.4 7636.5 7642.3 2101.8 2139.0 2231.3 2304.1 2308.2 2351.1 2357.9 2358.7 2359.5 2363.5 2268.6 2302.6 2304.2 2306.4 2310.9 2258.8 2264.3 2290.6 2291.1 2291.8 2015.6 2200.5 2241.8 2310.7 2311.1 8371.2 8400.6 8402.8 8403.9 8421.2 5076.2 5224.2 5226.8 5232.0 5252.4 3256.4 3453.5 3521.1 3527.7 3533.5 1185.8 1189.4 1249.1 1253.7 1268.6 10754.9 10873.1 10894.0 10900.2 10918.8 4509.1 4674.2 4687.6 4780.4 4795.4 8846.4 8924.9 8925.3 8944.0 8956.5 4470.0 5097.7 5192.0 5205.1 5212.9 4598.1 4787.9 4863.1 4867.1 4889.7 3480.8 3589.8 3594.8 3607.0 3609.3 962.5 1087.0 1147.9 1169.8 1177.2 863.7 880.7 884.2 894.1 923.0 4944.7 5456.9 5511.9 5674.3 5725.5 973.9 982.7 995.3 1004.8 1025.6 3620.6 3671.8 3735.6 3788.0 3836.8 9886.8 10126.8 10209.8 10221.0 10228.5 9998.4 10161.3 10183.5 10328.4 10404.9 6769.6 7763.9 7873.4 7966.8 8003.2 5704.5 5828.5 5881.6 5950.1 5951.9 8858.3 8949.5 9225.8 9421.6 9467.1 8488.0 9222.5 9332.8 9466.7 9470.4 7150.5 7193.0 7334.8 7335.6 7347.3 7863.6 7871.5 7960.7 7967.6 7991.7 7025.9 7054.0 7076.0 7192.0 7269.6 7078.1 7099.2 7135.9 7154.7 7221.1 6389.2 6431.1 6460.2 6509.2 6531.4 4957.4 4958.9 4995.8 5046.5 5063.0 4962.6 4974.7 5000.2 5062.5 5220.5 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4433.20 Median:4907.95 stddev:1328.03 (27.1%) stddev-sans-first:1295.57 06:52:47 INFO - PROCESS | 1643 | Values: 330.7 346.5 351.6 355.0 357.2 4644.2 5054.5 5230.3 5234.3 5295.3 5010.0 5180.8 5235.9 5241.4 5241.9 3222.4 3505.5 3906.4 4047.9 4097.7 3101.5 3232.7 3951.4 3963.5 4029.4 3399.8 3906.8 3968.3 3974.0 4004.6 3979.0 3981.3 3991.8 3995.2 4012.6 3178.4 3239.9 3465.1 3477.4 3477.7 3991.9 5088.4 5175.8 5209.8 5210.9 3843.9 4791.6 4795.8 4799.9 4840.9 5591.9 5629.7 5634.6 5649.4 5666.4 3644.5 3915.0 3947.7 3955.8 3995.9 4999.8 5520.8 5653.9 5707.8 5841.8 4107.5 4176.9 4194.6 4215.5 4216.6 3938.2 4239.5 4246.9 4267.1 4279.9 4441.9 4513.9 4782.9 4819.6 4855.5 4733.0 5379.4 5618.2 5655.7 5675.0 1303.6 1346.9 1352.3 1390.3 1426.4 890.1 896.9 909.4 938.8 982.3 4529.8 4821.4 4934.4 4942.6 4943.7 4473.8 4803.3 4866.9 5058.3 5314.9 4150.3 4358.3 4486.7 4846.8 5012.4 2527.5 2792.5 2806.0 2889.5 2892.7 5171.9 5452.4 5503.0 5669.2 5709.9 5123.3 5206.5 5543.2 5623.9 5670.2 5128.0 5641.6 5643.5 5648.7 5671.6 4779.6 5217.3 5321.0 5468.8 5543.9 5335.0 5408.8 5702.1 5757.8 5769.4 4762.9 4932.0 5621.8 5774.9 5876.9 3513.9 3549.8 3859.6 3860.7 3886.6 4305.6 5072.9 5685.9 5771.5 5781.6 4825.7 5041.6 5525.2 5531.6 5534.3 4711.6 4883.9 5490.4 5513.6 5514.4 5079.3 5212.3 5442.1 5499.3 5511.0 4144.6 5078.8 5521.9 5525.8 5538.0 4594.3 4841.2 5201.6 5243.4 5431.4 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:19799.91 Median:3661.49 stddev:28225.94 (770.9%) stddev-sans-first:28268.66 06:52:47 INFO - PROCESS | 1643 | Values: 692.0 725.9 751.2 803.6 803.9 14824.7 14961.0 15796.4 15809.8 15910.4 13835.7 14409.9 14551.0 14581.3 14622.2 838.0 868.9 869.2 869.5 871.2 687.9 858.5 863.2 864.6 864.7 730.9 742.1 878.0 912.7 914.6 868.4 883.1 884.5 904.0 905.5 673.3 674.6 675.5 675.8 675.8 11080.6 11887.8 12172.9 12326.1 14999.1 12469.3 14644.7 14727.8 14775.2 14903.7 11532.2 11618.7 11642.9 11649.5 11739.5 3661.0 3709.9 3766.3 3904.5 3907.1 100170.5 104953.0 106291.5 106877.5 109983.9 10556.5 11109.6 11199.6 11419.2 11491.3 23495.9 23500.9 23608.6 23872.0 24082.8 7813.5 7817.7 7851.6 7893.0 7979.7 4211.1 4235.5 4309.1 4329.8 4338.0 3530.6 3620.5 3639.2 3652.5 3662.0 642.8 648.8 653.3 667.8 668.0 653.5 658.7 664.6 683.7 728.4 9737.9 10096.8 10171.2 10216.5 10232.9 651.7 675.2 699.2 705.8 708.1 4684.5 4903.1 4916.4 4934.5 4941.2 75970.0 108732.0 108736.0 108964.4 110644.3 69895.7 72124.0 74461.6 75908.6 83122.6 72891.5 74834.6 75546.0 76046.0 76729.6 10507.9 10796.5 10800.6 10926.0 11036.8 47796.8 48043.8 49143.0 50375.5 50482.7 60921.4 61774.0 62294.8 63544.7 64967.0 12377.1 12578.7 12603.6 12706.1 12812.0 13883.5 14121.3 14280.3 15001.0 15010.8 10945.6 13204.5 13305.9 13508.9 13621.5 12689.0 12880.0 12909.3 13292.7 13308.9 12311.8 13161.2 13168.5 13354.0 13669.9 10372.3 10742.8 10966.8 11040.8 11378.5 9091.8 9375.6 10025.0 10562.4 10611.2 06:52:47 INFO - PROCESS | 1643 | -------- Summary: end -------- 06:52:47 INFO - PROCESS | 1643 | 06:52:47 INFO - PROCESS | 1643 | 1488207167050 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 06:52:47 INFO - TEST-INFO | 1643: exit 0 06:52:47 INFO - TEST-OK | dromaeo_css | took 1118153ms 06:52:47 INFO - TEST-START | kraken 06:52:47 INFO - operating with platform_type : mac_ 06:52:47 INFO - Initialising browser for kraken test... 06:52:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpwH3kPd/profile http://localhost:49241/getInfo.html) 06:52:48 INFO - PROCESS | 1652 | 1488207168233 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 06:52:48 INFO - PROCESS | 1652 | 1488207168234 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 06:52:48 INFO - PROCESS | 1652 | 1488207168269 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 06:52:49 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 06:52:49 INFO - PROCESS | 1652 | colorDepth:24 06:52:49 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 06:52:49 INFO - PROCESS | 1652 | __metrics 06:52:50 INFO - PROCESS | 1652 | 1488207170016 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 06:52:50 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:52:50 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:50 INFO - TEST-INFO | 1652: exit 0 06:52:50 INFO - Browser initialized. 06:52:50 INFO - Running cycle 1/1 for kraken test... 06:52:50 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpwH3kPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:51 INFO - PROCESS | 1653 | 1488207171123 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 06:52:51 INFO - PROCESS | 1653 | 1488207171124 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 06:53:03 INFO - PROCESS | 1653 | RSS: Main: 213295104 06:53:03 INFO - PROCESS | 1653 | 06:53:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:53:06 INFO - PROCESS | 1653 | RSS: Main: 265883648 06:53:06 INFO - PROCESS | 1653 | 06:53:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:53:09 INFO - PROCESS | 1653 | RSS: Main: 276504576 06:53:09 INFO - PROCESS | 1653 | 06:53:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:53:13 INFO - PROCESS | 1653 | RSS: Main: 371576832 06:53:13 INFO - PROCESS | 1653 | 06:53:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:53:16 INFO - PROCESS | 1653 | RSS: Main: 274878464 06:53:16 INFO - PROCESS | 1653 | 06:53:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:53:18 INFO - PROCESS | 1653 | RSS: Main: 277553152 06:53:18 INFO - PROCESS | 1653 | 06:53:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:53:22 INFO - PROCESS | 1653 | RSS: Main: 316825600 06:53:22 INFO - PROCESS | 1653 | 06:53:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:53:26 INFO - PROCESS | 1653 | RSS: Main: 318500864 06:53:26 INFO - PROCESS | 1653 | 06:53:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:53:29 INFO - PROCESS | 1653 | RSS: Main: 315494400 06:53:29 INFO - PROCESS | 1653 | 06:53:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:53:31 INFO - PROCESS | 1653 | RSS: Main: 295059456 06:53:31 INFO - PROCESS | 1653 | 06:53:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:53:34 INFO - PROCESS | 1653 | RSS: Main: 297967616 06:53:34 INFO - PROCESS | 1653 | 06:53:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:53:37 INFO - PROCESS | 1653 | RSS: Main: 299741184 06:53:37 INFO - PROCESS | 1653 | 06:53:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:53:40 INFO - PROCESS | 1653 | RSS: Main: 316874752 06:53:40 INFO - PROCESS | 1653 | 06:53:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:53:44 INFO - PROCESS | 1653 | RSS: Main: 311033856 06:53:44 INFO - PROCESS | 1653 | 06:53:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:53:46 INFO - PROCESS | 1653 | RSS: Main: 355667968 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | __start_tp_report 06:53:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 06:53:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 06:53:46 INFO - PROCESS | 1653 | |i|pagename|runs| 06:53:46 INFO - PROCESS | 1653 | |0;ai-astar;115;116;115;113;113;116;115;114;113;115 06:53:46 INFO - PROCESS | 1653 | |1;audio-beat-detection;150;126;135;178;145;111;110;108;130;111 06:53:46 INFO - PROCESS | 1653 | |2;audio-dft;186;184;185;184;184;185;184;184;186;184 06:53:46 INFO - PROCESS | 1653 | |3;audio-fft;81;59;59;88;59;61;59;59;74;58 06:53:46 INFO - PROCESS | 1653 | |4;audio-oscillator;81;70;86;72;67;69;82;89;98;97 06:53:46 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;88;90;86;90;86;90;87;90;86 06:53:46 INFO - PROCESS | 1653 | |6;imaging-darkroom;145;102;95;95;95;95;109;153;147;95 06:53:46 INFO - PROCESS | 1653 | |7;imaging-desaturate;90;86;86;86;88;89;89;86;87;87 06:53:46 INFO - PROCESS | 1653 | |8;json-parse-financial;54;54;53;55;56;56;56;56;56;56 06:53:46 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;67;79;73;75;69;69;69;70;72 06:53:46 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;83;84;92;102;103;79;83;82;76 06:53:46 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;139;146;154;133;147;154;147;184;169 06:53:46 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;168;168;166;168;169;168;166;166;165;167 06:53:46 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;67;67;67;66;68;64;69;65;64 06:53:46 INFO - PROCESS | 1653 | __end_tp_report 06:53:46 INFO - PROCESS | 1653 | __start_cc_report 06:53:46 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2086 06:53:46 INFO - PROCESS | 1653 | __end_cc_report 06:53:46 INFO - PROCESS | 1653 | __startTimestamp1488207226228__endTimestamp 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | ------- Summary: start ------- 06:53:46 INFO - PROCESS | 1653 | Number of tests: 14 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 06:53:46 INFO - PROCESS | 1653 | Values: 115.0 116.0 115.0 113.0 113.0 116.0 115.0 114.0 113.0 115.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:132.50 stddev:22.54 (17.0%) stddev-sans-first:22.77 06:53:46 INFO - PROCESS | 1653 | Values: 150.0 126.0 135.0 178.0 145.0 111.0 110.0 108.0 130.0 111.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.60 Median:184.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 06:53:46 INFO - PROCESS | 1653 | Values: 186.0 184.0 185.0 184.0 184.0 185.0 184.0 184.0 186.0 184.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.09 (18.5%) stddev-sans-first:10.28 06:53:46 INFO - PROCESS | 1653 | Values: 81.0 59.0 59.0 88.0 59.0 61.0 59.0 59.0 74.0 58.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:84.00 stddev:11.44 (13.6%) stddev-sans-first:12.13 06:53:46 INFO - PROCESS | 1653 | Values: 81.0 70.0 86.0 72.0 67.0 69.0 82.0 89.0 98.0 97.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.50 stddev:1.81 (2.0%) stddev-sans-first:1.90 06:53:46 INFO - PROCESS | 1653 | Values: 89.0 88.0 90.0 86.0 90.0 86.0 90.0 87.0 90.0 86.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:113.10 Median:95.00 stddev:24.80 (26.1%) stddev-sans-first:23.47 06:53:46 INFO - PROCESS | 1653 | Values: 145.0 102.0 95.0 95.0 95.0 95.0 109.0 153.0 147.0 95.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:87.50 stddev:1.51 (1.7%) stddev-sans-first:1.27 06:53:46 INFO - PROCESS | 1653 | Values: 90.0 86.0 86.0 86.0 88.0 89.0 89.0 86.0 87.0 87.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.14 (2.0%) stddev-sans-first:1.12 06:53:46 INFO - PROCESS | 1653 | Values: 54.0 54.0 53.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:4.08 (5.7%) stddev-sans-first:3.75 06:53:46 INFO - PROCESS | 1653 | Values: 65.0 67.0 79.0 73.0 75.0 69.0 69.0 69.0 70.0 72.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:83.00 stddev:9.18 (11.1%) stddev-sans-first:9.73 06:53:46 INFO - PROCESS | 1653 | Values: 86.0 83.0 84.0 92.0 102.0 103.0 79.0 83.0 82.0 76.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:150.50 stddev:15.46 (10.3%) stddev-sans-first:15.55 06:53:46 INFO - PROCESS | 1653 | Values: 137.0 139.0 146.0 154.0 133.0 147.0 154.0 147.0 184.0 169.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 06:53:46 INFO - PROCESS | 1653 | Values: 168.0 168.0 166.0 168.0 169.0 168.0 166.0 166.0 165.0 167.0 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.64 (2.4%) stddev-sans-first:1.73 06:53:46 INFO - PROCESS | 1653 | Values: 66.0 67.0 67.0 67.0 66.0 68.0 64.0 69.0 65.0 64.0 06:53:46 INFO - PROCESS | 1653 | -------- Summary: end -------- 06:53:46 INFO - PROCESS | 1653 | 06:53:46 INFO - PROCESS | 1653 | 1488207226248 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 06:53:47 INFO - TEST-INFO | 1653: exit 0 06:53:47 INFO - TEST-OK | kraken | took 59469ms 06:53:47 INFO - SUITE-END | took 1177s 06:53:47 INFO - Completed test suite (00:19:37) 06:53:47 INFO - javascript benchmark 06:53:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2899.623049003629, 3025.3193031567885, 3392.151962009497, 3399.354122716684, 3448.1724386147316, 5747.396523365044, 5755.827325180241, 5771.942280577193, 5774.2782152230975, 5779.017567013607, 5754.482096611304, 5798.217240672508, 5815.15680226368, 5840.182374467568, 5848.941510584893, 5288.127458969266, 5306.681599104057, 5309.62832601718, 5344.385395679507, 5356.758945847446, 5247.973760131194, 5250.3699556053325, 5257.369115706101, 5274.630775845692, 5401.891962160755, 5358.490943360394, 5375.16684913839, 5384.0847056000575, 5397.325334333208, 5420.512153906147, 5383.81156659517, 5385.2999110115825, 5390.51485366319, 5402.702851343174, 5414.10667239905, 5139.665921715076, 5177.534021938006, 5237.9476205238225, 5305.734713264322, 5313.229581710669, 5698.715064246812, 5717.742701578439, 5794.391588883191, 5806.042003069489, 5877.324107727623, 5247.186686063628, 6193.256809182882, 6292.339304373067, 6375.203099612549, 6399.456046236076, 4909.337239472661, 6306.369363063657, 6345.777897773602, 6358.491320694333, 6364.172657554488, 5711.000574899376, 5809.651420914759, 5869.354371019184, 5879.235699359141, 5890.322612899486, 6336.809895703136, 6337.302896681362, 6340.714667839959, 6347.143135676624, 6368.713407896656, 6231.781887634002, 6233.158523599256, 6235.875282494325, 6241.063840423882, 6263.530235232376, 6173.753049877954, 6173.84565385869, 6204.689765511706, 6209.285932117864, 6214.098955651496, 5344.251804747339, 6135.048937646369, 6219.129321894939, 6221.377862213742, 6222.595531290452, 6154.907676384858, 6194.039923811816, 6207.906881396782, 6215.689215539295, 6221.09794079865, 4981.003799240167, 4988.625853061035, 5008.198688209869, 5034.647574669812, 5069.670471419419, 4549.408576884984, 4561.863144105682, 4563.566461186182, 4598.97700511502, 4607.884802879955, 5831.212786273799, 5973.01445261527, 5975.79084732041, 5975.880482390415, 5979.133025711334, 5410.431904650034, 5926.525877929756, 6180.258368995749, 6242.188515493048, 6273.686315684197, 5887.116932460165, 5891.23413956183, 5904.7342869570975, 5909.8227053188475, 5944.7324870380935, 5540.612157149041, 5543.2793736814765, 5550.167474878801, 5557.5553955683445, 5561.888762224733, 4969.6769709970185, 6287.968560157353, 6299.275583307978, 6370.904436433457, 6386.7764628236855, 6306.779262725782, 6325.620462772248, 6328.208973878265, 6351.491880649629, 6378.298387177314, 6351.174347334817, 6379.425851673372, 6400.871982560416, 6430.871382572416, 6491.610503369624, 6125.540584456095, 6152.78465253714, 6206.968965155145, 6273.592216505913, 6316.842078948063, 5642.322921249476, 6232.844178895564, 6323.20959880015, 6326.2092238470195, 6391.744330226739, 6172.537059720449, 6186.876262474815, 6194.907076393948, 6199.380061993765, 6200.441960223601, 6044.576879618385, 6154.353792851686, 6175.84560385994, 6205.81382558524, 6215.627062376091, 4996.825111121093, 5921.585489015728, 6023.819285421444, 6045.758169673164, 6089.238845144357, 6196.7018199438835, 6238.376162383907, 6242.282137554058, 6246.219222597176, 6260.812175634738, 6035.124906888389, 6054.90917636227, 6060.090986351906, 6062.120992456157, 6096.993995990611], "value": 5743.608886369131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.0468620582983, 461.9491855895853, 476.60679939050294, 503.9319691841601, 505.59047171790854, 30553.38893222137, 37933.62066379336, 39848.40227396584, 39993.60006399935, 40031.999200020015, 40139.79580612579, 43002.7849860751, 43022.0, 43026.0, 43109.568904311025, 8335.95832020839, 9117.726468205949, 9344.159025687686, 9357.95321023394, 9415.670451534197, 8352.665893364288, 9166.54167291636, 11269.830952535718, 11295.152863535226, 11457.5416983321, 11316.038136758385, 11381.772364552704, 11384.260023098514, 11413.828792568118, 11438.0, 11192.66422007337, 11279.830802537886, 11282.999999999958, 11294.0, 11316.660500185008, 8352.83294334116, 8529.53087580183, 8534.658613655447, 8642.092580279043, 8651.610677519528, 39132.41301380481, 39642.80178599117, 39683.0, 41658.1668366631, 41754.582454175375, 3821.5987321331418, 3931.9410208846602, 3957.28768821612, 3963.3460479021214, 4015.2371049500794, 30021.39957200844, 30048.248793780112, 31097.689023109706, 31131.844340778378, 31386.21534461634, 2833.2775142338573, 3143.0256620447735, 3167.3823604397153, 3238.2228265216413, 3251.0, 506481.0, 507075.0, 508566.0, 509535.0, 510391.0, 65998.34001659922, 66597.0, 66692.33307666861, 66726.0, 66741.6662916692, 69325.49384290005, 69335.0, 69434.65282673555, 69482.30517694859, 69488.6525567369, 16168.838311616733, 16364.427245046367, 16784.412545561092, 16805.0, 16897.15514224284, 11645.184837061324, 12954.67613309656, 13053.0, 13066.54267100647, 13077.280749558675, 15995.360185592446, 16533.6693266134, 18348.990805505557, 18675.252989880526, 18799.15403806832, 6863.691133898987, 6956.339147780953, 6991.510594258353, 6993.685284162225, 7007.194172670106, 865.4201684871151, 866.7789713622985, 884.6682494064726, 898.6315610599622, 918.7106061590712, 21644.891775541022, 28610.427791444472, 28641.997530086763, 30320.483975801122, 30614.081577552708, 1071.2608300272943, 1073.4149888310733, 1098.2861140258897, 1110.1230028277732, 1211.4487908001838, 15259.389624415122, 15663.138527380876, 15742.527724168292, 16093.597660058358, 16137.515874523782, 624377.0, 625186.0, 628594.0, 629947.0, 630380.0, 61415.165559271794, 61528.38471615316, 61561.0, 61654.69172654108, 62014.0697889532, 1415.83010038796, 1458.693674328403, 1472.256510462231, 1475.0928179169734, 1475.5794598539364, 27718.307042323297, 29120.854395727885, 29394.55908161422, 30181.245468862577, 30334.69665303407, 43730.0, 52761.0, 53501.4649853512, 53506.46493535015, 53561.0, 522386.0, 537779.0, 553879.0, 556398.0, 556403.0, 40341.1931761369, 40816.591834082465, 41824.16351673011, 41908.371374428796, 41912.74261772152, 46264.30603541017, 47252.29121563111, 47419.81450463766, 47831.0, 47918.76040619914, 28822.42355152927, 33174.0, 38405.23189536249, 38432.615673842905, 40482.987925302106, 28134.71865281321, 38558.0, 39812.80093599513, 40046.799766000986, 40312.39531406973, 37083.44374834433, 37387.0, 38081.619183808914, 38107.047323817125, 38377.0, 32195.0, 33033.66966330306, 33833.66166338305, 33909.321813564085, 34035.65964340325, 23144.3056708299, 24405.38986525351, 24776.504469910862, 24840.079984878423, 25108.24675259745], "value": 20322.132758396354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.30386221971577, 388.8988862895647, 391.06730447881796, 400.1576681086313, 425.25155725922366, 14311.855051595874, 15613.453529126482, 18901.71647425288, 20524.38426847197, 21130.366089017352, 20606.278780242694, 20954.476138096554, 21165.365039048815, 21543.13827446904, 21621.3513594592, 4525.230710779159, 4564.315352697089, 5546.306711661043, 5757.222774925394, 5843.883122337551, 5077.441481437039, 5626.578006649518, 5655.462731040545, 5730.541556675476, 5772.855678608026, 4143.834246630131, 4382.452193475816, 4424.756638384888, 5696.743646535895, 6550.443212326934, 5657.2928383952, 6583.177102862142, 6583.374579414948, 6601.042848786947, 6601.2408573014, 5513.61404701671, 5514.95215908976, 5573.052581061189, 5575.804846830341, 5638.971805140989, 22697.546049078926, 23139.84300784954, 26066.218013459627, 26140.738592614212, 26449.47101057968, 2679.089109702691, 2692.9192124236306, 2729.9454010919867, 2734.934011766582, 2769.1830909881633, 15444.227788610637, 15501.992370495882, 15518.612034699223, 15654.608634784221, 16008.919955400264, 1756.6135450200936, 1798.2896755781394, 1811.4837271377726, 1816.0, 1840.8067152948881, 103440.0, 120552.0, 127313.72686273111, 128042.3597882014, 131045.0, 9455.76360590977, 11519.193656444137, 11671.649850504498, 11677.357745324089, 11873.762524749456, 14699.0, 14734.263286835616, 14741.705165896621, 14752.63118422048, 14764.114153150846, 8342.582870856433, 8752.0, 8759.693410730593, 8788.91211087881, 8807.0, 8686.86969695455, 8695.478271303615, 8700.30397568193, 8835.514046727363, 8881.33389995753, 5915.438033386821, 7134.430425306425, 7138.750143744944, 7145.6784444700115, 7150.96424517874, 1865.869389142747, 1914.387396033256, 1946.1339703831943, 1961.254723205173, 1963.4404194804413, 861.8319427711662, 890.7684002159485, 891.9163216691751, 894.932880034, 930.9441433514011, 16582.17089145538, 21247.893760531097, 22126.557468850853, 22129.225477108546, 22138.225162119572, 911.8905731312152, 936.166811537732, 936.7096200177966, 940.7601061729215, 960.3853533738413, 11028.613998510174, 11455.599054033235, 11522.942385288019, 11570.42147892602, 11650.825237621442, 432254.0, 555585.0, 655448.0, 774430.0, 787282.0, 117145.41427292979, 127676.36161819317, 130378.0, 131228.0, 131503.0, 972.6984634763246, 1004.9849252261222, 1029.2897900448665, 1040.484959944832, 1046.2885238038054, 19647.803521964597, 19783.40649780509, 20534.0, 20563.58872822505, 20580.588388232452, 61642.0, 62068.0, 62125.68937155466, 63511.36488635239, 64313.0, 90678.0, 93137.534312328, 93165.0, 94373.0, 94376.52811736173, 8172.959135204286, 8187.631556580087, 8466.830663386574, 8501.362397820065, 8503.404761666625, 8654.264387527131, 8785.780355491164, 8991.505467199368, 9042.457452552868, 9175.357724959189, 7621.771346859603, 8132.227438393344, 8249.546274954935, 8272.17278272192, 8430.15698430152, 7062.576245425291, 7808.219178082373, 7886.605669716606, 8253.546054967035, 8377.0, 7563.659635316314, 8416.242538171595, 8456.619452124545, 8458.450200736932, 8489.575521224038, 12429.50845898498, 12862.485500579873, 12928.7324432113, 13373.598792036255, 13539.59381218565, 11674.299542027506, 11706.648800535997, 12130.514779408724, 12226.877731222574, 12246.510139594317], "value": 9736.179994753205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.333964706412, 1445.2990299704643, 1451.7314296855077, 1452.8474510176438, 1456.6940942402096, 7815.960920195405, 8463.619137138829, 8481.151884811523, 8484.91515084849, 8491.872621910661, 7372.004779354799, 7622.618869056552, 7623.390128789697, 7636.503627264224, 7642.273983971514, 2101.7898210178973, 2139.0267428320076, 2231.3306008197474, 2304.078368652544, 2308.1805958884606, 2351.071326825903, 2357.9410514737096, 2358.6933698619155, 2359.528094381131, 2363.4682196505732, 2268.625676763332, 2302.5855346037706, 2304.2050492580033, 2306.411864974438, 2310.919117830876, 2258.830587705929, 2264.275431861813, 2290.576243394977, 2291.0835665733675, 2291.8281128915396, 2015.647261729206, 2200.4938864061196, 2241.8318626102946, 2310.688057112285, 2311.0986715181093, 8371.16288371164, 8400.579971001487, 8402.78993025173, 8403.915960840435, 8421.199986001382, 5076.213186956028, 5224.242484839715, 5226.764795584208, 5231.973840130813, 5252.422233554306, 3256.4301247281633, 3453.5165076889257, 3521.0845180253064, 3527.682508574215, 3533.522974398449, 1185.7535623342008, 1189.3874654552912, 1249.1256120715536, 1253.6552448076761, 1268.6130730127306, 10754.892451075468, 10873.075788557982, 10893.965073318022, 10900.182486313479, 10918.836217456745, 4509.098180363941, 4674.158651442773, 4687.6249900007915, 4780.426348838162, 4795.352627395327, 8846.380753347332, 8924.8661270081, 8925.285977121815, 8943.955280223558, 8956.462612243156, 4469.9776501117285, 5097.668651537638, 5191.97404012985, 5205.141151710001, 5212.895742085213, 4598.149342371672, 4787.8563643090765, 4863.10032643962, 4867.0995865764235, 4889.731064791471, 3480.773749706261, 3589.8384572693767, 3594.8382322795537, 3606.9819650901577, 3609.3322735294055, 962.5091203486132, 1086.9619563315246, 1147.862256529222, 1169.7543515861594, 1177.2289150606366, 863.684755064397, 880.6859035708376, 884.2130503851578, 894.1058941058941, 923.0492592629603, 4944.653874228769, 5456.863578410492, 5511.889762204733, 5674.319081710221, 5725.541956643458, 973.8587904753913, 982.7346616413671, 995.323180237431, 1004.7940172264668, 1025.620520407454, 3620.6198349173483, 3671.834767435472, 3735.589085200626, 3787.981060094682, 3836.846526138979, 9886.752831179134, 10126.848097278547, 10209.846852297222, 10221.0, 10228.53971571281, 9998.400095994119, 10161.288709790391, 10183.490825458697, 10328.380297182193, 10404.895951040393, 6769.593824370553, 7763.883541746765, 7873.448858579959, 7966.800829979297, 8003.19968003195, 5704.486596206361, 5828.504577110993, 5881.617694849821, 5950.077737950624, 5951.940480595312, 8858.29133669292, 8949.507777072324, 9225.815483690154, 9421.644588852787, 9467.053294670477, 8487.957560212159, 9222.538873056454, 9332.813343733224, 9466.715998520056, 9470.384425012353, 7150.499465037397, 7193.0289410930945, 7334.779956601311, 7335.559866408033, 7347.26527347261, 7863.646135924012, 7871.48835325702, 7960.681572737258, 7967.641456134604, 7991.680332786624, 7025.894611580932, 7053.964730176522, 7076.0, 7191.964040179766, 7269.563826170447, 7078.115235595551, 7099.2190859006505, 7135.928640713526, 7154.749583764543, 7221.133463984355, 6389.233292004989, 6431.099646049463, 6460.160179176677, 6509.1863517060365, 6531.444827189552, 4957.405111386656, 4958.876028099182, 4995.775190116527, 5046.495350464924, 5063.0, 4962.578180854668, 4974.676646017997, 5000.199968005102, 5062.493750624908, 5220.451852555427], "value": 4406.121533881129, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7387164140329, 346.4871989455606, 351.60238053736396, 354.9680528752412, 357.17492592112205, 4644.164050470914, 5054.545090941814, 5230.293910322105, 5234.267202591631, 5295.285136506575, 5009.974950125254, 5180.844574662757, 5235.947640523594, 5241.42344342122, 5241.889158070879, 3222.3555288942307, 3505.526753888231, 3906.433567132764, 4047.8785636430953, 4097.713160078795, 3101.4727496325677, 3232.65844674461, 3951.4467974483596, 3963.483188175515, 4029.3955906614096, 3399.847006884696, 3906.8084234308526, 3968.305546529346, 3974.0, 4004.599540046001, 3978.9801050994847, 3981.2634662587516, 3991.7804520751347, 3995.180987897474, 4012.558618551957, 3178.396104740115, 3239.8616912837415, 3465.081753335368, 3477.4088404971217, 3477.6522347765276, 3991.9201615967518, 5088.4148322942965, 5175.842735931079, 5209.791608335662, 5210.931758989398, 3843.8846834595006, 4791.5687588117235, 4795.848996240912, 4799.856004319876, 4840.927386089212, 5591.944080559183, 5629.662220266797, 5634.6337488063145, 5649.406812284733, 5666.3766985631955, 3644.5444319460066, 3914.9608503914883, 3947.723659343847, 3955.802209889494, 3995.9410756149646, 4999.825006124768, 5520.757829488333, 5653.9151912721345, 5707.800226992035, 5841.824745257649, 4107.507099148122, 4176.895577610523, 4194.643455306272, 4215.524566401735, 4216.599423054805, 3938.1926705025403, 4239.47006624172, 4246.893827654333, 4267.061246525759, 4279.930017495626, 4441.933370999438, 4513.909721805546, 4782.928256076161, 4819.5782244238035, 4855.465898751135, 4733.0, 5379.390995367244, 5618.213450116987, 5655.745491452894, 5674.978503869261, 1303.6349822049842, 1346.8585798491017, 1352.3373546962114, 1390.2770559309104, 1426.4436869620856, 890.1365675294953, 896.9416089015025, 909.3676850054169, 938.7700013496737, 982.268210183418, 4529.818807247739, 4821.373221481185, 4934.358533390637, 4942.640773787237, 4943.65394422387, 4473.753943533072, 4803.255495398219, 4866.878328041827, 5058.342415486037, 5314.92027619586, 4150.302303502747, 4358.259095953696, 4486.68593198473, 4846.801111266547, 5012.373453318335, 2527.54504189244, 2792.4554711830997, 2805.9859700701772, 2889.537673972154, 2892.6673432555526, 5171.896562068738, 5452.372977107683, 5502.98194833957, 5669.206311116447, 5709.914351284734, 5123.2827404163445, 5206.5376524611465, 5543.223948647193, 5623.919149914558, 5670.206171136044, 5128.025675121715, 5641.643222282735, 5643.463870932255, 5648.74580643872, 5671.602987790898, 4779.617630589475, 5217.3217881394285, 5321.0, 5468.781248750005, 5543.8891222176135, 5335.0, 5408.78364865401, 5702.144678298123, 5757.769689212385, 5769.394213607511, 4762.857114286577, 4931.9753401232765, 5621.80323688669, 5774.892164360062, 5876.853078673067, 3513.9297214055064, 3549.840257188381, 3859.575446700917, 3860.749051311656, 3886.611338866204, 4305.590968857953, 5072.923906141337, 5685.943140568541, 5771.509421699203, 5781.640195784603, 4825.734584597881, 5041.630433696157, 5525.198846167203, 5531.612787104864, 5534.308211473566, 4711.646626502958, 4883.926741098958, 5490.419502833662, 5513.641613295123, 5514.367930938031, 5079.339685840817, 5212.296339994053, 5442.129259318648, 5499.340079190522, 5510.972445137909, 4144.564820693904, 5078.847634570969, 5521.923224971092, 5525.834224973257, 5538.040301184672, 4594.287885377772, 4841.225403935354, 5201.609879258995, 5243.449437808975, 5431.447219806684], "value": 4030.2250939326373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.9723211071557, 725.8512005038967, 751.1511991449661, 803.6142651527267, 803.8874557561942, 14824.703505929874, 14961.0, 15796.447124350636, 15809.762853557206, 15910.363585456567, 13835.723285534283, 14409.855901440982, 14551.0, 14581.34383952722, 14622.195779232137, 837.9999999999985, 868.9044205137429, 869.1525762381691, 869.4783130121908, 871.1941454154913, 687.8933765266391, 858.4677499950039, 863.1541089732067, 864.5590748718167, 864.7059999600135, 730.8757511223105, 742.0946445336681, 878.0, 912.7216199059284, 914.6295750221171, 868.3617541107282, 883.1477624092781, 884.4958373726978, 903.9819203615924, 905.5019739143445, 673.2896793882452, 674.642439507062, 675.4630069095081, 675.787127054976, 675.8073948924582, 11080.61217857371, 11887.762244755142, 12172.878271217352, 12326.07554433412, 14999.100053996686, 12469.251844889335, 14644.70710585793, 14727.779083313759, 14775.187364694937, 14903.70192596142, 11532.192746507748, 11618.651440456715, 11642.94178529102, 11649.534018639244, 11739.47172377245, 3660.963390366089, 3709.914168428909, 3766.2655782122497, 3904.511936007999, 3907.0623050467684, 100170.46474071422, 104953.0, 106291.46854265679, 106877.465612673, 109983.90016099896, 10556.47217639115, 11109.611163609397, 11199.552017919355, 11419.20065595417, 11491.310521368745, 23495.88252058763, 23500.882495587754, 23608.64587031196, 23872.0, 24082.759172408052, 7813.531188128731, 7817.687292508236, 7851.646675899598, 7892.960535197287, 7979.72070977513, 4211.115665710174, 4235.486671789725, 4309.1381723655395, 4329.783510824446, 4337.9783101084295, 3530.593981692087, 3620.5474315710535, 3639.1629925117372, 3652.543432070991, 3662.011256960606, 642.7557528139371, 648.7673420501086, 653.3205466315075, 667.813012356541, 667.9599224046573, 653.5261935097017, 658.6527288101144, 664.5514277862424, 683.733343995842, 728.3590440412403, 9737.853932191023, 10096.848547271797, 10171.186305095574, 10216.540255688511, 10232.948835255926, 651.7458191305394, 675.2167485716545, 699.174973531238, 705.7882635209417, 708.1113202930393, 4684.484706682262, 4903.117438861039, 4916.434610019822, 4934.481879402611, 4941.209406494943, 75970.0, 108732.0, 108736.0, 108964.36553451704, 110644.34033489504, 69895.65052174707, 72124.0, 74461.6276918612, 75908.62045689847, 83122.58438707767, 72891.54216915739, 74834.62582687051, 75546.0, 76046.0, 76729.61635191788, 10507.89492105069, 10796.514156863117, 10800.627629698516, 10926.0, 11036.834447483134, 47796.76101619609, 48043.75978120087, 49143.0, 50375.49624503708, 50482.74758626183, 60921.39078609157, 61774.0, 62294.75410491855, 63544.72910541671, 64967.0, 12377.133600648229, 12578.685532861751, 12603.558875439316, 12706.110572259853, 12812.0, 13883.514077007256, 14121.2939353034, 14280.285985700466, 15001.024933379296, 15010.849891500946, 10945.60968704848, 13204.471821127046, 13305.933470332586, 13508.86491135076, 13621.455141794217, 12689.047947051467, 12880.0, 12909.289989050316, 13292.667683307995, 13308.93345533266, 12311.75376492483, 13161.210327380388, 13168.539101131415, 13354.0, 13669.931650341685, 10372.27394082407, 10742.785144296913, 10966.835497467384, 11040.847034828132, 11378.487968041292, 9091.772705682411, 9375.561276417475, 10025.0, 10562.419066951392, 10611.151107911193], "value": 7411.771526230947, "unit": "score"}], "name": "dromaeo_css", "value": 7285.900421544597, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 113.0, 113.0, 116.0, 115.0, 114.0, 113.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 135.0, 178.0, 145.0, 111.0, 110.0, 108.0, 130.0, 111.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 184.0, 184.0, 185.0, 184.0, 184.0, 186.0, 184.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 59.0, 61.0, 59.0, 59.0, 74.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 86.0, 72.0, 67.0, 69.0, 82.0, 89.0, 98.0, 97.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 86.0, 90.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 102.0, 95.0, 95.0, 95.0, 95.0, 109.0, 153.0, 147.0, 95.0], "value": 113.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 86.0, 86.0, 88.0, 89.0, 89.0, 86.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 79.0, 73.0, 75.0, 69.0, 69.0, 69.0, 70.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 92.0, 102.0, 103.0, 79.0, 83.0, 82.0, 76.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 146.0, 154.0, 133.0, 147.0, 154.0, 147.0, 184.0, 169.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 168.0, 169.0, 168.0, 166.0, 166.0, 165.0, 167.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 64.0, 69.0, 65.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1462.3999999999999, "alertThreshold": 2.0}]} 06:53:47 INFO - Return code: 0 06:53:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:53:47 ERROR - # TBPL SUCCESS # 06:53:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:47 INFO - 2017-02-27 06:53:47.545 screenresolution[1657:9710] starting screenresolution argv=screenresolution get 06:53:47 INFO - 2017-02-27 06:53:47.548 screenresolution[1657:9710] Display 0: 1600x1200x32@60 06:53:47 INFO - 2017-02-27 06:53:47.554 screenresolution[1658:9713] starting screenresolution argv=screenresolution list 06:53:47 INFO - Available Modes on Display 0 06:53:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:47 INFO - Intel Iris: 06:53:47 INFO - Chipset Model: Intel Iris 06:53:47 INFO - Type: GPU 06:53:47 INFO - Bus: Built-In 06:53:47 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:47 INFO - Vendor: Intel (0x8086) 06:53:47 INFO - Device ID: 0x0a2e 06:53:47 INFO - Revision ID: 0x0009 06:53:47 INFO - Displays: 06:53:47 INFO - Display: 06:53:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:47 INFO - Display Serial Number: 1600x1200 60 06:53:47 INFO - Main Display: Yes 06:53:47 INFO - Mirror: Off 06:53:47 INFO - Online: Yes 06:53:47 INFO - Rotation: Supported 06:53:47 INFO - Return code: 0 06:53:47 INFO - Running post-action listener: _resource_record_post_action 06:53:47 INFO - [mozharness: 2017-02-27 14:53:47.791499Z] Finished run-tests step (success) 06:53:47 INFO - Running post-run listener: _resource_record_post_run 06:53:47 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39166976; Write bytes: 509735936; Read time: 375; Write time: 1543 06:53:47 INFO - TinderboxPrint: CPU usage
53.8% 06:53:47 INFO - TinderboxPrint: I/O read bytes / time
39,166,976 / 375 06:53:47 INFO - TinderboxPrint: I/O write bytes / time
509,735,936 / 1,543 06:53:47 INFO - TinderboxPrint: CPU idle
2,216.9 (46.2%) 06:53:47 INFO - TinderboxPrint: CPU system
962.2 (20.1%) 06:53:47 INFO - TinderboxPrint: CPU user
1,614.5 (33.7%) 06:53:47 INFO - TinderboxPrint: Swap in / out
246,595,584 / 0 06:53:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205656576; Write bytes: 198950912; Read time: 15682; Write time: 384 06:53:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36619264; Write bytes: 299688960; Read time: 349; Write time: 1117 06:53:48 INFO - Running post-run listener: _upload_blobber_files 06:53:48 INFO - Blob upload gear active. 06:53:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:53:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:53:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:49 INFO - (blobuploader) - INFO - Done attempting. 06:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:50 INFO - (blobuploader) - INFO - Done attempting. 06:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:51 INFO - (blobuploader) - INFO - Done attempting. 06:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:53 INFO - (blobuploader) - INFO - Done attempting. 06:53:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:53:53 INFO - Return code: 0 06:53:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:53:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:53:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc50063d223489e156e81a6c61bd884ccfd7c000d5d4cfec485155c0c86a68e342e092784a8da7e6f509c4cac79e9d1ac0fdbe067c122e6ac1c9d8e91fadae7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a600823a3643b04185c083b8dcd2596800cdc42be03910e539eb324e1cf5d712de00da58d94588ba2a664bcc23229798307202cd0a25dcddc7e82486a9df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd5b0dc24f7c985b92816679497cd78770e37c0640abf36ec0a49aeecf94a2ec6ae14e0b47916236942a4d51474c71838d1159100ace19fa724d9ffd5a150071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a044cbb91387ac9e8d0158dd51a4413e64bdb9c447f00e844c4cc3d3cfeffc6cd3fee6c559eeba1fe2ed62b0892fa5eeb815d99fbabbec60cbff551b8e51bb2e"} 06:53:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:53:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:53:53 INFO - Contents: 06:53:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc50063d223489e156e81a6c61bd884ccfd7c000d5d4cfec485155c0c86a68e342e092784a8da7e6f509c4cac79e9d1ac0fdbe067c122e6ac1c9d8e91fadae7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a600823a3643b04185c083b8dcd2596800cdc42be03910e539eb324e1cf5d712de00da58d94588ba2a664bcc23229798307202cd0a25dcddc7e82486a9df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd5b0dc24f7c985b92816679497cd78770e37c0640abf36ec0a49aeecf94a2ec6ae14e0b47916236942a4d51474c71838d1159100ace19fa724d9ffd5a150071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a044cbb91387ac9e8d0158dd51a4413e64bdb9c447f00e844c4cc3d3cfeffc6cd3fee6c559eeba1fe2ed62b0892fa5eeb815d99fbabbec60cbff551b8e51bb2e"} 06:53:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:53:53 INFO - Copying logs to upload dir... 06:53:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:53:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.282297 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-27 06:53:53.671506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 06:53:53.674778) ========= 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.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc50063d223489e156e81a6c61bd884ccfd7c000d5d4cfec485155c0c86a68e342e092784a8da7e6f509c4cac79e9d1ac0fdbe067c122e6ac1c9d8e91fadae7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a600823a3643b04185c083b8dcd2596800cdc42be03910e539eb324e1cf5d712de00da58d94588ba2a664bcc23229798307202cd0a25dcddc7e82486a9df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd5b0dc24f7c985b92816679497cd78770e37c0640abf36ec0a49aeecf94a2ec6ae14e0b47916236942a4d51474c71838d1159100ace19fa724d9ffd5a150071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a044cbb91387ac9e8d0158dd51a4413e64bdb9c447f00e844c4cc3d3cfeffc6cd3fee6c559eeba1fe2ed62b0892fa5eeb815d99fbabbec60cbff551b8e51bb2e"} build_url:https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/Y0yubNJmStajwJsLipqGHQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc50063d223489e156e81a6c61bd884ccfd7c000d5d4cfec485155c0c86a68e342e092784a8da7e6f509c4cac79e9d1ac0fdbe067c122e6ac1c9d8e91fadae7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6a600823a3643b04185c083b8dcd2596800cdc42be03910e539eb324e1cf5d712de00da58d94588ba2a664bcc23229798307202cd0a25dcddc7e82486a9df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd5b0dc24f7c985b92816679497cd78770e37c0640abf36ec0a49aeecf94a2ec6ae14e0b47916236942a4d51474c71838d1159100ace19fa724d9ffd5a150071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a044cbb91387ac9e8d0158dd51a4413e64bdb9c447f00e844c4cc3d3cfeffc6cd3fee6c559eeba1fe2ed62b0892fa5eeb815d99fbabbec60cbff551b8e51bb2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 06:53:53.710328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:53:53.710707) ========= 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.v6cq0nOfY8/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.2kN8TESSVx/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 06:53:53.759387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 06:53:53.759726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 06:53:53.760075) ========= ========= Total master_lag: 0.82 =========