builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1484656316.31 results: success (0) buildid: 20170117030218 builduid: 5e48b2bbcdaa4087bcf1b9752bfbd88e revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.314492) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.315004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.315329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.346004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.346363) ========= 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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-17 04:31:56-- 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% 18.3M=0.001s 2017-01-17 04:31:56 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.289231 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.663918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.664248) ========= 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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.027000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:56.712612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 04:31:56.712988) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e275d37a06236981bff399b7d7aa0646be3fee7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e275d37a06236981bff399b7d7aa0646be3fee7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-17 04:31:56,805 truncating revision to first 12 chars 2017-01-17 04:31:56,805 Setting DEBUG logging. 2017-01-17 04:31:56,805 attempt 1/10 2017-01-17 04:31:56,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e275d37a062?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 04:31:57,815 unpacking tar archive at: mozilla-central-3e275d37a062/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270976 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 04:31:58.010986) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:58.011632) ========= script_repo_revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:58.012604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:58.013348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 04:31:58.043847) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 04:31:58.044169) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:31:58 INFO - MultiFileLogger online at 20170117 04:31:58 in /builds/slave/test 04:31:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:31:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:58 INFO - {'append_to_log': False, 04:31:58 INFO - 'base_work_dir': '/builds/slave/test', 04:31:58 INFO - 'blob_upload_branch': 'Firefox', 04:31:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:58 INFO - 'branch': 'Firefox', 04:31:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:58 INFO - 'config_files': ('talos/mac_config.py',), 04:31:58 INFO - 'default_actions': ('clobber', 04:31:58 INFO - 'read-buildbot-config', 04:31:58 INFO - 'download-and-extract', 04:31:58 INFO - 'populate-webroot', 04:31:58 INFO - 'create-virtualenv', 04:31:58 INFO - 'install', 04:31:58 INFO - 'run-tests'), 04:31:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:58 INFO - 'download_minidump_stackwalk': True, 04:31:58 INFO - 'download_symbols': 'ondemand', 04:31:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:58 INFO - 'installer_path': 'installer.exe', 04:31:58 INFO - 'log_level': 'info', 04:31:58 INFO - 'log_name': 'talos', 04:31:58 INFO - 'log_to_console': True, 04:31:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:58 INFO - 'opt_config_files': (), 04:31:58 INFO - 'pip_index': False, 04:31:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:58 INFO - 'cmd': ('bash', 04:31:58 INFO - '-c', 04:31:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:58 INFO - 'enabled': True, 04:31:58 INFO - 'halt_on_failure': False, 04:31:58 INFO - 'name': 'check_screen_resolution'},), 04:31:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:58 INFO - 'cmd': ('bash', 04:31:58 INFO - '-c', 04:31:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:58 INFO - 'enabled': True, 04:31:58 INFO - 'halt_on_failure': False, 04:31:58 INFO - 'name': 'check_screen_resolution'},), 04:31:58 INFO - 'run_cmd_checks_enabled': True, 04:31:58 INFO - 'sps_profile': False, 04:31:58 INFO - 'sps_profile_interval': 0, 04:31:58 INFO - 'suite': 'dromaeojs-e10s', 04:31:58 INFO - 'system_bits': '32', 04:31:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:58 INFO - 'title': 't-yosemite-r7-0009', 04:31:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:58 INFO - 'use_talos_json': True, 04:31:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:58 INFO - 'work_dir': 'build'} 04:31:58 INFO - [mozharness: 2017-01-17 12:31:58.251418Z] Running clobber step. 04:31:58 INFO - Running pre-action listener: _resource_record_pre_action 04:31:58 INFO - Running main action method: clobber 04:31:58 INFO - rmtree: /builds/slave/test/build 04:31:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:00 INFO - Running post-action listener: _resource_record_post_action 04:32:00 INFO - [mozharness: 2017-01-17 12:32:00.885756Z] Finished clobber step (success) 04:32:00 INFO - [mozharness: 2017-01-17 12:32:00.885867Z] Running read-buildbot-config step. 04:32:00 INFO - Running pre-action listener: _resource_record_pre_action 04:32:00 INFO - Running main action method: read_buildbot_config 04:32:00 INFO - Using buildbot properties: 04:32:00 INFO - { 04:32:00 INFO - "project": "", 04:32:00 INFO - "product": "firefox", 04:32:00 INFO - "script_repo_revision": "production", 04:32:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:32:00 INFO - "repository": "", 04:32:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:32:00 INFO - "buildid": "20170117030218", 04:32:00 INFO - "stage_platform": "macosx64", 04:32:00 INFO - "basedir": "/builds/slave/test", 04:32:00 INFO - "nightly_build": "True", 04:32:00 INFO - "buildnumber": 58, 04:32:00 INFO - "slavename": "t-yosemite-r7-0009", 04:32:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:32:00 INFO - "platform": "yosemite_r7", 04:32:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:32:00 INFO - "branch": "mozilla-central", 04:32:00 INFO - "repo_path": "mozilla-central", 04:32:00 INFO - "revision": "3e275d37a06236981bff399b7d7aa0646be3fee7", 04:32:00 INFO - "pgo_build": "False", 04:32:00 INFO - "builduid": "5e48b2bbcdaa4087bcf1b9752bfbd88e", 04:32:00 INFO - "slavebuilddir": "test" 04:32:00 INFO - } 04:32:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:32:00 INFO - Running post-action listener: _resource_record_post_action 04:32:00 INFO - [mozharness: 2017-01-17 12:32:00.888919Z] Finished read-buildbot-config step (success) 04:32:00 INFO - [mozharness: 2017-01-17 12:32:00.889053Z] Running download-and-extract step. 04:32:00 INFO - Running pre-action listener: _resource_record_pre_action 04:32:00 INFO - Running main action method: download_and_extract 04:32:00 INFO - mkdir: /builds/slave/test/build/tests 04:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:00 INFO - trying https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:32:01 INFO - Downloaded 1199 bytes. 04:32:01 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:32:01 INFO - Using the following test package requirements: 04:32:01 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:32:01 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:32:01 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:32:01 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'jsshell-mac.zip'], 04:32:01 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:32:01 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:32:01 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:32:01 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:32:01 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:32:01 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:32:01 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:32:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:32:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:32:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:01 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:32:02 INFO - Expected file size: 16326686 04:32:02 INFO - Obtained file size: 16326686 04:32:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:32:10 INFO - Expected file size: 16326686 04:32:10 INFO - Obtained file size: 16326686 04:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:32:18 INFO - Expected file size: 14403463 04:32:18 INFO - Obtained file size: 14403463 04:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:18 INFO - trying https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:18 INFO - Downloading https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:32:21 INFO - Downloaded 70185748 bytes. 04:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:21 INFO - mkdir: /builds/slave/test/properties 04:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:21 INFO - Contents: 04:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:32:22 INFO - Running post-action listener: _resource_record_post_action 04:32:22 INFO - Running post-action listener: set_extra_try_arguments 04:32:22 INFO - [mozharness: 2017-01-17 12:32:22.673048Z] Finished download-and-extract step (success) 04:32:22 INFO - [mozharness: 2017-01-17 12:32:22.673173Z] Running populate-webroot step. 04:32:22 INFO - Running pre-action listener: _resource_record_pre_action 04:32:22 INFO - Running main action method: populate_webroot 04:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:22 INFO - '--tppagecycles', 04:32:22 INFO - '7'], 04:32:22 INFO - 'tests': ['tsvgm']}}, 04:32:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['damp', 'tps']}, 04:32:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'tests': ['damp', 'tps']}, 04:32:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['dromaeo_dom']}, 04:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['basic_compositor_video']}, 04:32:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['a11yr', 04:32:22 INFO - 'ts_paint', 04:32:22 INFO - 'tpaint', 04:32:22 INFO - 'sessionrestore', 04:32:22 INFO - 'sessionrestore_no_auto_restore', 04:32:22 INFO - 'tabpaint']}, 04:32:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['tsvgx', 04:32:22 INFO - 'tsvgr_opacity', 04:32:22 INFO - 'tart', 04:32:22 INFO - 'tscrollx', 04:32:22 INFO - 'cart', 04:32:22 INFO - 'tsvg_static']}, 04:32:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:22 INFO - 'tsvgr_opacity', 04:32:22 INFO - 'tart', 04:32:22 INFO - 'tscrollx', 04:32:22 INFO - 'cart', 04:32:22 INFO - 'tsvg_static']}, 04:32:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'talos_options': ['--disable-e10s'], 04:32:22 INFO - 'tests': ['tp5o']}, 04:32:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:32:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'talos_options': ['--disable-e10s', 04:32:22 INFO - '--xperf_path', 04:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:22 INFO - 'tests': ['tp5n']}, 04:32:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:32:22 INFO - 'talos_options': ['--xperf_path', 04:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:22 INFO - 'tests': ['tp5n']}}, 04:32:22 INFO - 'talos.zip': {'path': '', 04:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:22 INFO - Running post-action listener: _resource_record_post_action 04:32:22 INFO - [mozharness: 2017-01-17 12:32:22.690804Z] Finished populate-webroot step (success) 04:32:22 INFO - [mozharness: 2017-01-17 12:32:22.690918Z] Running create-virtualenv step. 04:32:22 INFO - Running pre-action listener: _resource_record_pre_action 04:32:22 INFO - Running main action method: create_virtualenv 04:32:22 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:22 INFO - Using real prefix '/tools/python27' 04:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:26 INFO - Installing pip.................done. 04:32:26 INFO - Return code: 0 04:32:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:26 INFO - Reading from file tmpfile_stdout 04:32:26 INFO - Output received: 04:32:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:32:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:26 INFO - 'HOME': '/Users/cltbld', 04:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:26 INFO - 'LOGNAME': 'cltbld', 04:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:26 INFO - 'MOZ_NO_REMOTE': '1', 04:32:26 INFO - 'NO_EM_RESTART': '1', 04:32:26 INFO - 'PAGER': '/bin/cat', 04:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:26 INFO - 'PWD': '/builds/slave/test', 04:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:26 INFO - 'SHELL': '/bin/bash', 04:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:26 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:26 INFO - 'USER': 'cltbld', 04:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:26 INFO - 'XPC_FLAGS': '0x0', 04:32:26 INFO - 'XPC_SERVICE_NAME': '0', 04:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:26 INFO - Cleaning up... 04:32:26 INFO - Return code: 0 04:32:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:26 INFO - 'HOME': '/Users/cltbld', 04:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:26 INFO - 'LOGNAME': 'cltbld', 04:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:26 INFO - 'MOZ_NO_REMOTE': '1', 04:32:26 INFO - 'NO_EM_RESTART': '1', 04:32:26 INFO - 'PAGER': '/bin/cat', 04:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:26 INFO - 'PWD': '/builds/slave/test', 04:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:26 INFO - 'SHELL': '/bin/bash', 04:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:26 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:26 INFO - 'USER': 'cltbld', 04:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:26 INFO - 'XPC_FLAGS': '0x0', 04:32:26 INFO - 'XPC_SERVICE_NAME': '0', 04:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:27 INFO - Downloading/unpacking psutil>=3.1.1 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:30 INFO - Installing collected packages: psutil 04:32:30 INFO - Running setup.py install for psutil 04:32:31 INFO - building 'psutil._psutil_osx' extension 04:32:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:32:31 INFO - building 'psutil._psutil_posix' extension 04:32:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:32:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:32 INFO - ^ 04:32:32 INFO - 1 warning generated. 04:32:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:32:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:32 INFO - Successfully installed psutil 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:35 INFO - Installing collected packages: mozsystemmonitor 04:32:35 INFO - Running setup.py install for mozsystemmonitor 04:32:35 INFO - Successfully installed mozsystemmonitor 04:32:35 INFO - Cleaning up... 04:32:35 INFO - Return code: 0 04:32:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:35 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:35 INFO - 'HOME': '/Users/cltbld', 04:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:35 INFO - 'LOGNAME': 'cltbld', 04:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:35 INFO - 'MOZ_NO_REMOTE': '1', 04:32:35 INFO - 'NO_EM_RESTART': '1', 04:32:35 INFO - 'PAGER': '/bin/cat', 04:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:35 INFO - 'PWD': '/builds/slave/test', 04:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:35 INFO - 'SHELL': '/bin/bash', 04:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:35 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:35 INFO - 'USER': 'cltbld', 04:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:35 INFO - 'XPC_FLAGS': '0x0', 04:32:35 INFO - 'XPC_SERVICE_NAME': '0', 04:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:35 INFO - Downloading/unpacking jsonschema==2.5.1 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:38 INFO - warning: no files found matching '*.txt' 04:32:38 INFO - no previously-included directories found matching 'build' 04:32:38 INFO - no previously-included directories found matching 'dist' 04:32:38 INFO - no previously-included directories found matching '.git*' 04:32:38 INFO - Installing collected packages: jsonschema, functools32 04:32:38 INFO - Running setup.py install for functools32 04:32:39 INFO - warning: no files found matching '*.txt' 04:32:39 INFO - no previously-included directories found matching 'build' 04:32:39 INFO - no previously-included directories found matching 'dist' 04:32:39 INFO - no previously-included directories found matching '.git*' 04:32:39 INFO - Successfully installed jsonschema functools32 04:32:39 INFO - Cleaning up... 04:32:39 INFO - Return code: 0 04:32:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:39 INFO - 'HOME': '/Users/cltbld', 04:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:39 INFO - 'LOGNAME': 'cltbld', 04:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:39 INFO - 'MOZ_NO_REMOTE': '1', 04:32:39 INFO - 'NO_EM_RESTART': '1', 04:32:39 INFO - 'PAGER': '/bin/cat', 04:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:39 INFO - 'PWD': '/builds/slave/test', 04:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:39 INFO - 'SHELL': '/bin/bash', 04:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:39 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:39 INFO - 'USER': 'cltbld', 04:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:39 INFO - 'XPC_FLAGS': '0x0', 04:32:39 INFO - 'XPC_SERVICE_NAME': '0', 04:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:39 INFO - Cleaning up... 04:32:39 INFO - Return code: 0 04:32:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:39 INFO - 'HOME': '/Users/cltbld', 04:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:39 INFO - 'LOGNAME': 'cltbld', 04:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:39 INFO - 'MOZ_NO_REMOTE': '1', 04:32:39 INFO - 'NO_EM_RESTART': '1', 04:32:39 INFO - 'PAGER': '/bin/cat', 04:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:39 INFO - 'PWD': '/builds/slave/test', 04:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:39 INFO - 'SHELL': '/bin/bash', 04:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:39 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:39 INFO - 'USER': 'cltbld', 04:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:39 INFO - 'XPC_FLAGS': '0x0', 04:32:39 INFO - 'XPC_SERVICE_NAME': '0', 04:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:43 INFO - Downloading docopt-0.6.1.tar.gz 04:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:43 INFO - Running setup.py install for blobuploader 04:32:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:43 INFO - Running setup.py install for requests 04:32:44 INFO - Running setup.py install for docopt 04:32:44 INFO - Successfully installed blobuploader requests docopt 04:32:44 INFO - Cleaning up... 04:32:44 INFO - Return code: 0 04:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:44 INFO - 'HOME': '/Users/cltbld', 04:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:44 INFO - 'LOGNAME': 'cltbld', 04:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:44 INFO - 'MOZ_NO_REMOTE': '1', 04:32:44 INFO - 'NO_EM_RESTART': '1', 04:32:44 INFO - 'PAGER': '/bin/cat', 04:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:44 INFO - 'PWD': '/builds/slave/test', 04:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:44 INFO - 'SHELL': '/bin/bash', 04:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:44 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:44 INFO - 'USER': 'cltbld', 04:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:44 INFO - 'XPC_FLAGS': '0x0', 04:32:44 INFO - 'XPC_SERVICE_NAME': '0', 04:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LONxQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-56DQ6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-jgmuLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-PjkvAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-2rHa5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-13DwPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-gxEM5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-fuG5r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Ky4xAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Rzk4Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ixVBes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-oxMgLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:46 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-NW8H6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:46 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-NEv2IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:46 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qChPAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:46 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-egI08b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:46 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hTaeKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:46 INFO - Running setup.py install for manifestparser 04:32:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:46 INFO - Running setup.py install for mozcrash 04:32:46 INFO - Running setup.py install for mozdebug 04:32:46 INFO - Running setup.py install for mozdevice 04:32:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Running setup.py install for mozfile 04:32:47 INFO - Running setup.py install for mozhttpd 04:32:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Running setup.py install for mozinfo 04:32:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Running setup.py install for mozInstall 04:32:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Running setup.py install for mozleak 04:32:47 INFO - Running setup.py install for mozlog 04:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for moznetwork 04:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozprocess 04:32:48 INFO - Running setup.py install for mozprofile 04:32:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozrunner 04:32:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozscreenshot 04:32:48 INFO - Running setup.py install for moztest 04:32:48 INFO - Running setup.py install for mozversion 04:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:49 INFO - Cleaning up... 04:32:49 INFO - Return code: 0 04:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:49 INFO - 'HOME': '/Users/cltbld', 04:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PAGER': '/bin/cat', 04:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:49 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - 'XPC_FLAGS': '0x0', 04:32:49 INFO - 'XPC_SERVICE_NAME': '0', 04:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ju88Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8yqUAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-aLnN4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hd_FlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-khlYqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-emvei5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-YW1obD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-icVl6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-R5yndx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vhlnv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-84EIYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SwjoGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nNQNz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-RFHblN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-FKhimT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-wlpvNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-MS_QLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:53 INFO - Downloading blessings-1.6.tar.gz 04:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:53 INFO - Installing collected packages: blessings 04:32:53 INFO - Running setup.py install for blessings 04:32:54 INFO - Successfully installed blessings 04:32:54 INFO - Cleaning up... 04:32:54 INFO - Return code: 0 04:32:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:54 INFO - Reading from file tmpfile_stdout 04:32:54 INFO - Current package versions: 04:32:54 INFO - blessings == 1.6 04:32:54 INFO - blobuploader == 1.2.4 04:32:54 INFO - docopt == 0.6.1 04:32:54 INFO - functools32 == 3.2.3-2 04:32:54 INFO - jsonschema == 2.5.1 04:32:54 INFO - manifestparser == 1.1 04:32:54 INFO - mozInstall == 1.12 04:32:54 INFO - mozcrash == 1.0 04:32:54 INFO - mozdebug == 0.1 04:32:54 INFO - mozdevice == 0.49 04:32:54 INFO - mozfile == 1.2 04:32:54 INFO - mozhttpd == 0.7 04:32:54 INFO - mozinfo == 0.9 04:32:54 INFO - mozleak == 0.1 04:32:54 INFO - mozlog == 3.4 04:32:54 INFO - moznetwork == 0.27 04:32:54 INFO - mozprocess == 0.24 04:32:54 INFO - mozprofile == 0.28 04:32:54 INFO - mozrunner == 6.13 04:32:54 INFO - mozscreenshot == 0.1 04:32:54 INFO - mozsystemmonitor == 0.3 04:32:54 INFO - moztest == 0.8 04:32:54 INFO - mozversion == 1.4 04:32:54 INFO - psutil == 3.1.1 04:32:54 INFO - requests == 1.2.3 04:32:54 INFO - wsgiref == 0.1.2 04:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:54 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:54 INFO - 'HOME': '/Users/cltbld', 04:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:54 INFO - 'LOGNAME': 'cltbld', 04:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:54 INFO - 'MOZ_NO_REMOTE': '1', 04:32:54 INFO - 'NO_EM_RESTART': '1', 04:32:54 INFO - 'PAGER': '/bin/cat', 04:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:54 INFO - 'PWD': '/builds/slave/test', 04:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:54 INFO - 'SHELL': '/bin/bash', 04:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:54 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:54 INFO - 'USER': 'cltbld', 04:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:54 INFO - 'XPC_FLAGS': '0x0', 04:32:54 INFO - 'XPC_SERVICE_NAME': '0', 04:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:54 INFO - Cleaning up... 04:32:54 INFO - Return code: 0 04:32:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:54 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 0x105cd4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaa95bca70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, '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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:54 INFO - 'HOME': '/Users/cltbld', 04:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:54 INFO - 'LOGNAME': 'cltbld', 04:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:54 INFO - 'MOZ_NO_REMOTE': '1', 04:32:54 INFO - 'NO_EM_RESTART': '1', 04:32:54 INFO - 'PAGER': '/bin/cat', 04:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:54 INFO - 'PWD': '/builds/slave/test', 04:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:54 INFO - 'SHELL': '/bin/bash', 04:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:32:54 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:54 INFO - 'USER': 'cltbld', 04:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:54 INFO - 'XPC_FLAGS': '0x0', 04:32:54 INFO - 'XPC_SERVICE_NAME': '0', 04:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:55 INFO - Cleaning up... 04:32:55 INFO - Return code: 0 04:32:55 INFO - Running post-action listener: _resource_record_post_action 04:32:55 INFO - Running post-action listener: _start_resource_monitoring 04:32:55 INFO - Starting resource monitoring. 04:32:55 INFO - [mozharness: 2017-01-17 12:32:55.077556Z] Finished create-virtualenv step (success) 04:32:55 INFO - [mozharness: 2017-01-17 12:32:55.078591Z] Running install step. 04:32:55 INFO - Running pre-action listener: _resource_record_pre_action 04:32:55 INFO - Running main action method: install 04:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:55 INFO - Reading from file tmpfile_stdout 04:32:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:55 INFO - Reading from file tmpfile_stdout 04:32:55 INFO - Output received: 04:32:55 INFO - Usage: mozinstall [options] installer 04:32:55 INFO - Options: 04:32:55 INFO - -h, --help show this help message and exit 04:32:55 INFO - -d DEST, --destination=DEST 04:32:55 INFO - Directory to install application into. [default: 04:32:55 INFO - "/builds/slave/test"] 04:32:55 INFO - --app=APP Application being installed. [default: firefox] 04:32:55 INFO - mkdir: /builds/slave/test/build/application 04:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:17 INFO - Reading from file tmpfile_stdout 04:33:17 INFO - Output received: 04:33:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:33:17 INFO - Running post-action listener: _resource_record_post_action 04:33:17 INFO - [mozharness: 2017-01-17 12:33:17.479613Z] Finished install step (success) 04:33:17 INFO - [mozharness: 2017-01-17 12:33:17.479788Z] Running run-tests step. 04:33:17 INFO - Running pre-action listener: _resource_record_pre_action 04:33:17 INFO - Running main action method: run_tests 04:33:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:17 INFO - 2017-01-17 04:33:17.494 screenresolution[1630:7511] starting screenresolution argv=screenresolution get 04:33:17 INFO - 2017-01-17 04:33:17.496 screenresolution[1630:7511] Display 0: 1600x1200x32@60 04:33:17 INFO - 2017-01-17 04:33:17.502 screenresolution[1631:7514] starting screenresolution argv=screenresolution list 04:33:17 INFO - Available Modes on Display 0 04:33:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:17 INFO - Intel Iris: 04:33:17 INFO - Chipset Model: Intel Iris 04:33:17 INFO - Type: GPU 04:33:17 INFO - Bus: Built-In 04:33:17 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:17 INFO - Vendor: Intel (0x8086) 04:33:17 INFO - Device ID: 0x0a2e 04:33:17 INFO - Revision ID: 0x0009 04:33:17 INFO - Displays: 04:33:17 INFO - Display: 04:33:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:17 INFO - Display Serial Number: 1600x1200 60 04:33:17 INFO - Main Display: Yes 04:33:17 INFO - Mirror: Off 04:33:17 INFO - Online: Yes 04:33:17 INFO - Rotation: Supported 04:33:17 INFO - Return code: 0 04:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:17 INFO - Python 2.7.3 04:33:17 INFO - Return code: 0 04:33:17 INFO - grabbing minidump binary from tooltool 04:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:17 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 0x105ab2d30>, '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 0x1059d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aa7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:33:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:33:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:33:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:17 INFO - Return code: 0 04:33:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H0jgOcuHnw/Render', 04:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:17 INFO - 'HOME': '/Users/cltbld', 04:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:17 INFO - 'LOGNAME': 'cltbld', 04:33:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:17 INFO - 'MOZ_NO_REMOTE': '1', 04:33:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:17 INFO - 'NO_EM_RESTART': '1', 04:33:17 INFO - 'PAGER': '/bin/cat', 04:33:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:17 INFO - 'PWD': '/builds/slave/test', 04:33:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:17 INFO - 'SHELL': '/bin/bash', 04:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f3xhnxwOW6/Listeners', 04:33:17 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 04:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:17 INFO - 'USER': 'cltbld', 04:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:17 INFO - 'XPC_FLAGS': '0x0', 04:33:17 INFO - 'XPC_SERVICE_NAME': '0', 04:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:33:18 INFO - mozversion application_buildid: 20170117030218 04:33:18 INFO - mozversion application_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 04:33:18 INFO - mozversion application_display_name: Nightly 04:33:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:18 INFO - mozversion application_name: Firefox 04:33:18 INFO - mozversion application_remotingname: firefox 04:33:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:18 INFO - mozversion application_vendor: Mozilla 04:33:18 INFO - mozversion application_version: 53.0a1 04:33:18 INFO - mozversion platform_buildid: 20170117030218 04:33:18 INFO - mozversion platform_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 04:33:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:18 INFO - mozversion platform_version: 53.0a1 04:33:18 INFO - using testdate: 1484656398 04:33:18 INFO - actual date: 1484656398 04:33:18 INFO - starting webserver on 'localhost:49235' 04:33:18 INFO - SUITE-START | Running 2 tests 04:33:18 INFO - TEST-START | dromaeo_css 04:33:18 INFO - operating with platform_type : mac_ 04:33:18 INFO - Initialising browser for dromaeo_css test... 04:33:18 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpBZUpUN/profile http://localhost:49235/getInfo.html) 04:33:21 INFO - PROCESS | 1641 | 2017-01-17 04:33:21.124 plugin-container[1644:7680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 04:33:21 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:21 INFO - PROCESS | 1641 | 2017-01-17 04:33:21.125 plugin-container[1644:7680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e1b, name = 'com.apple.CFPasteboardClient' 04:33:21 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:21 INFO - PROCESS | 1641 | 2017-01-17 04:33:21.125 plugin-container[1644:7680] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:33:21 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 04:33:21 INFO - PROCESS | 1641 | colorDepth:24 04:33:21 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 04:33:21 INFO - PROCESS | 1641 | __metrics 04:33:21 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 04:33:21 INFO - TEST-INFO | 1641: exit 0 04:33:21 INFO - Browser initialized. 04:33:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:21 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpBZUpUN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:24 INFO - PROCESS | 1645 | 2017-01-17 04:33:24.426 plugin-container[1646:7802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 04:33:24 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:24 INFO - PROCESS | 1645 | 2017-01-17 04:33:24.427 plugin-container[1646:7802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.CFPasteboardClient' 04:33:24 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:33:24 INFO - PROCESS | 1645 | 2017-01-17 04:33:24.427 plugin-container[1646:7802] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:33:34 INFO - PROCESS | 1645 | RSS: Main: 233938944 04:33:34 INFO - PROCESS | 1645 | 04:36:37 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 04:36:38 INFO - PROCESS | 1645 | RSS: Main: 251224064 04:36:38 INFO - PROCESS | 1645 | 04:38:22 INFO - PROCESS | 1645 | ************************* 04:38:22 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 04:38:22 INFO - PROCESS | 1645 | 04:38:22 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:38:22 INFO - PROCESS | 1645 | Full stack: 04:38:22 INFO - PROCESS | 1645 | ************************* 04:39:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 04:39:42 INFO - PROCESS | 1645 | RSS: Main: 262311936 04:39:42 INFO - PROCESS | 1645 | 04:42:44 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 04:42:44 INFO - PROCESS | 1645 | RSS: Main: 270733312 04:42:44 INFO - PROCESS | 1645 | 04:45:46 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 04:45:47 INFO - PROCESS | 1645 | RSS: Main: 266919936 04:45:47 INFO - PROCESS | 1645 | 04:48:50 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 04:48:50 INFO - PROCESS | 1645 | RSS: Main: 271704064 04:48:50 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 04:51:53 INFO - PROCESS | 1645 | RSS: Main: 277606400 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | __start_tp_report 04:51:53 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 04:51:53 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 04:51:53 INFO - PROCESS | 1645 | |i|pagename|runs| 04:51:53 INFO - PROCESS | 1645 | |0;dojo.html;3248.4640034394324;3312.602487701476;3398.558187435633;3412.7781694189866;3415.1803567143893;5594.384617692051;5597.328320601523;5615.298087739033;5652.689102099388;5691.601587888849;5576.191452239423;5639.830805075844;5685.317761868581;5687.061634830248;5773.220615216955;5095.8216462423825;5182.922256166161;5215.530602245797;5241.371035475749;5255.789768409259;5168.948310516885;5266.262723218733;5272.130098533757;5282.99623071617;5324.92012619811;5067.8986420271385;5095.261187127883;5205.427402985669;5233.319668443097;5245.31810864589;5107.642465027449;5124.128898087334;5135.38375394955;5144.228365745131;5161.329027226474;5132.358455193101;5139.331886854685;5166.302549155854;5179.223116532513;5187.610929180327;4618.35343051973;5251.081060814342;5580.86047848807;5704.2299289595785;5704.458076482769;6026.819195424145;6043.939560604425;6169.7532098716;6194.225721784777;6217.285012223561;6110.892920173631;6139.6454669416935;6157.291911430153;6192.411720886508;6201.6899155042065;5765.164051212592;5806.564507661942;5810.680412577307;5815.04051831443;5837.562182836305;6128.080787881853;6130.141780150782;6206.782762603287;6208.627482351073;6215.720292586754;6040.818775436744;6044.304904935989;6081.513478921675;6084.6349219046115;6112.052631842072;6102.9437319708995;6133.754649813957;6144.754209831646;6145.893739127;6146.524834039798;6058.757649693963;6099.420555047263;6118.680093383066;6128.228138398679;6144.433169541739;6187.876242475125;6216.409441103088;6218.81343559694;6222.844428889223;6223.3465486123305;4503.41455610775;4524.502304746541;4793.592544633675;4970.527799859007;5023.2716256143385;4367.10474352757;4371.890702732394;4393;4396.406485124531;4480.126375356775;5748.19525266463;5758.078707406795;5759.568032397587;5767.423257674199;5775;6116.510679145657;6158.692065396713;6176.073588961692;6186.536009799283;6188.504919606421;5665.544018148926;5692.943070569324;5696.572757043238;5703.429657034263;5720.084786434234;5371.462853714597;5411.458854114557;5428.83713488596;5440.727963601804;5482.753276102585;6249.625022498664;6257.342978987232;6257.4681152102585;6264.34224406449;6279.1209230708655;6076.422739839708;6114.205153330038;6176.938230617816;6192.81421557354;6196.287426945959;6142.98993493194;6143.266246520256;6150.477209437248;6176.166217560572;6281.811545653638;6170;6185.2886918003205;6186.536009799193;6187.133801267736;6212.47193988516;6124.203853499017;6212.565120441525;6219.129321895029;6229.470495007975;6243.469305108935;5103.464136265788;5681.602287839977;5719.828405147852;5798.652080875161;5872.882542349214;6018.729157188025;6088.969555152196;6109.450149486567;6122.265328160649;6124.510039196943;5689.601727879009;5733.140028995684;5771.9134212986;5874.500667443315;5909.497692696169;6043.456088952015;6083.513318934386;6106.2061931948565;6110.847228819137;6139.508839292756;5709.600327977168;5781;5804.796832110856;5934.703264836655;5944.970275148597 04:51:53 INFO - PROCESS | 1645 | |1;ext.html;449.68297350367976;475.643267549338;500.9123403404403;505.41876841632126;508.0296633430147;39712.80143599281;42963;42976.57023429765;45607.31589026167;45620;43913.560864391424;44446;44535.55464445354;44624.776876115575;44786.55213447865;8390.916090839106;8603.913960860375;9209.12513311236;9555.713328600154;9563.569639366211;11120;11459.885401146006;11490.482928268248;11642.476088576035;11648.767024659503;11472.196946213768;11539.48072336747;11555.595554155607;11561.364124973165;11632.825507617392;11444.427778611078;11446.885531144666;11500.482478288497;11505.079593632488;11525.654230373102;11297.039751621121;11335.716607084889;11341.319520828776;11364.374959377232;11372.545098196062;41073.38389924153;41385;41426.37860432096;41451;41477;4005.2590270799706;4044.090079732037;4079.469668943048;4089.284375234352;4168.374743788426;25561.360965975815;28051.0182143624;29667.10998670022;29721.811127554873;29875.850620746758;3113.532970054487;3253;3289.7203737682325;3295.8681652734103;3299.9935019818945;435350;435884.99999999686;435980;438212;438695;57275.28174154782;57677;57717.71141144352;57756.4224357751;57824;60108.699456502436;60519.69740151271;60602.78794424175;60603.09095363573;60764.69617651972;15583;15754.842451575338;15755.291011904492;15797;15809.762853557206;10881.238313317992;11127.610533631447;11989.520419183134;12133.635990920286;12281.631551053482;18173.818261817214;18292.54268643268;18404.26382944694;18481.5379615508;18595.90702046508;7692.653830577638;7765.417593680384;7782.338501227459;7814.179511151361;7845.803854903673;795.8010497375656;866.7486428935538;871.7384784564605;877.2148926710558;893.9106089391139;30269.545956810667;30377.544336834966;30545.389092218033;30723.846380767955;30830.69169308323;1052.4842827014709;1063.989360106389;1102.5589764094427;1105.2539535813455;1185.3480585677842;14827.406903723946;15595.532134035997;15711.21443927799;15919.965202261816;16144;484092;589223;590618;590728;590738;61413.38586614166;62051.379486205464;62056.689716551125;62090.68954655198;62121.689391552754;1407.27525324458;1432.090622454728;1452.2375752729479;1454.3964254834125;1454.5781723300336;28949.276268093465;29329.85335073311;29545.55681664734;30319.242018949702;30697.846510767304;52875.919269284524;53401.198982014525;53494.73252633712;53504.46495534995;53569;418427;422467;422815;424057;424845;26515.33711657224;26862.59706104449;26964.95525671165;27077.59383609208;27250.591241131002;47389;48316.27525587049;48979.510204897495;49054.50945490642;49388.259176113104;36769.816150919076;36793;37930.43104353382;39860.80069599633;40056.1988760229;36104;36499.81750091232;37064.81467592645;37390.25219495649;37424.45096044617;36146.45780313245;36709.63290367169;36779.89660310195;36926;37107;30950.916717914766;31978.84010579932;32893.67106329002;33148.1712957178;33154.50268246027;23517.764822351557;23939.521209576058;24012.75987240175;24306.87846560756;24442.022319107036 04:51:53 INFO - PROCESS | 1645 | |2;jquery.html;380.15415700067354;384.50590990577115;393.7283274540567;395.74078978269233;415.5989470161294;20306.086226119824;20764.896175519138;20879.791202087974;21049.158033678636;21114.366569002916;16204.918975405106;18131;20559.486012849688;21207.68188477174;21457.785422145775;5056.696598204119;5621.634593751393;5635.267415236013;5952.987992041363;6091;5754;5920.171176035358;5926.5258779297765;5973.1040343948325;5988.880222395549;5854.882902341972;5928.584999050068;5929.822105336847;5934;5960.135780311853;5199.792008319662;5715.914261286042;5867.031939729939;5911.876743418737;5924.911126333087;5823.4467725566;5829.533637309048;5831.620944638585;5834.620749651259;5847.736851841677;13488.19070855742;13637.590872273848;13651.249181295025;13667.726645467135;22654.320370388916;2495.987520062406;2522.924312270635;2572.961405578918;2628.8028397870235;2681.36987807865;9947.05502977216;10042.297039207258;10124.34191777532;10171.54228059739;10290.691279261635;1803.1164729282557;1829.815224541056;1862.4133397979592;1865.8414034807058;1871.585654505686;109484.90515094827;131916;137558;137598;139118;11706.590269340531;11709.824352634718;11710.824337634942;11849.703757406134;12058.758824823455;15185;15351.616209594626;15352.30914608823;15364.308606112529;15370.615734606725;8375.664973400995;8543.829123417498;8557.35819813504;8572.185642363966;8660.956695216484;8199.244438225815;8285.25432711059;8434.409591328547;8455.66177352899;8471.830563388698;4628.9537104628525;4704.95295047052;4721.622270218374;4725.196716558194;4769.73766442842;1866.915988780508;1921.2987259650126;1980.0792631426457;2024.5343570978757;2030.4517780199265;930.0652843891845;997.1474389396961;1028.4240825137947;1030.0883717909553;1042.166266986408;21096.367108986757;21406.697472193046;21411.785882141292;21472.78527214739;21645.891770541046;980.181548407088;1054.9683509494728;1060.8514807926897;1091.3342860854873;1096.9341839489657;9320.161185493338;9429.15137637616;10665.680029599125;11237.269577477438;11300.265482743594;678610;693476;693836;701751;716513;126511;148822;150127;150495.24752376167;158571;903.2818908967387;1061.7823346214007;1074.8441475985937;1090.9672709818717;1097.6048622495896;18118;18905.338313159522;18913.810861891205;18914.905425472785;18958.52603684919;48657.99999999858;51413.06400787294;52400.213996790844;58602;60138.79722405615;71077.64461177662;89797;90666;90844.18311633597;90906.09093908976;7618.771436856903;7644.541327520366;8170.101288858102;8326;8467.705702047726;9224.538773061455;11958.461869215733;12325.445354959227;13046.41291141882;13251.337433128498;10145.543450544596;10200.693979180636;10997.230193886351;11294.820916260707;11347.148963827582;9543.952280238555;10887.891121088687;11209.271397359145;11312.15158863105;11465.828012579985;10975.670729878117;11503.252288601214;11584.594539191088;11653.30080195191;11788.4695188715;7099.609521476368;7302.819392478026;7485.401167906663;8201.22088401601;8550.529720865412;8269.875951860606;10033.648822291185;10765.084967777513;11423.971842534213;11628.94185529067 04:51:53 INFO - PROCESS | 1645 | |3;mootools.html;1354.6207062022634;1392.269058744159;1432.1550285331653;1463.458520347471;1470.2648675662172;7476.401887848972;7735.806604834882;8037.638306276217;8428.957855210723;8465.407421480491;7096.609686467255;7927.484713493619;7993.400494962872;8264.752057438287;8321.375896807733;2294.1740973249657;2327.650852372141;2338.988305058472;2346.1671106757112;2353.52929414117;1753.3424965637885;2140.9357719268446;2307.0541078157958;2340.520193360357;2348.3072493614427;2242.2264318809985;2318.2697450303185;2324.4537533679572;2325.069972011192;2337.4506990857135;2292.3380549101853;2307.3424074138957;2315.8263130265295;2316.953660926789;2318.0148436914415;2279.680844681746;2296.0586159674453;2342.367560758603;2355.258093700496;2359.044586942291;7281.599512026836;8411.158884111539;8412.495250285003;8430.704925327645;8435.789105272355;4978.6763860348965;5126.051680439094;5142.871428214287;5155.40712818027;5161.458046905059;2932.692067332942;3228.5872522815203;3293.1931676739114;3329.1356840169583;3408.812515311657;1168.2056201782784;1195.557643671847;1240.7890658587971;1250.662321173278;1260.85500167481;10561.102306303974;10674;10723.03492685662;10731.356118632906;10734.516946737338;4343.413639158736;4653.674242802971;4707.693999889996;4721.291806229025;4724.173269677793;8240.340772738167;9398.624055037859;9420.434773913586;9437.150656440816;9445.716628501155;5196.038732834438;5211.5830733541225;5213.661112027706;5220.451852555503;5232.1628539433505;4281.892952676208;4484.215262329079;4699.859004229878;4781.593564546983;4812.109759694467;3603.990882552889;3631.5655316149973;3855.248226595843;3890.16361482277;3936.7441116327345;1180.8819118088295;1224.5163160551533;1267.3916520070234;1291.4317700211877;1295.9157654752412;777.8560966221268;853.1553761775797;871.0375035585713;910.9590068446936;926.4811705444972;5171;5301.098813201765;5439.211314359396;5578.525825304894;5650.237217975603;931.7577429868284;950.5437390052813;991.1723710701501;991.4249735153594;998.201438848918;3472.585506813153;3708.2398108387715;3758.9436158457647;3775.7356985010783;3792.924141517154;9471.715848524555;9839.852402213972;9882.703518894445;9983.450910200008;10000.199984001409;9758.75603109928;9939.950300248453;9943.850842237372;9958.103770660675;9970.351927124713;7637.394778849708;7886.3296619786815;7894.526328420313;7967.681292748225;7988.520688758693;5354.732263386737;5380.1391777317;5408.405075441777;5531.225628411945;5545.556355491471;8993.28053755711;9026.819463610822;9028.09719028092;9133.497657628894;9178.770530736518;8940.46357218569;9149.359544831797;9197.356185067249;9327.58025888823;9366.95316523413;6628.5691430056895;6850.280720524273;6856.588604683735;6861.279565645735;6880.4839637026425;7606.315431611181;7609.086909570887;7682.078150621961;7699.6535155917;7721.266479684421;6108.205933228652;7055.153381594037;7141.607211603412;7201.3518783309755;7205.423566114803;7088.184858741104;7108.07595012645;7112.217656057933;7197.676104575411;7224.422046236394;6264.31092579825;6283.968580157253;6331.493480521455;6336.904946425715;6339.4928405726505;4836.226203807374;4942.975285123552;4978.8755281118265;5009.474005229544;5160.509751573594;4947.975260123676;4994.101061808909;4996.450390457119;5007.574356179765;5129.999650068201 04:51:53 INFO - PROCESS | 1645 | |4;prototype.html;319.6739325887595;358.21372088266247;365.94510823376504;370.0655843993916;377.9943300850488;4407.699728580069;4514.97742511287;5496.642718223317;5583.38582755897;5591.608587398884;4714.9528504714945;5309.982206761425;5383.407825139241;5450.91823622646;5530.557555395569;3926.685865130797;4250.723702959313;4284.564670835274;4311.9784401078105;4318.5033721122;3938.6258305460933;4084.9591504084874;4323.459567554056;4326.52898014675;4327.156204540116;3359.4792807114936;3702.4446333049987;4073;4073.9592604074023;4085.2238074765846;4099.323611604082;4100.487439070132;4121.5466298707115;4146.5853414658595;4148.983499042723;3194.9456679295777;3552.3428165789155;3580.373434648926;3583.3191693578137;3588.946165807515;4513.909721805546;4973.303737476756;5300;5302.681839089629;5317.867053323659;4354.346847972798;4710.717356958594;4723.354921244114;4724.76376181193;4755.286706993944;5267.157254839208;5362.570994320445;5745.885082298372;5784.595078344518;5849.970750146222;3106.8135911845134;3401.9659803401896;3920.843166273374;3932.744371615836;3934.7048971327263;5691.658500489983;5790.478856902899;6062.211912451353;6063.060225665029;6074.939250607482;3683.834227459771;3958.416633346627;4004.5383435045997;4020.8391664333685;4023.3562629979065;3890.630390112935;4019.352065653127;4034.2334956358786;4042.171354872303;4048.595140485928;4004.778542544552;4540.954590454053;4621.445426548836;4745.240761478147;4761.357216775691;4907.460179380337;5428.131498960148;5874.676892770939;5908.615939963888;5929.169916211734;1215.295128825279;1227.5948936850818;1262.450833887262;1286.2668279081022;1302.417562661371;770.4183341577074;820.3806126374668;885.203317014692;888.7244954064261;889.5589145584195;4375.431193944767;5144.074066668036;5168.405633352138;5183.352080989876;5220.973895130576;4720;5496.790706044664;5666.716664166775;5667.659940403589;5682.573806964494;4535.027263140544;4934.634146341464;5048.747562621854;5050.84847454577;5165.819196328111;2727.368089793359;2935.7944943854154;2955.788126867974;2998.220462679719;3006.3085490337344;5354.500739792787;5516.613837031369;5898.64608123514;5904.431572266078;5931.703414829241;4840.177169881058;5337.332833395825;5424.9421362834655;5461.1262198048125;5901.970490147522;4837.419509658793;4907.558319751168;5593.636413633101;5639.746211420496;5727.453587531343;5152.742362881916;5650.739704118386;5653.3781284057895;5655;5664.555538337698;5041.571466425395;5258.2375555544995;5435.755391007335;5962.2249107615735;5981.9401805983125;5074.391073071255;6174.938250617616;6187.504999599932;6195.535334849814;6246.625202487865;3660.871869484555;4150.979245103756;4332.935005974976;4333.674974376871;4343.2182207203;5007.7746501408255;5083.644144909821;5289.973550132225;5290.709011004432;5705.942940570541;5047.470015648304;5052.72210028452;5245.186996015624;5457.045017121908;5802.303723553201;5610.943890561042;5706.058500347396;5769.480746732815;5795.449432303924;5808.94191058084;5096.949030509648;5312.521873031291;5360.552650784189;5468.45716741717;5750.654960702372;5377.924415116914;5517.503424691637;5699.7435115419075;5781.479666830005;5816.883662326814;5449.836504904859;5484.451554844483;5661.377248502744;5661.830145095653;5684.658920464785 04:51:53 INFO - PROCESS | 1645 | |5;yui.html;697.2365260040254;700.6636814329119;752.7327798631486;802.7270727952496;853.0701535326493;14436.989410741253;14788.40846366144;14805.851941480596;14834.03578767382;14863.702725945488;11747.41262936854;14474.5657630271;14521.49174778883;15567.29947152378;16072;848.5290663681669;886.8226354729047;887.6094518411878;888.1739981816908;888.5113187746746;805.5649949027518;884.9159329863653;895.3911340288602;896.0278098263392;899.6491368366343;904.9864252036225;943.2972435535536;943.8112377524488;945.3335398544044;946.2004606107862;933.6265493802465;938.9530523473833;940.9529523523796;942.2650332740508;953.823542644606;694.0942070597868;702.115334678304;704.0495331302751;704.2781149321986;704.8237940514871;15310.311036003295;15711;15736.763948540782;15744.370225190978;16017;13933.721325573533;14181.645458863612;14218.573442796733;14220.431182752678;14231.217283049427;11815.113866459964;11817.527298908033;11837.82243266343;11850.644480665507;11867.94066029673;3687.631236876318;3698.944515832238;3725.795081270529;3747.9437808432895;3827.5215598050245;92930.5353473235;94512.52743736237;103007;105716.56686626746;109058.45470772675;9209.815803684023;11187.664370068911;11194.888051119548;11346.773064538827;11482.368469734245;21592;21831;21845;21860.23489177903;21935.232266870902;6875.828104297332;7856.921430785734;8163.346932245406;8166.550839703873;8191;3783.829727662262;4369.497507786582;4406.911861762811;4575.3823233863;4575.450945886515;3162.3201011782576;3560.661737134968;3627.510286111341;3658.5975542690285;3660.743747937672;602.9638221706624;668.3283300283184;670.7082419147687;673.7473447457204;682.6586706646676;630.3003665930813;682.5699809120223;697.285282585354;709.6877373955443;720.4020662849822;8448.831023379498;9696.70909872705;10314.484275786332;10412.375257484424;11230;577.9569222797392;606.1090197409801;615.3354377272624;637.346719612401;678.6844117485393;4437.223485890021;4922;4994.950050499521;5004.199328107486;5020.3724534433195;98025;99702.50148749354;99908.00091999132;100424;100564.4971775151;87564;88091;88724.5563772177;89211;89500;68067.31932680709;68634.65682671555;75376.62311688406;76563.85154222691;77375;9977.401355918668;10312.175025997753;10537.789244215226;10945.674845557094;11269.323840569592;49629;50745.23882141697;51331.486685134165;52006.479935200165;52921;71033.64483177551;74109.25890741023;74589;74752;75696.24303756891;12812.55156069533;12876.871231287567;12950.287734174712;12963.41664625113;13286.050594525437;14279.928600356932;14506.1296322221;14541;14772.63068423298;14787.556373308818;13323.200607963554;13414.12808167466;13444.596662100153;14152.080114792505;14154.221517816619;13228;13428.462861485432;13653.931730341284;13910.652233693834;13995.230262335263;11352.432378380883;12976.221426714428;13184.538541151014;13633.522826701017;13697.356317241596;10541.736456588647;10881.238313318308;11060.557577696802;11363.602273920704;11404.372759498307;9863.556139973862;10890.128789696964;10901.727456813644;10915.836262456229;10925.726856828644 04:51:53 INFO - PROCESS | 1645 | __end_tp_report 04:51:53 INFO - PROCESS | 1645 | __start_cc_report 04:51:53 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,386 04:51:53 INFO - PROCESS | 1645 | __end_cc_report 04:51:53 INFO - PROCESS | 1645 | __startTimestamp1484657513829__endTimestamp 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | ------- Summary: start ------- 04:51:53 INFO - PROCESS | 1645 | Number of tests: 6 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5679.42 Median:5810.68 stddev:632.37 (10.9%) stddev-sans-first:604.87 04:51:53 INFO - PROCESS | 1645 | Values: 3248.5 3312.6 3398.6 3412.8 3415.2 5594.4 5597.3 5615.3 5652.7 5691.6 5576.2 5639.8 5685.3 5687.1 5773.2 5095.8 5182.9 5215.5 5241.4 5255.8 5168.9 5266.3 5272.1 5283.0 5324.9 5067.9 5095.3 5205.4 5233.3 5245.3 5107.6 5124.1 5135.4 5144.2 5161.3 5132.4 5139.3 5166.3 5179.2 5187.6 4618.4 5251.1 5580.9 5704.2 5704.5 6026.8 6043.9 6169.8 6194.2 6217.3 6110.9 6139.6 6157.3 6192.4 6201.7 5765.2 5806.6 5810.7 5815.0 5837.6 6128.1 6130.1 6206.8 6208.6 6215.7 6040.8 6044.3 6081.5 6084.6 6112.1 6102.9 6133.8 6144.8 6145.9 6146.5 6058.8 6099.4 6118.7 6128.2 6144.4 6187.9 6216.4 6218.8 6222.8 6223.3 4503.4 4524.5 4793.6 4970.5 5023.3 4367.1 4371.9 4393.0 4396.4 4480.1 5748.2 5758.1 5759.6 5767.4 5775.0 6116.5 6158.7 6176.1 6186.5 6188.5 5665.5 5692.9 5696.6 5703.4 5720.1 5371.5 5411.5 5428.8 5440.7 5482.8 6249.6 6257.3 6257.5 6264.3 6279.1 6076.4 6114.2 6176.9 6192.8 6196.3 6143.0 6143.3 6150.5 6176.2 6281.8 6170.0 6185.3 6186.5 6187.1 6212.5 6124.2 6212.6 6219.1 6229.5 6243.5 5103.5 5681.6 5719.8 5798.7 5872.9 6018.7 6089.0 6109.5 6122.3 6124.5 5689.6 5733.1 5771.9 5874.5 5909.5 6043.5 6083.5 6106.2 6110.8 6139.5 5709.6 5781.0 5804.8 5934.7 5945.0 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:62758.70 Median:36786.45 stddev:127903.81 (347.7%) stddev-sans-first:128177.05 04:51:53 INFO - PROCESS | 1645 | Values: 449.7 475.6 500.9 505.4 508.0 39712.8 42963.0 42976.6 45607.3 45620.0 43913.6 44446.0 44535.6 44624.8 44786.6 8390.9 8603.9 9209.1 9555.7 9563.6 11120.0 11459.9 11490.5 11642.5 11648.8 11472.2 11539.5 11555.6 11561.4 11632.8 11444.4 11446.9 11500.5 11505.1 11525.7 11297.0 11335.7 11341.3 11364.4 11372.5 41073.4 41385.0 41426.4 41451.0 41477.0 4005.3 4044.1 4079.5 4089.3 4168.4 25561.4 28051.0 29667.1 29721.8 29875.9 3113.5 3253.0 3289.7 3295.9 3300.0 435350.0 435885.0 435980.0 438212.0 438695.0 57275.3 57677.0 57717.7 57756.4 57824.0 60108.7 60519.7 60602.8 60603.1 60764.7 15583.0 15754.8 15755.3 15797.0 15809.8 10881.2 11127.6 11989.5 12133.6 12281.6 18173.8 18292.5 18404.3 18481.5 18595.9 7692.7 7765.4 7782.3 7814.2 7845.8 795.8 866.7 871.7 877.2 893.9 30269.5 30377.5 30545.4 30723.8 30830.7 1052.5 1064.0 1102.6 1105.3 1185.3 14827.4 15595.5 15711.2 15920.0 16144.0 484092.0 589223.0 590618.0 590728.0 590738.0 61413.4 62051.4 62056.7 62090.7 62121.7 1407.3 1432.1 1452.2 1454.4 1454.6 28949.3 29329.9 29545.6 30319.2 30697.8 52875.9 53401.2 53494.7 53504.5 53569.0 418427.0 422467.0 422815.0 424057.0 424845.0 26515.3 26862.6 26965.0 27077.6 27250.6 47389.0 48316.3 48979.5 49054.5 49388.3 36769.8 36793.0 37930.4 39860.8 40056.2 36104.0 36499.8 37064.8 37390.3 37424.5 36146.5 36709.6 36779.9 36926.0 37107.0 30950.9 31978.8 32893.7 33148.2 33154.5 23517.8 23939.5 24012.8 24306.9 24442.0 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:38646.06 Median:21434.79 stddev:116403.50 (543.1%) stddev-sans-first:116694.58 04:51:53 INFO - PROCESS | 1645 | Values: 380.2 384.5 393.7 395.7 415.6 20306.1 20764.9 20879.8 21049.2 21114.4 16204.9 18131.0 20559.5 21207.7 21457.8 5056.7 5621.6 5635.3 5953.0 6091.0 5754.0 5920.2 5926.5 5973.1 5988.9 5854.9 5928.6 5929.8 5934.0 5960.1 5199.8 5715.9 5867.0 5911.9 5924.9 5823.4 5829.5 5831.6 5834.6 5847.7 13488.2 13637.6 13651.2 13667.7 22654.3 2496.0 2522.9 2573.0 2628.8 2681.4 9947.1 10042.3 10124.3 10171.5 10290.7 1803.1 1829.8 1862.4 1865.8 1871.6 109484.9 131916.0 137558.0 137598.0 139118.0 11706.6 11709.8 11710.8 11849.7 12058.8 15185.0 15351.6 15352.3 15364.3 15370.6 8375.7 8543.8 8557.4 8572.2 8661.0 8199.2 8285.3 8434.4 8455.7 8471.8 4629.0 4705.0 4721.6 4725.2 4769.7 1866.9 1921.3 1980.1 2024.5 2030.5 930.1 997.1 1028.4 1030.1 1042.2 21096.4 21406.7 21411.8 21472.8 21645.9 980.2 1055.0 1060.9 1091.3 1096.9 9320.2 9429.2 10665.7 11237.3 11300.3 678610.0 693476.0 693836.0 701751.0 716513.0 126511.0 148822.0 150127.0 150495.2 158571.0 903.3 1061.8 1074.8 1091.0 1097.6 18118.0 18905.3 18913.8 18914.9 18958.5 48658.0 51413.1 52400.2 58602.0 60138.8 71077.6 89797.0 90666.0 90844.2 90906.1 7618.8 7644.5 8170.1 8326.0 8467.7 9224.5 11958.5 12325.4 13046.4 13251.3 10145.5 10200.7 10997.2 11294.8 11347.1 9544.0 10887.9 11209.3 11312.2 11465.8 10975.7 11503.3 11584.6 11653.3 11788.5 7099.6 7302.8 7485.4 8201.2 8550.5 8269.9 10033.6 10765.1 11424.0 11628.9 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5365.27 Median:5226.31 stddev:2908.48 (55.7%) stddev-sans-first:2901.02 04:51:53 INFO - PROCESS | 1645 | Values: 1354.6 1392.3 1432.2 1463.5 1470.3 7476.4 7735.8 8037.6 8429.0 8465.4 7096.6 7927.5 7993.4 8264.8 8321.4 2294.2 2327.7 2339.0 2346.2 2353.5 1753.3 2140.9 2307.1 2340.5 2348.3 2242.2 2318.3 2324.5 2325.1 2337.5 2292.3 2307.3 2315.8 2317.0 2318.0 2279.7 2296.1 2342.4 2355.3 2359.0 7281.6 8411.2 8412.5 8430.7 8435.8 4978.7 5126.1 5142.9 5155.4 5161.5 2932.7 3228.6 3293.2 3329.1 3408.8 1168.2 1195.6 1240.8 1250.7 1260.9 10561.1 10674.0 10723.0 10731.4 10734.5 4343.4 4653.7 4707.7 4721.3 4724.2 8240.3 9398.6 9420.4 9437.2 9445.7 5196.0 5211.6 5213.7 5220.5 5232.2 4281.9 4484.2 4699.9 4781.6 4812.1 3604.0 3631.6 3855.2 3890.2 3936.7 1180.9 1224.5 1267.4 1291.4 1295.9 777.9 853.2 871.0 911.0 926.5 5171.0 5301.1 5439.2 5578.5 5650.2 931.8 950.5 991.2 991.4 998.2 3472.6 3708.2 3758.9 3775.7 3792.9 9471.7 9839.9 9882.7 9983.5 10000.2 9758.8 9940.0 9943.9 9958.1 9970.4 7637.4 7886.3 7894.5 7967.7 7988.5 5354.7 5380.1 5408.4 5531.2 5545.6 8993.3 9026.8 9028.1 9133.5 9178.8 8940.5 9149.4 9197.4 9327.6 9367.0 6628.6 6850.3 6856.6 6861.3 6880.5 7606.3 7609.1 7682.1 7699.7 7721.3 6108.2 7055.2 7141.6 7201.4 7205.4 7088.2 7108.1 7112.2 7197.7 7224.4 6264.3 6284.0 6331.5 6336.9 6339.5 4836.2 4943.0 4978.9 5009.5 5160.5 4948.0 4994.1 4996.5 5007.6 5130.0 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4577.00 Median:5090.30 stddev:1392.70 (27.4%) stddev-sans-first:1359.46 04:51:53 INFO - PROCESS | 1645 | Values: 319.7 358.2 365.9 370.1 378.0 4407.7 4515.0 5496.6 5583.4 5591.6 4715.0 5310.0 5383.4 5450.9 5530.6 3926.7 4250.7 4284.6 4312.0 4318.5 3938.6 4085.0 4323.5 4326.5 4327.2 3359.5 3702.4 4073.0 4074.0 4085.2 4099.3 4100.5 4121.5 4146.6 4149.0 3194.9 3552.3 3580.4 3583.3 3588.9 4513.9 4973.3 5300.0 5302.7 5317.9 4354.3 4710.7 4723.4 4724.8 4755.3 5267.2 5362.6 5745.9 5784.6 5850.0 3106.8 3402.0 3920.8 3932.7 3934.7 5691.7 5790.5 6062.2 6063.1 6074.9 3683.8 3958.4 4004.5 4020.8 4023.4 3890.6 4019.4 4034.2 4042.2 4048.6 4004.8 4541.0 4621.4 4745.2 4761.4 4907.5 5428.1 5874.7 5908.6 5929.2 1215.3 1227.6 1262.5 1286.3 1302.4 770.4 820.4 885.2 888.7 889.6 4375.4 5144.1 5168.4 5183.4 5221.0 4720.0 5496.8 5666.7 5667.7 5682.6 4535.0 4934.6 5048.7 5050.8 5165.8 2727.4 2935.8 2955.8 2998.2 3006.3 5354.5 5516.6 5898.6 5904.4 5931.7 4840.2 5337.3 5424.9 5461.1 5902.0 4837.4 4907.6 5593.6 5639.7 5727.5 5152.7 5650.7 5653.4 5655.0 5664.6 5041.6 5258.2 5435.8 5962.2 5981.9 5074.4 6174.9 6187.5 6195.5 6246.6 3660.9 4151.0 4332.9 4333.7 4343.2 5007.8 5083.6 5290.0 5290.7 5705.9 5047.5 5052.7 5245.2 5457.0 5802.3 5610.9 5706.1 5769.5 5795.4 5808.9 5096.9 5312.5 5360.6 5468.5 5750.7 5377.9 5517.5 5699.7 5781.5 5816.9 5449.8 5484.5 5661.4 5661.8 5684.7 04:51:53 INFO - PROCESS | 1645 | 04:51:53 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20367.36 Median:4098.51 stddev:28818.91 (703.2%) stddev-sans-first:28861.90 04:51:53 INFO - PROCESS | 1645 | Values: 697.2 700.7 752.7 802.7 853.1 14437.0 14788.4 14805.9 14834.0 14863.7 11747.4 14474.6 14521.5 15567.3 16072.0 848.5 886.8 887.6 888.2 888.5 805.6 884.9 895.4 896.0 899.6 905.0 943.3 943.8 945.3 946.2 933.6 939.0 941.0 942.3 953.8 694.1 702.1 704.0 704.3 704.8 15310.3 15711.0 15736.8 15744.4 16017.0 13933.7 14181.6 14218.6 14220.4 14231.2 11815.1 11817.5 11837.8 11850.6 11867.9 3687.6 3698.9 3725.8 3747.9 3827.5 92930.5 94512.5 103007.0 105716.6 109058.5 9209.8 11187.7 11194.9 11346.8 11482.4 21592.0 21831.0 21845.0 21860.2 21935.2 6875.8 7856.9 8163.3 8166.6 8191.0 3783.8 4369.5 4406.9 4575.4 4575.5 3162.3 3560.7 3627.5 3658.6 3660.7 603.0 668.3 670.7 673.7 682.7 630.3 682.6 697.3 709.7 720.4 8448.8 9696.7 10314.5 10412.4 11230.0 578.0 606.1 615.3 637.3 678.7 4437.2 4922.0 4995.0 5004.2 5020.4 98025.0 99702.5 99908.0 100424.0 100564.5 87564.0 88091.0 88724.6 89211.0 89500.0 68067.3 68634.7 75376.6 76563.9 77375.0 9977.4 10312.2 10537.8 10945.7 11269.3 49629.0 50745.2 51331.5 52006.5 52921.0 71033.6 74109.3 74589.0 74752.0 75696.2 12812.6 12876.9 12950.3 12963.4 13286.1 14279.9 14506.1 14541.0 14772.6 14787.6 13323.2 13414.1 13444.6 14152.1 14154.2 13228.0 13428.5 13653.9 13910.7 13995.2 11352.4 12976.2 13184.5 13633.5 13697.4 10541.7 10881.2 11060.6 11363.6 11404.4 9863.6 10890.1 10901.7 10915.8 10925.7 04:51:53 INFO - PROCESS | 1645 | -------- Summary: end -------- 04:51:53 INFO - PROCESS | 1645 | 04:51:54 INFO - TEST-INFO | 1645: exit 0 04:51:54 INFO - TEST-OK | dromaeo_css | took 1116419ms 04:51:54 INFO - TEST-START | kraken 04:51:54 INFO - operating with platform_type : mac_ 04:51:54 INFO - Initialising browser for kraken test... 04:51:54 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpzsJWL7/profile http://localhost:49235/getInfo.html) 04:51:57 INFO - PROCESS | 1654 | 2017-01-17 04:51:57.312 plugin-container[1656:10100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 04:51:57 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:57 INFO - PROCESS | 1654 | 2017-01-17 04:51:57.313 plugin-container[1656:10100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 04:51:57 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:57 INFO - PROCESS | 1654 | 2017-01-17 04:51:57.313 plugin-container[1656:10100] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:51:57 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 04:51:57 INFO - PROCESS | 1654 | colorDepth:24 04:51:57 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 04:51:57 INFO - PROCESS | 1654 | __metrics 04:51:57 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 04:51:58 INFO - TEST-INFO | 1654: exit 0 04:51:58 INFO - Browser initialized. 04:51:58 INFO - Running cycle 1/1 for kraken test... 04:51:58 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpzsJWL7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:00 INFO - PROCESS | 1657 | 2017-01-17 04:52:00.648 plugin-container[1658:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 04:52:00 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:00 INFO - PROCESS | 1657 | 2017-01-17 04:52:00.649 plugin-container[1658:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:52:00 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:00 INFO - PROCESS | 1657 | 2017-01-17 04:52:00.649 plugin-container[1658:10215] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:52:10 INFO - PROCESS | 1657 | RSS: Main: 233545728 04:52:10 INFO - PROCESS | 1657 | 04:52:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:14 INFO - PROCESS | 1657 | RSS: Main: 246362112 04:52:14 INFO - PROCESS | 1657 | 04:52:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 04:52:17 INFO - PROCESS | 1657 | RSS: Main: 254443520 04:52:17 INFO - PROCESS | 1657 | 04:52:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 04:52:21 INFO - PROCESS | 1657 | RSS: Main: 257142784 04:52:21 INFO - PROCESS | 1657 | 04:52:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 04:52:24 INFO - PROCESS | 1657 | RSS: Main: 258297856 04:52:24 INFO - PROCESS | 1657 | 04:52:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:26 INFO - PROCESS | 1657 | RSS: Main: 258584576 04:52:26 INFO - PROCESS | 1657 | 04:52:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:30 INFO - PROCESS | 1657 | RSS: Main: 263831552 04:52:30 INFO - PROCESS | 1657 | 04:52:33 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:33 INFO - PROCESS | 1657 | RSS: Main: 263630848 04:52:33 INFO - PROCESS | 1657 | 04:52:36 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 04:52:37 INFO - PROCESS | 1657 | RSS: Main: 263540736 04:52:37 INFO - PROCESS | 1657 | 04:52:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:39 INFO - PROCESS | 1657 | RSS: Main: 263032832 04:52:39 INFO - PROCESS | 1657 | 04:52:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:42 INFO - PROCESS | 1657 | RSS: Main: 264519680 04:52:42 INFO - PROCESS | 1657 | 04:52:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:45 INFO - PROCESS | 1657 | RSS: Main: 264372224 04:52:45 INFO - PROCESS | 1657 | 04:52:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:48 INFO - PROCESS | 1657 | RSS: Main: 264560640 04:52:48 INFO - PROCESS | 1657 | 04:52:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:52 INFO - PROCESS | 1657 | RSS: Main: 264753152 04:52:52 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 04:52:54 INFO - PROCESS | 1657 | RSS: Main: 266829824 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | __start_tp_report 04:52:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 04:52:54 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 04:52:54 INFO - PROCESS | 1657 | |i|pagename|runs| 04:52:54 INFO - PROCESS | 1657 | |0;ai-astar;105;113;118;116;118;118;116;118;117;121 04:52:54 INFO - PROCESS | 1657 | |1;audio-beat-detection;145;114;114;150;98;138;135;141;147;112 04:52:54 INFO - PROCESS | 1657 | |2;audio-dft;203;200;219;201;196;197;199;220;206;279 04:52:54 INFO - PROCESS | 1657 | |3;audio-fft;83;58;57;82;60;59;58;60;72;59 04:52:54 INFO - PROCESS | 1657 | |4;audio-oscillator;88;71;83;72;69;70;80;74;99;108 04:52:54 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;91;81;130;120;92;112;129;124;90;89 04:52:54 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;98;123;95;98;105;146;115;97;97 04:52:54 INFO - PROCESS | 1657 | |7;imaging-desaturate;88;95;94;93;93;92;92;93;123;91 04:52:54 INFO - PROCESS | 1657 | |8;json-parse-financial;62;61;61;61;61;62;62;62;62;62 04:52:54 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;68;72;74;82;75;71;72;71;86;99 04:52:54 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;87;88;93;88;93;86;88;101;109;86 04:52:54 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;138;140;140;138;153;177;152;154;203;150 04:52:54 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;175;174;181;173;173;174;175;185;201;177 04:52:54 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;67;69;69;68;69;67;70;65;68;67 04:52:54 INFO - PROCESS | 1657 | __end_tp_report 04:52:54 INFO - PROCESS | 1657 | __start_cc_report 04:52:54 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,923 04:52:54 INFO - PROCESS | 1657 | __end_cc_report 04:52:54 INFO - PROCESS | 1657 | __startTimestamp1484657574332__endTimestamp 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | ------- Summary: start ------- 04:52:54 INFO - PROCESS | 1657 | Number of tests: 14 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:116.00 Median:118.00 stddev:4.37 (3.7%) stddev-sans-first:2.17 04:52:54 INFO - PROCESS | 1657 | Values: 105.0 113.0 118.0 116.0 118.0 118.0 116.0 118.0 117.0 121.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:143.00 stddev:18.20 (12.7%) stddev-sans-first:18.41 04:52:54 INFO - PROCESS | 1657 | Values: 145.0 114.0 114.0 150.0 98.0 138.0 135.0 141.0 147.0 112.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:212.00 Median:204.50 stddev:25.02 (12.2%) stddev-sans-first:26.32 04:52:54 INFO - PROCESS | 1657 | Values: 203.0 200.0 219.0 201.0 196.0 197.0 199.0 220.0 206.0 279.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.00 stddev:10.25 (17.1%) stddev-sans-first:8.50 04:52:54 INFO - PROCESS | 1657 | Values: 83.0 58.0 57.0 82.0 60.0 59.0 58.0 60.0 72.0 59.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:77.00 stddev:13.33 (17.3%) stddev-sans-first:13.93 04:52:54 INFO - PROCESS | 1657 | Values: 88.0 71.0 83.0 72.0 69.0 70.0 80.0 74.0 99.0 108.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:105.80 Median:85.00 stddev:19.01 (22.4%) stddev-sans-first:19.39 04:52:54 INFO - PROCESS | 1657 | Values: 91.0 81.0 130.0 120.0 92.0 112.0 129.0 124.0 90.0 89.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:97.00 stddev:16.50 (17.0%) stddev-sans-first:17.09 04:52:54 INFO - PROCESS | 1657 | Values: 97.0 98.0 123.0 95.0 98.0 105.0 146.0 115.0 97.0 97.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:93.00 stddev:9.88 (10.6%) stddev-sans-first:10.11 04:52:54 INFO - PROCESS | 1657 | Values: 88.0 95.0 94.0 93.0 93.0 92.0 92.0 93.0 123.0 91.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:52:54 INFO - PROCESS | 1657 | Values: 62.0 61.0 61.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:74.50 stddev:9.46 (12.7%) stddev-sans-first:9.46 04:52:54 INFO - PROCESS | 1657 | Values: 68.0 72.0 74.0 82.0 75.0 71.0 72.0 71.0 86.0 99.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:88.00 stddev:7.58 (8.6%) stddev-sans-first:7.83 04:52:54 INFO - PROCESS | 1657 | Values: 87.0 88.0 93.0 88.0 93.0 86.0 88.0 101.0 109.0 86.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:152.50 stddev:20.69 (13.6%) stddev-sans-first:21.07 04:52:54 INFO - PROCESS | 1657 | Values: 138.0 140.0 140.0 138.0 153.0 177.0 152.0 154.0 203.0 150.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:176.00 stddev:8.70 (4.9%) stddev-sans-first:9.12 04:52:54 INFO - PROCESS | 1657 | Values: 175.0 174.0 181.0 173.0 173.0 174.0 175.0 185.0 201.0 177.0 04:52:54 INFO - PROCESS | 1657 | 04:52:54 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.45 (2.1%) stddev-sans-first:1.50 04:52:54 INFO - PROCESS | 1657 | Values: 67.0 69.0 69.0 68.0 69.0 67.0 70.0 65.0 68.0 67.0 04:52:54 INFO - PROCESS | 1657 | -------- Summary: end -------- 04:52:54 INFO - PROCESS | 1657 | 04:52:55 INFO - TEST-INFO | 1657: exit 0 04:52:55 INFO - TEST-OK | kraken | took 60728ms 04:52:55 INFO - SUITE-END | took 1177s 04:52:55 INFO - Completed test suite (00:19:37) 04:52:55 INFO - javascript benchmark 04:52:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7287.248778515198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.4640034394324, 3312.602487701476, 3398.558187435633, 3412.7781694189866, 3415.1803567143893, 5594.384617692051, 5597.328320601523, 5615.298087739033, 5652.689102099388, 5691.601587888849, 5576.191452239423, 5639.830805075844, 5685.317761868581, 5687.061634830248, 5773.220615216955, 5095.8216462423825, 5182.922256166161, 5215.530602245797, 5241.371035475749, 5255.789768409259, 5168.948310516885, 5266.262723218733, 5272.130098533757, 5282.99623071617, 5324.92012619811, 5067.8986420271385, 5095.261187127883, 5205.427402985669, 5233.319668443097, 5245.31810864589, 5107.642465027449, 5124.128898087334, 5135.38375394955, 5144.228365745131, 5161.329027226474, 5132.358455193101, 5139.331886854685, 5166.302549155854, 5179.223116532513, 5187.610929180327, 4618.35343051973, 5251.081060814342, 5580.86047848807, 5704.2299289595785, 5704.458076482769, 6026.819195424145, 6043.939560604425, 6169.7532098716, 6194.225721784777, 6217.285012223561, 6110.892920173631, 6139.6454669416935, 6157.291911430153, 6192.411720886508, 6201.6899155042065, 5765.164051212592, 5806.564507661942, 5810.680412577307, 5815.04051831443, 5837.562182836305, 6128.080787881853, 6130.141780150782, 6206.782762603287, 6208.627482351073, 6215.720292586754, 6040.818775436744, 6044.304904935989, 6081.513478921675, 6084.6349219046115, 6112.052631842072, 6102.9437319708995, 6133.754649813957, 6144.754209831646, 6145.893739127, 6146.524834039798, 6058.757649693963, 6099.420555047263, 6118.680093383066, 6128.228138398679, 6144.433169541739, 6187.876242475125, 6216.409441103088, 6218.81343559694, 6222.844428889223, 6223.3465486123305, 4503.41455610775, 4524.502304746541, 4793.592544633675, 4970.527799859007, 5023.2716256143385, 4367.10474352757, 4371.890702732394, 4393.0, 4396.406485124531, 4480.126375356775, 5748.19525266463, 5758.078707406795, 5759.568032397587, 5767.423257674199, 5775.0, 6116.510679145657, 6158.692065396713, 6176.073588961692, 6186.536009799283, 6188.504919606421, 5665.544018148926, 5692.943070569324, 5696.572757043238, 5703.429657034263, 5720.084786434234, 5371.462853714597, 5411.458854114557, 5428.83713488596, 5440.727963601804, 5482.753276102585, 6249.625022498664, 6257.342978987232, 6257.4681152102585, 6264.34224406449, 6279.1209230708655, 6076.422739839708, 6114.205153330038, 6176.938230617816, 6192.81421557354, 6196.287426945959, 6142.98993493194, 6143.266246520256, 6150.477209437248, 6176.166217560572, 6281.811545653638, 6170.0, 6185.2886918003205, 6186.536009799193, 6187.133801267736, 6212.47193988516, 6124.203853499017, 6212.565120441525, 6219.129321895029, 6229.470495007975, 6243.469305108935, 5103.464136265788, 5681.602287839977, 5719.828405147852, 5798.652080875161, 5872.882542349214, 6018.729157188025, 6088.969555152196, 6109.450149486567, 6122.265328160649, 6124.510039196943, 5689.601727879009, 5733.140028995684, 5771.9134212986, 5874.500667443315, 5909.497692696169, 6043.456088952015, 6083.513318934386, 6106.2061931948565, 6110.847228819137, 6139.508839292756, 5709.600327977168, 5781.0, 5804.796832110856, 5934.703264836655, 5944.970275148597], "value": 5639.017545212606, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.68297350367976, 475.643267549338, 500.9123403404403, 505.41876841632126, 508.0296633430147, 39712.80143599281, 42963.0, 42976.57023429765, 45607.31589026167, 45620.0, 43913.560864391424, 44446.0, 44535.55464445354, 44624.776876115575, 44786.55213447865, 8390.916090839106, 8603.913960860375, 9209.12513311236, 9555.713328600154, 9563.569639366211, 11120.0, 11459.885401146006, 11490.482928268248, 11642.476088576035, 11648.767024659503, 11472.196946213768, 11539.48072336747, 11555.595554155607, 11561.364124973165, 11632.825507617392, 11444.427778611078, 11446.885531144666, 11500.482478288497, 11505.079593632488, 11525.654230373102, 11297.039751621121, 11335.716607084889, 11341.319520828776, 11364.374959377232, 11372.545098196062, 41073.38389924153, 41385.0, 41426.37860432096, 41451.0, 41477.0, 4005.2590270799706, 4044.090079732037, 4079.469668943048, 4089.284375234352, 4168.374743788426, 25561.360965975815, 28051.0182143624, 29667.10998670022, 29721.811127554873, 29875.850620746758, 3113.532970054487, 3253.0, 3289.7203737682325, 3295.8681652734103, 3299.9935019818945, 435350.0, 435884.99999999686, 435980.0, 438212.0, 438695.0, 57275.28174154782, 57677.0, 57717.71141144352, 57756.4224357751, 57824.0, 60108.699456502436, 60519.69740151271, 60602.78794424175, 60603.09095363573, 60764.69617651972, 15583.0, 15754.842451575338, 15755.291011904492, 15797.0, 15809.762853557206, 10881.238313317992, 11127.610533631447, 11989.520419183134, 12133.635990920286, 12281.631551053482, 18173.818261817214, 18292.54268643268, 18404.26382944694, 18481.5379615508, 18595.90702046508, 7692.653830577638, 7765.417593680384, 7782.338501227459, 7814.179511151361, 7845.803854903673, 795.8010497375656, 866.7486428935538, 871.7384784564605, 877.2148926710558, 893.9106089391139, 30269.545956810667, 30377.544336834966, 30545.389092218033, 30723.846380767955, 30830.69169308323, 1052.4842827014709, 1063.989360106389, 1102.5589764094427, 1105.2539535813455, 1185.3480585677842, 14827.406903723946, 15595.532134035997, 15711.21443927799, 15919.965202261816, 16144.0, 484092.0, 589223.0, 590618.0, 590728.0, 590738.0, 61413.38586614166, 62051.379486205464, 62056.689716551125, 62090.68954655198, 62121.689391552754, 1407.27525324458, 1432.090622454728, 1452.2375752729479, 1454.3964254834125, 1454.5781723300336, 28949.276268093465, 29329.85335073311, 29545.55681664734, 30319.242018949702, 30697.846510767304, 52875.919269284524, 53401.198982014525, 53494.73252633712, 53504.46495534995, 53569.0, 418427.0, 422467.0, 422815.0, 424057.0, 424845.0, 26515.33711657224, 26862.59706104449, 26964.95525671165, 27077.59383609208, 27250.591241131002, 47389.0, 48316.27525587049, 48979.510204897495, 49054.50945490642, 49388.259176113104, 36769.816150919076, 36793.0, 37930.43104353382, 39860.80069599633, 40056.1988760229, 36104.0, 36499.81750091232, 37064.81467592645, 37390.25219495649, 37424.45096044617, 36146.45780313245, 36709.63290367169, 36779.89660310195, 36926.0, 37107.0, 30950.916717914766, 31978.84010579932, 32893.67106329002, 33148.1712957178, 33154.50268246027, 23517.764822351557, 23939.521209576058, 24012.75987240175, 24306.87846560756, 24442.022319107036], "value": 20056.55455592336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.15415700067354, 384.50590990577115, 393.7283274540567, 395.74078978269233, 415.5989470161294, 20306.086226119824, 20764.896175519138, 20879.791202087974, 21049.158033678636, 21114.366569002916, 16204.918975405106, 18131.0, 20559.486012849688, 21207.68188477174, 21457.785422145775, 5056.696598204119, 5621.634593751393, 5635.267415236013, 5952.987992041363, 6091.0, 5754.0, 5920.171176035358, 5926.5258779297765, 5973.1040343948325, 5988.880222395549, 5854.882902341972, 5928.584999050068, 5929.822105336847, 5934.0, 5960.135780311853, 5199.792008319662, 5715.914261286042, 5867.031939729939, 5911.876743418737, 5924.911126333087, 5823.4467725566, 5829.533637309048, 5831.620944638585, 5834.620749651259, 5847.736851841677, 13488.19070855742, 13637.590872273848, 13651.249181295025, 13667.726645467135, 22654.320370388916, 2495.987520062406, 2522.924312270635, 2572.961405578918, 2628.8028397870235, 2681.36987807865, 9947.05502977216, 10042.297039207258, 10124.34191777532, 10171.54228059739, 10290.691279261635, 1803.1164729282557, 1829.815224541056, 1862.4133397979592, 1865.8414034807058, 1871.585654505686, 109484.90515094827, 131916.0, 137558.0, 137598.0, 139118.0, 11706.590269340531, 11709.824352634718, 11710.824337634942, 11849.703757406134, 12058.758824823455, 15185.0, 15351.616209594626, 15352.30914608823, 15364.308606112529, 15370.615734606725, 8375.664973400995, 8543.829123417498, 8557.35819813504, 8572.185642363966, 8660.956695216484, 8199.244438225815, 8285.25432711059, 8434.409591328547, 8455.66177352899, 8471.830563388698, 4628.9537104628525, 4704.95295047052, 4721.622270218374, 4725.196716558194, 4769.73766442842, 1866.915988780508, 1921.2987259650126, 1980.0792631426457, 2024.5343570978757, 2030.4517780199265, 930.0652843891845, 997.1474389396961, 1028.4240825137947, 1030.0883717909553, 1042.166266986408, 21096.367108986757, 21406.697472193046, 21411.785882141292, 21472.78527214739, 21645.891770541046, 980.181548407088, 1054.9683509494728, 1060.8514807926897, 1091.3342860854873, 1096.9341839489657, 9320.161185493338, 9429.15137637616, 10665.680029599125, 11237.269577477438, 11300.265482743594, 678610.0, 693476.0, 693836.0, 701751.0, 716513.0, 126511.0, 148822.0, 150127.0, 150495.24752376167, 158571.0, 903.2818908967387, 1061.7823346214007, 1074.8441475985937, 1090.9672709818717, 1097.6048622495896, 18118.0, 18905.338313159522, 18913.810861891205, 18914.905425472785, 18958.52603684919, 48657.99999999858, 51413.06400787294, 52400.213996790844, 58602.0, 60138.79722405615, 71077.64461177662, 89797.0, 90666.0, 90844.18311633597, 90906.09093908976, 7618.771436856903, 7644.541327520366, 8170.101288858102, 8326.0, 8467.705702047726, 9224.538773061455, 11958.461869215733, 12325.445354959227, 13046.41291141882, 13251.337433128498, 10145.543450544596, 10200.693979180636, 10997.230193886351, 11294.820916260707, 11347.148963827582, 9543.952280238555, 10887.891121088687, 11209.271397359145, 11312.15158863105, 11465.828012579985, 10975.670729878117, 11503.252288601214, 11584.594539191088, 11653.30080195191, 11788.4695188715, 7099.609521476368, 7302.819392478026, 7485.401167906663, 8201.22088401601, 8550.529720865412, 8269.875951860606, 10033.648822291185, 10765.084967777513, 11423.971842534213, 11628.94185529067], "value": 9663.061374412824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.6207062022634, 1392.269058744159, 1432.1550285331653, 1463.458520347471, 1470.2648675662172, 7476.401887848972, 7735.806604834882, 8037.638306276217, 8428.957855210723, 8465.407421480491, 7096.609686467255, 7927.484713493619, 7993.400494962872, 8264.752057438287, 8321.375896807733, 2294.1740973249657, 2327.650852372141, 2338.988305058472, 2346.1671106757112, 2353.52929414117, 1753.3424965637885, 2140.9357719268446, 2307.0541078157958, 2340.520193360357, 2348.3072493614427, 2242.2264318809985, 2318.2697450303185, 2324.4537533679572, 2325.069972011192, 2337.4506990857135, 2292.3380549101853, 2307.3424074138957, 2315.8263130265295, 2316.953660926789, 2318.0148436914415, 2279.680844681746, 2296.0586159674453, 2342.367560758603, 2355.258093700496, 2359.044586942291, 7281.599512026836, 8411.158884111539, 8412.495250285003, 8430.704925327645, 8435.789105272355, 4978.6763860348965, 5126.051680439094, 5142.871428214287, 5155.40712818027, 5161.458046905059, 2932.692067332942, 3228.5872522815203, 3293.1931676739114, 3329.1356840169583, 3408.812515311657, 1168.2056201782784, 1195.557643671847, 1240.7890658587971, 1250.662321173278, 1260.85500167481, 10561.102306303974, 10674.0, 10723.03492685662, 10731.356118632906, 10734.516946737338, 4343.413639158736, 4653.674242802971, 4707.693999889996, 4721.291806229025, 4724.173269677793, 8240.340772738167, 9398.624055037859, 9420.434773913586, 9437.150656440816, 9445.716628501155, 5196.038732834438, 5211.5830733541225, 5213.661112027706, 5220.451852555503, 5232.1628539433505, 4281.892952676208, 4484.215262329079, 4699.859004229878, 4781.593564546983, 4812.109759694467, 3603.990882552889, 3631.5655316149973, 3855.248226595843, 3890.16361482277, 3936.7441116327345, 1180.8819118088295, 1224.5163160551533, 1267.3916520070234, 1291.4317700211877, 1295.9157654752412, 777.8560966221268, 853.1553761775797, 871.0375035585713, 910.9590068446936, 926.4811705444972, 5171.0, 5301.098813201765, 5439.211314359396, 5578.525825304894, 5650.237217975603, 931.7577429868284, 950.5437390052813, 991.1723710701501, 991.4249735153594, 998.201438848918, 3472.585506813153, 3708.2398108387715, 3758.9436158457647, 3775.7356985010783, 3792.924141517154, 9471.715848524555, 9839.852402213972, 9882.703518894445, 9983.450910200008, 10000.199984001409, 9758.75603109928, 9939.950300248453, 9943.850842237372, 9958.103770660675, 9970.351927124713, 7637.394778849708, 7886.3296619786815, 7894.526328420313, 7967.681292748225, 7988.520688758693, 5354.732263386737, 5380.1391777317, 5408.405075441777, 5531.225628411945, 5545.556355491471, 8993.28053755711, 9026.819463610822, 9028.09719028092, 9133.497657628894, 9178.770530736518, 8940.46357218569, 9149.359544831797, 9197.356185067249, 9327.58025888823, 9366.95316523413, 6628.5691430056895, 6850.280720524273, 6856.588604683735, 6861.279565645735, 6880.4839637026425, 7606.315431611181, 7609.086909570887, 7682.078150621961, 7699.6535155917, 7721.266479684421, 6108.205933228652, 7055.153381594037, 7141.607211603412, 7201.3518783309755, 7205.423566114803, 7088.184858741104, 7108.07595012645, 7112.217656057933, 7197.676104575411, 7224.422046236394, 6264.31092579825, 6283.968580157253, 6331.493480521455, 6336.904946425715, 6339.4928405726505, 4836.226203807374, 4942.975285123552, 4978.8755281118265, 5009.474005229544, 5160.509751573594, 4947.975260123676, 4994.101061808909, 4996.450390457119, 5007.574356179765, 5129.999650068201], "value": 4374.999305000822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.6739325887595, 358.21372088266247, 365.94510823376504, 370.0655843993916, 377.9943300850488, 4407.699728580069, 4514.97742511287, 5496.642718223317, 5583.38582755897, 5591.608587398884, 4714.9528504714945, 5309.982206761425, 5383.407825139241, 5450.91823622646, 5530.557555395569, 3926.685865130797, 4250.723702959313, 4284.564670835274, 4311.9784401078105, 4318.5033721122, 3938.6258305460933, 4084.9591504084874, 4323.459567554056, 4326.52898014675, 4327.156204540116, 3359.4792807114936, 3702.4446333049987, 4073.0, 4073.9592604074023, 4085.2238074765846, 4099.323611604082, 4100.487439070132, 4121.5466298707115, 4146.5853414658595, 4148.983499042723, 3194.9456679295777, 3552.3428165789155, 3580.373434648926, 3583.3191693578137, 3588.946165807515, 4513.909721805546, 4973.303737476756, 5300.0, 5302.681839089629, 5317.867053323659, 4354.346847972798, 4710.717356958594, 4723.354921244114, 4724.76376181193, 4755.286706993944, 5267.157254839208, 5362.570994320445, 5745.885082298372, 5784.595078344518, 5849.970750146222, 3106.8135911845134, 3401.9659803401896, 3920.843166273374, 3932.744371615836, 3934.7048971327263, 5691.658500489983, 5790.478856902899, 6062.211912451353, 6063.060225665029, 6074.939250607482, 3683.834227459771, 3958.416633346627, 4004.5383435045997, 4020.8391664333685, 4023.3562629979065, 3890.630390112935, 4019.352065653127, 4034.2334956358786, 4042.171354872303, 4048.595140485928, 4004.778542544552, 4540.954590454053, 4621.445426548836, 4745.240761478147, 4761.357216775691, 4907.460179380337, 5428.131498960148, 5874.676892770939, 5908.615939963888, 5929.169916211734, 1215.295128825279, 1227.5948936850818, 1262.450833887262, 1286.2668279081022, 1302.417562661371, 770.4183341577074, 820.3806126374668, 885.203317014692, 888.7244954064261, 889.5589145584195, 4375.431193944767, 5144.074066668036, 5168.405633352138, 5183.352080989876, 5220.973895130576, 4720.0, 5496.790706044664, 5666.716664166775, 5667.659940403589, 5682.573806964494, 4535.027263140544, 4934.634146341464, 5048.747562621854, 5050.84847454577, 5165.819196328111, 2727.368089793359, 2935.7944943854154, 2955.788126867974, 2998.220462679719, 3006.3085490337344, 5354.500739792787, 5516.613837031369, 5898.64608123514, 5904.431572266078, 5931.703414829241, 4840.177169881058, 5337.332833395825, 5424.9421362834655, 5461.1262198048125, 5901.970490147522, 4837.419509658793, 4907.558319751168, 5593.636413633101, 5639.746211420496, 5727.453587531343, 5152.742362881916, 5650.739704118386, 5653.3781284057895, 5655.0, 5664.555538337698, 5041.571466425395, 5258.2375555544995, 5435.755391007335, 5962.2249107615735, 5981.9401805983125, 5074.391073071255, 6174.938250617616, 6187.504999599932, 6195.535334849814, 6246.625202487865, 3660.871869484555, 4150.979245103756, 4332.935005974976, 4333.674974376871, 4343.2182207203, 5007.7746501408255, 5083.644144909821, 5289.973550132225, 5290.709011004432, 5705.942940570541, 5047.470015648304, 5052.72210028452, 5245.186996015624, 5457.045017121908, 5802.303723553201, 5610.943890561042, 5706.058500347396, 5769.480746732815, 5795.449432303924, 5808.94191058084, 5096.949030509648, 5312.521873031291, 5360.552650784189, 5468.45716741717, 5750.654960702372, 5377.924415116914, 5517.503424691637, 5699.7435115419075, 5781.479666830005, 5816.883662326814, 5449.836504904859, 5484.451554844483, 5661.377248502744, 5661.830145095653, 5684.658920464785], "value": 4139.367448614651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.2365260040254, 700.6636814329119, 752.7327798631486, 802.7270727952496, 853.0701535326493, 14436.989410741253, 14788.40846366144, 14805.851941480596, 14834.03578767382, 14863.702725945488, 11747.41262936854, 14474.5657630271, 14521.49174778883, 15567.29947152378, 16072.0, 848.5290663681669, 886.8226354729047, 887.6094518411878, 888.1739981816908, 888.5113187746746, 805.5649949027518, 884.9159329863653, 895.3911340288602, 896.0278098263392, 899.6491368366343, 904.9864252036225, 943.2972435535536, 943.8112377524488, 945.3335398544044, 946.2004606107862, 933.6265493802465, 938.9530523473833, 940.9529523523796, 942.2650332740508, 953.823542644606, 694.0942070597868, 702.115334678304, 704.0495331302751, 704.2781149321986, 704.8237940514871, 15310.311036003295, 15711.0, 15736.763948540782, 15744.370225190978, 16017.0, 13933.721325573533, 14181.645458863612, 14218.573442796733, 14220.431182752678, 14231.217283049427, 11815.113866459964, 11817.527298908033, 11837.82243266343, 11850.644480665507, 11867.94066029673, 3687.631236876318, 3698.944515832238, 3725.795081270529, 3747.9437808432895, 3827.5215598050245, 92930.5353473235, 94512.52743736237, 103007.0, 105716.56686626746, 109058.45470772675, 9209.815803684023, 11187.664370068911, 11194.888051119548, 11346.773064538827, 11482.368469734245, 21592.0, 21831.0, 21845.0, 21860.23489177903, 21935.232266870902, 6875.828104297332, 7856.921430785734, 8163.346932245406, 8166.550839703873, 8191.0, 3783.829727662262, 4369.497507786582, 4406.911861762811, 4575.3823233863, 4575.450945886515, 3162.3201011782576, 3560.661737134968, 3627.510286111341, 3658.5975542690285, 3660.743747937672, 602.9638221706624, 668.3283300283184, 670.7082419147687, 673.7473447457204, 682.6586706646676, 630.3003665930813, 682.5699809120223, 697.285282585354, 709.6877373955443, 720.4020662849822, 8448.831023379498, 9696.70909872705, 10314.484275786332, 10412.375257484424, 11230.0, 577.9569222797392, 606.1090197409801, 615.3354377272624, 637.346719612401, 678.6844117485393, 4437.223485890021, 4922.0, 4994.950050499521, 5004.199328107486, 5020.3724534433195, 98025.0, 99702.50148749354, 99908.00091999132, 100424.0, 100564.4971775151, 87564.0, 88091.0, 88724.5563772177, 89211.0, 89500.0, 68067.31932680709, 68634.65682671555, 75376.62311688406, 76563.85154222691, 77375.0, 9977.401355918668, 10312.175025997753, 10537.789244215226, 10945.674845557094, 11269.323840569592, 49629.0, 50745.23882141697, 51331.486685134165, 52006.479935200165, 52921.0, 71033.64483177551, 74109.25890741023, 74589.0, 74752.0, 75696.24303756891, 12812.55156069533, 12876.871231287567, 12950.287734174712, 12963.41664625113, 13286.050594525437, 14279.928600356932, 14506.1296322221, 14541.0, 14772.63068423298, 14787.556373308818, 13323.200607963554, 13414.12808167466, 13444.596662100153, 14152.080114792505, 14154.221517816619, 13228.0, 13428.462861485432, 13653.931730341284, 13910.652233693834, 13995.230262335263, 11352.432378380883, 12976.221426714428, 13184.538541151014, 13633.522826701017, 13697.356317241596, 10541.736456588647, 10881.238313318308, 11060.557577696802, 11363.602273920704, 11404.372759498307, 9863.556139973862, 10890.128789696964, 10901.727456813644, 10915.836262456229, 10925.726856828644], "value": 7565.671582889066, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 118.0, 116.0, 118.0, 118.0, 116.0, 118.0, 117.0, 121.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 114.0, 150.0, 98.0, 138.0, 135.0, 141.0, 147.0, 112.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 219.0, 201.0, 196.0, 197.0, 199.0, 220.0, 206.0, 279.0], "value": 212.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 57.0, 82.0, 60.0, 59.0, 58.0, 60.0, 72.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 83.0, 72.0, 69.0, 70.0, 80.0, 74.0, 99.0, 108.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 81.0, 130.0, 120.0, 92.0, 112.0, 129.0, 124.0, 90.0, 89.0], "value": 105.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 123.0, 95.0, 98.0, 105.0, 146.0, 115.0, 97.0, 97.0], "value": 107.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 94.0, 93.0, 93.0, 92.0, 92.0, 93.0, 123.0, 91.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 74.0, 82.0, 75.0, 71.0, 72.0, 71.0, 86.0, 99.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 93.0, 88.0, 93.0, 86.0, 88.0, 101.0, 109.0, 86.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 140.0, 138.0, 153.0, 177.0, 152.0, 154.0, 203.0, 150.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 181.0, 173.0, 173.0, 174.0, 175.0, 185.0, 201.0, 177.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 69.0, 67.0, 70.0, 65.0, 68.0, 67.0], "value": 67.9, "unit": "score"}]}]} 04:52:55 INFO - Return code: 0 04:52:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:55 ERROR - # TBPL SUCCESS # 04:52:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:55 INFO - 2017-01-17 04:52:55.656 screenresolution[1662:10599] starting screenresolution argv=screenresolution get 04:52:55 INFO - 2017-01-17 04:52:55.659 screenresolution[1662:10599] Display 0: 1600x1200x32@60 04:52:55 INFO - 2017-01-17 04:52:55.665 screenresolution[1663:10603] starting screenresolution argv=screenresolution list 04:52:55 INFO - Available Modes on Display 0 04:52:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:55 INFO - Intel Iris: 04:52:55 INFO - Chipset Model: Intel Iris 04:52:55 INFO - Type: GPU 04:52:55 INFO - Bus: Built-In 04:52:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:55 INFO - Vendor: Intel (0x8086) 04:52:55 INFO - Device ID: 0x0a2e 04:52:55 INFO - Revision ID: 0x0009 04:52:55 INFO - Displays: 04:52:55 INFO - Display: 04:52:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:55 INFO - Display Serial Number: 1600x1200 60 04:52:55 INFO - Main Display: Yes 04:52:55 INFO - Mirror: Off 04:52:55 INFO - Online: Yes 04:52:55 INFO - Rotation: Supported 04:52:55 INFO - Return code: 0 04:52:55 INFO - Running post-action listener: _resource_record_post_action 04:52:55 INFO - [mozharness: 2017-01-17 12:52:55.900207Z] Finished run-tests step (success) 04:52:55 INFO - Running post-run listener: _resource_record_post_run 04:52:55 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 39983104; Write bytes: 556474368; Read time: 396; Write time: 1623 04:52:55 INFO - TinderboxPrint: CPU usage
54.7% 04:52:55 INFO - TinderboxPrint: I/O read bytes / time
39,983,104 / 396 04:52:55 INFO - TinderboxPrint: I/O write bytes / time
556,474,368 / 1,623 04:52:55 INFO - TinderboxPrint: CPU idle
2,173.1 (45.3%) 04:52:55 INFO - TinderboxPrint: CPU system
971.7 (20.2%) 04:52:55 INFO - TinderboxPrint: CPU user
1,657.0 (34.5%) 04:52:55 INFO - TinderboxPrint: Swap in / out
291,995,648 / 0 04:52:55 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 251023872; Write bytes: 239802368; Read time: 17897; Write time: 487 04:52:55 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 32579584; Write bytes: 300984320; Read time: 306; Write time: 1098 04:52:56 INFO - Running post-run listener: _upload_blobber_files 04:52:56 INFO - Blob upload gear active. 04:52:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:57 INFO - (blobuploader) - INFO - Done attempting. 04:52:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:58 INFO - (blobuploader) - INFO - Done attempting. 04:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:00 INFO - (blobuploader) - INFO - Done attempting. 04:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:02 INFO - (blobuploader) - INFO - Done attempting. 04:53:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:02 INFO - Return code: 0 04:53:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48fece589640d73f401bf657dd828941c505d93b3df57c0b5ce4c092131603736122ff90c3fc02ce5b61a796c1a519c16aa3156fe3f5031af76c3ca5913898dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75e72abe5865eec5430d1f8c120b716caac6ac716e2361032b21aab26c317787981e5e1902302ce577bd7e58a12489cdd34ef8b604b46e706bd0dd4f88f2ecd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0c7461000174e22e438f4a82e146d4452996ce6f2a4200945d92c2a7a4b3e2431e852a2f1755853edfeed8faf706e3476adce55ccfdcf9ed42cfe792600a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd9034bc765aab3aa844c1e60fee2c3e94615fafb4e82d463fe8b2c24787d33a9bcd9228d95d2fb12b039a958485da23bd31cbe95a74b1c451148752223ecb1"} 04:53:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:02 INFO - Contents: 04:53:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48fece589640d73f401bf657dd828941c505d93b3df57c0b5ce4c092131603736122ff90c3fc02ce5b61a796c1a519c16aa3156fe3f5031af76c3ca5913898dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75e72abe5865eec5430d1f8c120b716caac6ac716e2361032b21aab26c317787981e5e1902302ce577bd7e58a12489cdd34ef8b604b46e706bd0dd4f88f2ecd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0c7461000174e22e438f4a82e146d4452996ce6f2a4200945d92c2a7a4b3e2431e852a2f1755853edfeed8faf706e3476adce55ccfdcf9ed42cfe792600a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd9034bc765aab3aa844c1e60fee2c3e94615fafb4e82d463fe8b2c24787d33a9bcd9228d95d2fb12b039a958485da23bd31cbe95a74b1c451148752223ecb1"} 04:53:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:02 INFO - Copying logs to upload dir... 04:53:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.280694 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-17 04:53:02.365212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:02.369236) ========= 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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48fece589640d73f401bf657dd828941c505d93b3df57c0b5ce4c092131603736122ff90c3fc02ce5b61a796c1a519c16aa3156fe3f5031af76c3ca5913898dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75e72abe5865eec5430d1f8c120b716caac6ac716e2361032b21aab26c317787981e5e1902302ce577bd7e58a12489cdd34ef8b604b46e706bd0dd4f88f2ecd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0c7461000174e22e438f4a82e146d4452996ce6f2a4200945d92c2a7a4b3e2431e852a2f1755853edfeed8faf706e3476adce55ccfdcf9ed42cfe792600a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd9034bc765aab3aa844c1e60fee2c3e94615fafb4e82d463fe8b2c24787d33a9bcd9228d95d2fb12b039a958485da23bd31cbe95a74b1c451148752223ecb1"} build_url:https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/NHYaYFzTS2ansXkaL1qcMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48fece589640d73f401bf657dd828941c505d93b3df57c0b5ce4c092131603736122ff90c3fc02ce5b61a796c1a519c16aa3156fe3f5031af76c3ca5913898dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75e72abe5865eec5430d1f8c120b716caac6ac716e2361032b21aab26c317787981e5e1902302ce577bd7e58a12489cdd34ef8b604b46e706bd0dd4f88f2ecd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0c7461000174e22e438f4a82e146d4452996ce6f2a4200945d92c2a7a4b3e2431e852a2f1755853edfeed8faf706e3476adce55ccfdcf9ed42cfe792600a5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dd9034bc765aab3aa844c1e60fee2c3e94615fafb4e82d463fe8b2c24787d33a9bcd9228d95d2fb12b039a958485da23bd31cbe95a74b1c451148752223ecb1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:02.405988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:02.406313) ========= 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.H0jgOcuHnw/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.f3xhnxwOW6/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 04:53:02.454717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 04:53:02.455038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 04:53:02.455361) ========= ========= Total master_lag: 0.19 =========