builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1481291143.97 results: success (0) buildid: 20161209043251 builduid: 1d8f0098d7984e868d080ce5f7c72ecf revision: 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:43.969227) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:43.969616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:43.969924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:44.074622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:44.077897) ========= 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.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 --2016-12-09 05:45:44-- 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% 20.9M=0.001s 2016-12-09 05:45:44 (20.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148753 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:44.259167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:44.259449) ========= 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.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.025680 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:44.336507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-09 05:45:44.336831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a --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 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 2016-12-09 05:45:44,430 truncating revision to first 12 chars 2016-12-09 05:45:44,430 Setting DEBUG logging. 2016-12-09 05:45:44,431 attempt 1/10 2016-12-09 05:45:44,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44ab7f53ead5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 05:45:46,588 unpacking tar archive at: mozilla-central-44ab7f53ead5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.411711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-09 05:45:46.771091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:46.771411) ========= script_repo_revision: 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:46.771784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:46.772062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 05:45:46.792354) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-09 05:45:46.792639) ========= /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.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:45:46 INFO - MultiFileLogger online at 20161209 05:45:46 in /builds/slave/test 05:45:46 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 05:45:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:46 INFO - {'append_to_log': False, 05:45:46 INFO - 'base_work_dir': '/builds/slave/test', 05:45:46 INFO - 'blob_upload_branch': 'Firefox', 05:45:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:46 INFO - 'branch': 'Firefox', 05:45:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:46 INFO - 'config_files': ('talos/mac_config.py',), 05:45:46 INFO - 'default_actions': ('clobber', 05:45:46 INFO - 'read-buildbot-config', 05:45:46 INFO - 'download-and-extract', 05:45:46 INFO - 'populate-webroot', 05:45:46 INFO - 'create-virtualenv', 05:45:46 INFO - 'install', 05:45:46 INFO - 'run-tests'), 05:45:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:46 INFO - 'download_minidump_stackwalk': True, 05:45:46 INFO - 'download_symbols': 'ondemand', 05:45:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:46 INFO - 'installer_path': 'installer.exe', 05:45:46 INFO - 'log_level': 'info', 05:45:46 INFO - 'log_name': 'talos', 05:45:46 INFO - 'log_to_console': True, 05:45:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:46 INFO - 'opt_config_files': (), 05:45:46 INFO - 'pip_index': False, 05:45:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:46 INFO - 'cmd': ('bash', 05:45:46 INFO - '-c', 05:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:46 INFO - 'enabled': True, 05:45:46 INFO - 'halt_on_failure': False, 05:45:46 INFO - 'name': 'check_screen_resolution'},), 05:45:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:46 INFO - 'cmd': ('bash', 05:45:46 INFO - '-c', 05:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:46 INFO - 'enabled': True, 05:45:46 INFO - 'halt_on_failure': False, 05:45:46 INFO - 'name': 'check_screen_resolution'},), 05:45:46 INFO - 'run_cmd_checks_enabled': True, 05:45:46 INFO - 'sps_profile': False, 05:45:46 INFO - 'sps_profile_interval': 0, 05:45:46 INFO - 'suite': 'dromaeojs-e10s', 05:45:46 INFO - 'system_bits': '32', 05:45:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:46 INFO - 'title': 't-yosemite-r7-0013', 05:45:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:46 INFO - 'use_talos_json': True, 05:45:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:46 INFO - 'work_dir': 'build'} 05:45:46 INFO - [mozharness: 2016-12-09 13:45:46.999112Z] Running clobber step. 05:45:46 INFO - Running pre-action listener: _resource_record_pre_action 05:45:46 INFO - Running main action method: clobber 05:45:46 INFO - rmtree: /builds/slave/test/build 05:45:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:49 INFO - Running post-action listener: _resource_record_post_action 05:45:49 INFO - [mozharness: 2016-12-09 13:45:49.344936Z] Finished clobber step (success) 05:45:49 INFO - [mozharness: 2016-12-09 13:45:49.345058Z] Running read-buildbot-config step. 05:45:49 INFO - Running pre-action listener: _resource_record_pre_action 05:45:49 INFO - Running main action method: read_buildbot_config 05:45:49 INFO - Using buildbot properties: 05:45:49 INFO - { 05:45:49 INFO - "project": "", 05:45:49 INFO - "product": "firefox", 05:45:49 INFO - "script_repo_revision": "production", 05:45:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:45:49 INFO - "repository": "", 05:45:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:45:49 INFO - "buildid": "20161209043251", 05:45:49 INFO - "pgo_build": "False", 05:45:49 INFO - "basedir": "/builds/slave/test", 05:45:49 INFO - "buildnumber": 15, 05:45:49 INFO - "slavename": "t-yosemite-r7-0013", 05:45:49 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:45:49 INFO - "platform": "yosemite_r7", 05:45:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:45:49 INFO - "branch": "mozilla-central", 05:45:49 INFO - "repo_path": "mozilla-central", 05:45:49 INFO - "revision": "44ab7f53ead5b57ef0d2e4de911567e4b5886d0a", 05:45:49 INFO - "stage_platform": "macosx64", 05:45:49 INFO - "builduid": "1d8f0098d7984e868d080ce5f7c72ecf", 05:45:49 INFO - "slavebuilddir": "test" 05:45:49 INFO - } 05:45:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 05:45:49 INFO - Running post-action listener: _resource_record_post_action 05:45:49 INFO - [mozharness: 2016-12-09 13:45:49.348266Z] Finished read-buildbot-config step (success) 05:45:49 INFO - [mozharness: 2016-12-09 13:45:49.348413Z] Running download-and-extract step. 05:45:49 INFO - Running pre-action listener: _resource_record_pre_action 05:45:49 INFO - Running main action method: download_and_extract 05:45:49 INFO - mkdir: /builds/slave/test/build/tests 05:45: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')]} 05:45:49 INFO - trying https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 05:45:49 INFO - Downloading https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 05:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 05:45:50 INFO - Downloaded 1235 bytes. 05:45:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 05:45:50 INFO - Using the following test package requirements: 05:45:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 05:45:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 05:45:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 05:45:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'jsshell-mac64.zip'], 05:45:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 05:45:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 05:45:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 05:45:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 05:45:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 05:45:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 05:45:50 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 05:45:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 05:45:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 05:45:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 05:45:50 INFO - Fetch https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 05:45:51 INFO - Expected file size: 16287340 05:45:51 INFO - Obtained file size: 16287340 05:45:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 05:45:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 05:45:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 05:45:58 INFO - Fetch https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 05:45:59 INFO - Expected file size: 16287340 05:45:59 INFO - Obtained file size: 16287340 05:46:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 05:46:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 05:46:05 INFO - Fetch https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 05:46:06 INFO - Expected file size: 14409734 05:46:06 INFO - Obtained file size: 14409734 05:46:07 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')]} 05:46:07 INFO - trying https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 05:46:07 INFO - Downloading https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 05:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 05:46:09 INFO - Downloaded 69685446 bytes. 05:46:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 05:46:09 INFO - mkdir: /builds/slave/test/properties 05:46:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:09 INFO - Contents: 05:46:09 INFO - build_url:https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 05:46:09 INFO - Running post-action listener: _resource_record_post_action 05:46:09 INFO - Running post-action listener: set_extra_try_arguments 05:46:09 INFO - [mozharness: 2016-12-09 13:46:09.740153Z] Finished download-and-extract step (success) 05:46:09 INFO - [mozharness: 2016-12-09 13:46:09.740301Z] Running populate-webroot step. 05:46:09 INFO - Running pre-action listener: _resource_record_pre_action 05:46:09 INFO - Running main action method: populate_webroot 05:46:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:09 INFO - '--tppagecycles', 05:46:09 INFO - '7'], 05:46:09 INFO - 'tests': ['tsvgm']}}, 05:46:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['damp', 'tps']}, 05:46:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'tests': ['damp', 'tps']}, 05:46:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['dromaeo_dom']}, 05:46:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['basic_compositor_video']}, 05:46:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['a11yr', 05:46:09 INFO - 'ts_paint', 05:46:09 INFO - 'tpaint', 05:46:09 INFO - 'sessionrestore', 05:46:09 INFO - 'sessionrestore_no_auto_restore', 05:46:09 INFO - 'tabpaint']}, 05:46:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['tsvgx', 05:46:09 INFO - 'tsvgr_opacity', 05:46:09 INFO - 'tart', 05:46:09 INFO - 'tscrollx', 05:46:09 INFO - 'cart', 05:46:09 INFO - 'tsvg_static']}, 05:46:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:09 INFO - 'tsvgr_opacity', 05:46:09 INFO - 'tart', 05:46:09 INFO - 'tscrollx', 05:46:09 INFO - 'cart', 05:46:09 INFO - 'tsvg_static']}, 05:46:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'talos_options': ['--disable-e10s'], 05:46:09 INFO - 'tests': ['tp5o']}, 05:46:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'talos_options': ['--disable-e10s', 05:46:09 INFO - '--xperf_path', 05:46:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:09 INFO - 'tests': ['tp5n']}, 05:46:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:09 INFO - 'talos_options': ['--xperf_path', 05:46:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:09 INFO - 'tests': ['tp5n']}}, 05:46:09 INFO - 'talos.zip': {'path': '', 05:46:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:09 INFO - Running post-action listener: _resource_record_post_action 05:46:09 INFO - [mozharness: 2016-12-09 13:46:09.759002Z] Finished populate-webroot step (success) 05:46:09 INFO - [mozharness: 2016-12-09 13:46:09.759129Z] Running create-virtualenv step. 05:46:09 INFO - Running pre-action listener: _resource_record_pre_action 05:46:09 INFO - Running main action method: create_virtualenv 05:46:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:09 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 05:46:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:09 INFO - Using real prefix '/tools/python27' 05:46:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:13 INFO - Installing pip.................done. 05:46:13 INFO - Return code: 0 05:46:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:13 INFO - Reading from file tmpfile_stdout 05:46:13 INFO - Output received: 05:46:13 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) 05:46:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:13 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:13 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 05:46:13 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 05:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:13 INFO - 'HOME': '/Users/cltbld', 05:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:13 INFO - 'LOGNAME': 'cltbld', 05:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:13 INFO - 'MOZ_NO_REMOTE': '1', 05:46:13 INFO - 'NO_EM_RESTART': '1', 05:46:13 INFO - 'PAGER': '/bin/cat', 05:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:13 INFO - 'PWD': '/builds/slave/test', 05:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:13 INFO - 'SHELL': '/bin/bash', 05:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:13 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:13 INFO - 'USER': 'cltbld', 05:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:13 INFO - 'XPC_FLAGS': '0x0', 05:46:13 INFO - 'XPC_SERVICE_NAME': '0', 05:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:13 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 05:46:13 INFO - Cleaning up... 05:46:13 INFO - Return code: 0 05:46:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:14 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:14 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 05:46:14 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 05:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:14 INFO - 'HOME': '/Users/cltbld', 05:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:14 INFO - 'LOGNAME': 'cltbld', 05:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:14 INFO - 'MOZ_NO_REMOTE': '1', 05:46:14 INFO - 'NO_EM_RESTART': '1', 05:46:14 INFO - 'PAGER': '/bin/cat', 05:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:14 INFO - 'PWD': '/builds/slave/test', 05:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:14 INFO - 'SHELL': '/bin/bash', 05:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:14 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:14 INFO - 'USER': 'cltbld', 05:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:14 INFO - 'XPC_FLAGS': '0x0', 05:46:14 INFO - 'XPC_SERVICE_NAME': '0', 05:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:14 INFO - Downloading/unpacking psutil>=3.1.1 05:46:14 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 05:46:14 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 05:46:14 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 05:46:14 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 05:46:14 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 05:46:14 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 05:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:18 INFO - Installing collected packages: psutil 05:46:18 INFO - Running setup.py install for psutil 05:46:18 INFO - building 'psutil._psutil_osx' extension 05:46:18 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 05:46:18 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 05:46:18 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 05:46:18 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 05:46:19 INFO - building 'psutil._psutil_posix' extension 05:46:19 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 05:46:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:46:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:46:19 INFO - ^ 05:46:19 INFO - 1 warning generated. 05:46:19 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 05:46:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:19 INFO - Successfully installed psutil 05:46:19 INFO - Cleaning up... 05:46:19 INFO - Return code: 0 05:46:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:19 INFO - 'HOME': '/Users/cltbld', 05:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:19 INFO - 'LOGNAME': 'cltbld', 05:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:19 INFO - 'MOZ_NO_REMOTE': '1', 05:46:19 INFO - 'NO_EM_RESTART': '1', 05:46:19 INFO - 'PAGER': '/bin/cat', 05:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:19 INFO - 'PWD': '/builds/slave/test', 05:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:19 INFO - 'SHELL': '/bin/bash', 05:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:19 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:19 INFO - 'USER': 'cltbld', 05:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:19 INFO - 'XPC_FLAGS': '0x0', 05:46:19 INFO - 'XPC_SERVICE_NAME': '0', 05:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:19 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 05:46:19 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 05:46:19 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 05:46:19 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 05:46:19 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 05:46:19 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 05:46:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:22 INFO - Installing collected packages: mozsystemmonitor 05:46:22 INFO - Running setup.py install for mozsystemmonitor 05:46:22 INFO - Successfully installed mozsystemmonitor 05:46:22 INFO - Cleaning up... 05:46:22 INFO - Return code: 0 05:46:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:22 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')]} 05:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:22 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')]} 05:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:22 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:22 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 05:46:22 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 05:46:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:22 INFO - 'HOME': '/Users/cltbld', 05:46:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:22 INFO - 'LOGNAME': 'cltbld', 05:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:22 INFO - 'MOZ_NO_REMOTE': '1', 05:46:22 INFO - 'NO_EM_RESTART': '1', 05:46:22 INFO - 'PAGER': '/bin/cat', 05:46:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:22 INFO - 'PWD': '/builds/slave/test', 05:46:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:22 INFO - 'SHELL': '/bin/bash', 05:46:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:22 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:22 INFO - 'USER': 'cltbld', 05:46:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:22 INFO - 'XPC_FLAGS': '0x0', 05:46:22 INFO - 'XPC_SERVICE_NAME': '0', 05:46:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:25 INFO - warning: no files found matching '*.txt' 05:46:25 INFO - no previously-included directories found matching 'build' 05:46:25 INFO - no previously-included directories found matching 'dist' 05:46:25 INFO - no previously-included directories found matching '.git*' 05:46:25 INFO - Installing collected packages: jsonschema, functools32 05:46:26 INFO - Running setup.py install for functools32 05:46:26 INFO - warning: no files found matching '*.txt' 05:46:26 INFO - no previously-included directories found matching 'build' 05:46:26 INFO - no previously-included directories found matching 'dist' 05:46:26 INFO - no previously-included directories found matching '.git*' 05:46:26 INFO - Successfully installed jsonschema functools32 05:46:26 INFO - Cleaning up... 05:46:26 INFO - Return code: 0 05:46:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', '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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:46: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 functools32==3.2.3-2 05:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:26 INFO - 'HOME': '/Users/cltbld', 05:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:26 INFO - 'LOGNAME': 'cltbld', 05:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:26 INFO - 'MOZ_NO_REMOTE': '1', 05:46:26 INFO - 'NO_EM_RESTART': '1', 05:46:26 INFO - 'PAGER': '/bin/cat', 05:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:26 INFO - 'PWD': '/builds/slave/test', 05:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:26 INFO - 'SHELL': '/bin/bash', 05:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:26 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:26 INFO - 'USER': 'cltbld', 05:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:26 INFO - 'XPC_FLAGS': '0x0', 05:46:26 INFO - 'XPC_SERVICE_NAME': '0', 05:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:26 INFO - Cleaning up... 05:46:26 INFO - Return code: 0 05:46:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', '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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46: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 blobuploader==1.2.4 05:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:26 INFO - 'HOME': '/Users/cltbld', 05:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:26 INFO - 'LOGNAME': 'cltbld', 05:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:26 INFO - 'MOZ_NO_REMOTE': '1', 05:46:26 INFO - 'NO_EM_RESTART': '1', 05:46:26 INFO - 'PAGER': '/bin/cat', 05:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:26 INFO - 'PWD': '/builds/slave/test', 05:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:26 INFO - 'SHELL': '/bin/bash', 05:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:26 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:26 INFO - 'USER': 'cltbld', 05:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:26 INFO - 'XPC_FLAGS': '0x0', 05:46:26 INFO - 'XPC_SERVICE_NAME': '0', 05:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:26 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 05:46:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:30 INFO - Downloading docopt-0.6.1.tar.gz 05:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:30 INFO - Running setup.py install for blobuploader 05:46:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:30 INFO - Running setup.py install for requests 05:46:31 INFO - Running setup.py install for docopt 05:46:31 INFO - Successfully installed blobuploader requests docopt 05:46:31 INFO - Cleaning up... 05:46:31 INFO - Return code: 0 05:46:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:31 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:31 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 05:46:31 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 05:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:31 INFO - 'HOME': '/Users/cltbld', 05:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:31 INFO - 'LOGNAME': 'cltbld', 05:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:31 INFO - 'MOZ_NO_REMOTE': '1', 05:46:31 INFO - 'NO_EM_RESTART': '1', 05:46:31 INFO - 'PAGER': '/bin/cat', 05:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:31 INFO - 'PWD': '/builds/slave/test', 05:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:31 INFO - 'SHELL': '/bin/bash', 05:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:31 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:31 INFO - 'USER': 'cltbld', 05:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:31 INFO - 'XPC_FLAGS': '0x0', 05:46:31 INFO - 'XPC_SERVICE_NAME': '0', 05:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-EsRO1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:31 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-tFNRzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xeDZMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xpJ9fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-QWjRQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XBgosi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-3ai3z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Q3W5v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Hb72NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-8zy9oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:32 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-7ux0w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-R0Bwzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Lm7svB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-zRRRTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-oxt02G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-eLxaZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:33 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-U0gFZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:33 INFO - Running setup.py install for manifestparser 05:46:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:33 INFO - Running setup.py install for mozcrash 05:46:33 INFO - Running setup.py install for mozdebug 05:46:34 INFO - Running setup.py install for mozdevice 05:46:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Running setup.py install for mozfile 05:46:34 INFO - Running setup.py install for mozhttpd 05:46:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Running setup.py install for mozinfo 05:46:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Running setup.py install for mozInstall 05:46:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:34 INFO - Running setup.py install for mozleak 05:46:34 INFO - Running setup.py install for mozlog 05:46:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Running setup.py install for moznetwork 05:46:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Running setup.py install for mozprocess 05:46:35 INFO - Running setup.py install for mozprofile 05:46:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Running setup.py install for mozrunner 05:46:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:35 INFO - Running setup.py install for mozscreenshot 05:46:35 INFO - Running setup.py install for moztest 05:46:36 INFO - Running setup.py install for mozversion 05:46:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:36 INFO - Cleaning up... 05:46:36 INFO - Return code: 0 05:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:36 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:36 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 05:46:36 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 05:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:36 INFO - 'HOME': '/Users/cltbld', 05:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:36 INFO - 'LOGNAME': 'cltbld', 05:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:36 INFO - 'MOZ_NO_REMOTE': '1', 05:46:36 INFO - 'NO_EM_RESTART': '1', 05:46:36 INFO - 'PAGER': '/bin/cat', 05:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:36 INFO - 'PWD': '/builds/slave/test', 05:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:36 INFO - 'SHELL': '/bin/bash', 05:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:36 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:36 INFO - 'USER': 'cltbld', 05:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:36 INFO - 'XPC_FLAGS': '0x0', 05:46:36 INFO - 'XPC_SERVICE_NAME': '0', 05:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-X80EeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:36 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)) 05:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hViSxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:36 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)) 05:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vgmo1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:36 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)) 05:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-RQySkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:36 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)) 05:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:36 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6ESwj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-PCYmsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-BiWiuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-05tky8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Xiw03J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-c67kG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-PvdLHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-8bFzCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Obyhs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:37 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)) 05:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:37 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NEu2YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:38 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)) 05:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:38 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Rj5zFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:38 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)) 05:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:38 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-MYgCx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:38 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-q3EUwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:38 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)) 05:46:38 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)) 05:46:38 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)) 05:46:38 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)) 05:46:38 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)) 05:46:38 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)) 05:46:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:40 INFO - Downloading blessings-1.6.tar.gz 05:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:41 INFO - Installing collected packages: blessings 05:46:41 INFO - Running setup.py install for blessings 05:46:41 INFO - Successfully installed blessings 05:46:41 INFO - Cleaning up... 05:46:41 INFO - Return code: 0 05:46:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:41 INFO - Reading from file tmpfile_stdout 05:46:41 INFO - Current package versions: 05:46:41 INFO - blessings == 1.6 05:46:41 INFO - blobuploader == 1.2.4 05:46:41 INFO - docopt == 0.6.1 05:46:41 INFO - functools32 == 3.2.3-2 05:46:41 INFO - jsonschema == 2.5.1 05:46:41 INFO - manifestparser == 1.1 05:46:41 INFO - mozInstall == 1.12 05:46:41 INFO - mozcrash == 1.0 05:46:41 INFO - mozdebug == 0.1 05:46:41 INFO - mozdevice == 0.49 05:46:41 INFO - mozfile == 1.2 05:46:41 INFO - mozhttpd == 0.7 05:46:41 INFO - mozinfo == 0.9 05:46:41 INFO - mozleak == 0.1 05:46:41 INFO - mozlog == 3.4 05:46:41 INFO - moznetwork == 0.27 05:46:41 INFO - mozprocess == 0.23 05:46:41 INFO - mozprofile == 0.28 05:46:41 INFO - mozrunner == 6.13 05:46:41 INFO - mozscreenshot == 0.1 05:46:41 INFO - mozsystemmonitor == 0.3 05:46:41 INFO - moztest == 0.7 05:46:41 INFO - mozversion == 1.4 05:46:41 INFO - psutil == 3.1.1 05:46:41 INFO - requests == 1.2.3 05:46:41 INFO - wsgiref == 0.1.2 05:46:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:41 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 05:46:41 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 05:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:41 INFO - 'HOME': '/Users/cltbld', 05:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:41 INFO - 'LOGNAME': 'cltbld', 05:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:41 INFO - 'MOZ_NO_REMOTE': '1', 05:46:41 INFO - 'NO_EM_RESTART': '1', 05:46:41 INFO - 'PAGER': '/bin/cat', 05:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:41 INFO - 'PWD': '/builds/slave/test', 05:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:41 INFO - 'SHELL': '/bin/bash', 05:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:41 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:41 INFO - 'USER': 'cltbld', 05:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:41 INFO - 'XPC_FLAGS': '0x0', 05:46:41 INFO - 'XPC_SERVICE_NAME': '0', 05:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 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)) 05:46:41 INFO - Cleaning up... 05:46:41 INFO - Return code: 0 05:46:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 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 0x101a943f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a0a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9002c92300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, '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.XGFtFdyUoF/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.YmrE2HseGV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:46:41 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 05:46:41 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 05:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:41 INFO - 'HOME': '/Users/cltbld', 05:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:41 INFO - 'LOGNAME': 'cltbld', 05:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:41 INFO - 'MOZ_NO_REMOTE': '1', 05:46:41 INFO - 'NO_EM_RESTART': '1', 05:46:41 INFO - 'PAGER': '/bin/cat', 05:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:41 INFO - 'PWD': '/builds/slave/test', 05:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:41 INFO - 'SHELL': '/bin/bash', 05:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:46:41 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:41 INFO - 'USER': 'cltbld', 05:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:41 INFO - 'XPC_FLAGS': '0x0', 05:46:41 INFO - 'XPC_SERVICE_NAME': '0', 05:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:42 INFO - Cleaning up... 05:46:42 INFO - Return code: 0 05:46:42 INFO - Running post-action listener: _resource_record_post_action 05:46:42 INFO - Running post-action listener: _start_resource_monitoring 05:46:42 INFO - Starting resource monitoring. 05:46:42 INFO - [mozharness: 2016-12-09 13:46:42.235249Z] Finished create-virtualenv step (success) 05:46:42 INFO - [mozharness: 2016-12-09 13:46:42.236225Z] Running install step. 05:46:42 INFO - Running pre-action listener: _resource_record_pre_action 05:46:42 INFO - Running main action method: install 05:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:42 INFO - Reading from file tmpfile_stdout 05:46:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:42 INFO - Reading from file tmpfile_stdout 05:46:42 INFO - Output received: 05:46:42 INFO - Usage: mozinstall [options] installer 05:46:42 INFO - Options: 05:46:42 INFO - -h, --help show this help message and exit 05:46:42 INFO - -d DEST, --destination=DEST 05:46:42 INFO - Directory to install application into. [default: 05:46:42 INFO - "/builds/slave/test"] 05:46:42 INFO - --app=APP Application being installed. [default: firefox] 05:46:42 INFO - mkdir: /builds/slave/test/build/application 05:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 05:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 05:47:04 INFO - Reading from file tmpfile_stdout 05:47:04 INFO - Output received: 05:47:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:47:04 INFO - Running post-action listener: _resource_record_post_action 05:47:04 INFO - [mozharness: 2016-12-09 13:47:04.741256Z] Finished install step (success) 05:47:04 INFO - [mozharness: 2016-12-09 13:47:04.741430Z] Running run-tests step. 05:47:04 INFO - Running pre-action listener: _resource_record_pre_action 05:47:04 INFO - Running main action method: run_tests 05:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:04 INFO - 2016-12-09 05:47:04.755 screenresolution[1629:7900] starting screenresolution argv=screenresolution get 05:47:04 INFO - 2016-12-09 05:47:04.758 screenresolution[1629:7900] Display 0: 1600x1200x32@60 05:47:04 INFO - 2016-12-09 05:47:04.764 screenresolution[1630:7902] starting screenresolution argv=screenresolution list 05:47:04 INFO - Available Modes on Display 0 05:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:04 INFO - Intel Iris: 05:47:04 INFO - Chipset Model: Intel Iris 05:47:04 INFO - Type: GPU 05:47:04 INFO - Bus: Built-In 05:47:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:04 INFO - Vendor: Intel (0x8086) 05:47:04 INFO - Device ID: 0x0a2e 05:47:04 INFO - Revision ID: 0x0009 05:47:04 INFO - Displays: 05:47:04 INFO - Display: 05:47:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:04 INFO - Display Serial Number: 1600x1200 60 05:47:04 INFO - Main Display: Yes 05:47:04 INFO - Mirror: Off 05:47:04 INFO - Online: Yes 05:47:04 INFO - Rotation: Supported 05:47:04 INFO - Return code: 0 05:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:04 INFO - Python 2.7.3 05:47:04 INFO - Return code: 0 05:47:05 INFO - grabbing minidump binary from tooltool 05:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:05 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 0x1018a9d30>, '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 0x101710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018a1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:05 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 05:47:05 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 05:47:05 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 05:47:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:05 INFO - Return code: 0 05:47:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:47:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:47:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 05:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 05:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XGFtFdyUoF/Render', 05:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:05 INFO - 'HOME': '/Users/cltbld', 05:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:05 INFO - 'LOGNAME': 'cltbld', 05:47:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:05 INFO - 'MOZ_NO_REMOTE': '1', 05:47:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:05 INFO - 'NO_EM_RESTART': '1', 05:47:05 INFO - 'PAGER': '/bin/cat', 05:47:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:05 INFO - 'PWD': '/builds/slave/test', 05:47:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:05 INFO - 'SHELL': '/bin/bash', 05:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YmrE2HseGV/Listeners', 05:47:05 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:05 INFO - 'USER': 'cltbld', 05:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:05 INFO - 'XPC_FLAGS': '0x0', 05:47:05 INFO - 'XPC_SERVICE_NAME': '0', 05:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 05:47:05 INFO - mozversion application_buildid: 20161209043251 05:47:05 INFO - mozversion application_changeset: 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a 05:47:05 INFO - mozversion application_display_name: Nightly 05:47:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:05 INFO - mozversion application_name: Firefox 05:47:05 INFO - mozversion application_remotingname: firefox 05:47:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:05 INFO - mozversion application_vendor: Mozilla 05:47:05 INFO - mozversion application_version: 53.0a1 05:47:05 INFO - mozversion platform_buildid: 20161209043251 05:47:05 INFO - mozversion platform_changeset: 44ab7f53ead5b57ef0d2e4de911567e4b5886d0a 05:47:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:05 INFO - mozversion platform_version: 53.0a1 05:47:05 INFO - using testdate: 1481291225 05:47:05 INFO - actual date: 1481291225 05:47:05 INFO - starting webserver on 'localhost:49241' 05:47:05 INFO - SUITE-START | Running 2 tests 05:47:05 INFO - TEST-START | dromaeo_css 05:47:05 INFO - operating with platform_type : mac_ 05:47:05 INFO - Initialising browser for dromaeo_css test... 05:47:05 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpvk3zPI/profile http://localhost:49241/getInfo.html) 05:47:08 INFO - PROCESS | 1640 | 2016-12-09 05:47:08.366 plugin-container[1642:8092] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 05:47:08 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:47:08 INFO - PROCESS | 1640 | 2016-12-09 05:47:08.369 plugin-container[1642:8092] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 05:47:08 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:47:08 INFO - PROCESS | 1640 | 2016-12-09 05:47:08.369 plugin-container[1642:8092] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:47:08 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 05:47:08 INFO - PROCESS | 1640 | colorDepth:24 05:47:08 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 05:47:08 INFO - PROCESS | 1640 | __metrics 05:47:08 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 05:47:09 INFO - TEST-INFO | 1640: exit 0 05:47:09 INFO - Browser initialized. 05:47:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:09 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpvk3zPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:11 INFO - PROCESS | 1644 | 2016-12-09 05:47:11.553 plugin-container[1645:8219] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894f, name = 'com.apple.tsm.portname' 05:47:11 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:47:11 INFO - PROCESS | 1644 | 2016-12-09 05:47:11.554 plugin-container[1645:8219] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 05:47:11 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:47:11 INFO - PROCESS | 1644 | 2016-12-09 05:47:11.554 plugin-container[1645:8219] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:47:21 INFO - PROCESS | 1644 | RSS: Main: 236609536 05:47:21 INFO - PROCESS | 1644 | 05:48:10 INFO - PROCESS | 1644 | 1481291290920 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:50:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:50:26 INFO - PROCESS | 1644 | RSS: Main: 257265664 05:50:26 INFO - PROCESS | 1644 | 05:53:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:53:30 INFO - PROCESS | 1644 | RSS: Main: 266653696 05:53:30 INFO - PROCESS | 1644 | 05:56:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:56:32 INFO - PROCESS | 1644 | RSS: Main: 271912960 05:56:32 INFO - PROCESS | 1644 | 05:59:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:59:35 INFO - PROCESS | 1644 | RSS: Main: 270499840 05:59:35 INFO - PROCESS | 1644 | 06:02:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:02:38 INFO - PROCESS | 1644 | RSS: Main: 276348928 06:02:38 INFO - PROCESS | 1644 | 06:05:41 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:05:41 INFO - PROCESS | 1644 | RSS: Main: 279506944 06:05:41 INFO - PROCESS | 1644 | 06:05:41 INFO - PROCESS | 1644 | __start_tp_report 06:05:41 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 06:05:41 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 06:05:41 INFO - PROCESS | 1644 | |i|pagename|runs| 06:05:41 INFO - PROCESS | 1644 | |0;dojo.html;3366.612839523454;3392.796432214067;3426.5716785401823;3431.571053618298;3438.707709844663;5533.418991005947;5610.1865229541745;5654.010548154072;5660.915086273709;5695.943040569593;5288.312519372476;5584.21820945068;5658.094704847225;5696.601237913348;5703.144528320754;5121.359830021247;5177.663451875635;5189.584833213334;5193.480651934814;5196.090684130262;5138.5889128869785;5260.079486089938;5265.131253343194;5284.180951952434;5304.124819404813;5209.921851172236;5251.186066159751;5266.710330931797;5269.235960785703;5279.102552566073;5032.924506132411;5080.441151473335;5116.334876466073;5117.181250999822;5136.178211486144;5046.873828154326;5053.747312634354;5111.386633603955;5118.820841270538;5121.923171152435;4207.705460617758;4602.562756538124;5404;5433.293671822677;5630.352509461423;6132.508481341068;6137.41694539018;6149.077638354238;6181.938180618226;6211.47202487789;5653.8586535336535;5891.82163567284;6238.2825975013;6254.46837018854;6256.249250090018;4950.6782059166035;5579.497845193952;5772.855678608068;5777.959967205943;5799.101139323369;6147.770445910835;6161.075838624242;6172.969135154295;6203;6238.1266622672865;5259.289995850511;5932;6100.664463454553;6116.122740413114;6138.447539721446;6179.443850053427;6186.133941248228;6188.690565471798;6190.690465476709;6202.503799696014;5078.4413714491375;5980.491658209014;5988.251468566429;6048;6128.724207410677;6096.980278560325;6115.879294474695;6132.448079672851;6137.009281402767;6139.907901381483;4820.71075735457;4834.709917404967;4859.902801944012;4884.462709101996;4889.997550502138;4363.258246098171;4390.4511936008;4399.406080179199;4432.468103827497;4443;5784.2769653793275;5785.392533783976;5793.7392817323325;5802.24570805801;5806.709664516758;6042.395760423922;6119.571629985947;6143.204841796972;6237.719302631393;6241.687915604201;5707.3721890592005;5769.567282453749;5798;5825.766969321265;5829.387914269026;5338.332708411449;5382.67703937765;5392.433794451605;5396.83809485716;5400.378956419983;6203.348648391854;6282.089097080989;6289.811305660837;6303.306636270098;6310.11658367838;6149.938500614937;6163.013917773134;6202.069689546604;6266.686665666607;6296.244450665949;6295.055741638791;6295.370462953668;6300.9684951574945;6312.6528040956355;6323.841903952438;5944.405559444021;6186.072089186658;6202.658853763086;6206.875862482815;6244.219472565929;5139.203423469368;5232.947670523246;6112.381899552462;6134.723937422916;6178.320384757583;5993.640381577119;5995.580309378476;6006.129111278928;6014.248218972629;6022.187004754477;4919.581835543876;5962.284525856925;5964.373740757332;5972.970135149297;6005.849853753691;5724.599278050497;5741.598088133791;5766.826995190151;5817.825465236049;5821.359650438364;5970.402959703995;6001.819945401645;6005.1892994446935;6037;6039.909401359071;5824.94175058244;5849.94150058511;5855.824325270249;5862.443067908542;5873.588848780544 06:05:41 INFO - PROCESS | 1644 | |1;ext.html;405.80926964326767;448.8182286174099;463.3281741474862;486.7955458707344;488.474889493794;36715.816420917894;38531.22937541248;38975.02562435937;39071.60928390715;40846.18307633853;39290.0177495562;39895.601043989554;39897.60102398975;40063.39904901429;40192.39711404331;8272.83454330913;8491.363147763943;9117.635294588208;9334.813303733921;9348.345615806897;10824.512896919618;11200.271982321165;11266.4366781661;11349.886501134966;11366.37484938328;11067.72330691731;11147.609833655824;11153.832692509619;11179.32924024557;11180.217384783069;11123.666290011271;11146.386948717818;11161.665150045512;11211.047060999825;11235.550577976872;10988.615398461016;11041.558337666484;11057.723556911062;11075.224734268604;11085.889141108648;37738.811305943294;37893.0526736831;38292.234155316735;38324.61675383266;38434.80782596097;2976.776741744356;3398.303347813692;3423.8972830815114;3605.296967091418;3636;28663.57004644932;28812;29507.377094259806;29513.409731805245;29619.70380296191;3142;3200.647928727838;3213.1324542373663;3339.465685490334;3353.748468864845;476165;476994;480069;480974;482234;55693.164602531;55874.72062639661;55919.72040139855;56057;56185.15722264169;48817.267740983916;55775;58525;58553.414465854796;58605.41394586085;15239.933204675566;15459;15478.690426191413;15479.922600386926;15481.5355539334;10815.513301901434;11073.778524429466;12002.75994480123;12035.338056406981;12321.260724356389;14671.266436678123;14877.553673389815;14921;14948.028378155384;14971;6764.526483146231;6770.661466926634;6782;6810.727570897207;6813.284605116491;847.5887647067686;952.8380175370204;981.5028272624215;1061.7345663584103;1069.2194697870598;28538.001169958952;28866;29218.853905730335;29467.11598652044;29499.55750663699;1040.5109598488698;1057.3233130796295;1080.5353697909975;1113.5991043224433;1166.6091859227254;14658.780118298235;14996.775048374284;15112.319945602474;15351.462698805712;15389;584437;673196;709900;713591;725052;39523.209535809125;40444.393334100016;45040.77479612647;48915.75542122267;49004.75497622489;1111.3387534417009;1333.8999575031912;1346.8451128120196;1356.6404902700594;1361.7072329449215;24792.38019049466;25949.891654933625;27143.86428067847;27608.723912760615;27839.86080069668;41883;42319.3652095225;42330;42370;42543.5745642552;486576;514949;519283;521560;522335;22633.773662263167;23020.884895575415;23270;23427;23448.64827027562;37022.44466333061;37377;37758.62241377661;37977.62022379741;38150.85547433581;25603.6159457612;28904;32236.871709490057;32372.35255294928;35777.64222357743;27905;32898.02667622901;33051.504227436126;33549.16127096842;34243.65756342404;32656.183595410304;33002.17494562559;33248.836290729705;33253.16867078342;33527.49708754322;23188.652170217123;27904;30079.94720184783;30150.54774178433;30153;19365.612687745885;22843.543129137655;23185.536289274456;23552.293431197093;23701.762982370645 06:05:41 INFO - PROCESS | 1644 | |2;jquery.html;322.0242664725881;341.6998321387123;343.9903882106021;379.6014185105639;379.98290076946535;18499.722504162433;18766.53083672909;19241.615167696655;19739;20203.292884749037;11568.884311156886;13701.794473082888;19147.32984345548;19408.320708775194;19500.512487187792;5042.142835717937;5294.814681486148;5300.814471493499;5308.787648494055;5314.92027619586;3797.905052373685;5229.37247530295;5238.895222095575;5992.43071908168;6025.457708806207;6040.879182416349;6046.727897244635;6067.393260673919;6067.423594758513;6081.6351018938785;6041.486473649723;6049.455549000589;6323.74705011799;6350.333215012403;6362.2365316161895;5382.757775900094;5632.07070833312;5634.098544232944;5641.943580564182;5651.632643878176;20199.79800201994;20524.897375513177;20527;22199.556008879732;22797.316080517612;2134.935951921445;2213.5904857601395;2287.9885600572056;2497.675302210719;2800;9625.903740962642;9665.178459830922;9811.705648830546;10203.336783109075;10203.693889183336;1822.5261432027635;1874.7843997940138;1893.5171531259577;1894.9242030318908;1898.9240430382767;109473;111754;114402.42798786036;115251.42374288158;116679;11311.773764524663;11401.144914131473;11539.711507212387;11678.824817627743;11698.94150529242;14300.785488217685;14398.85601143996;14448.783268250985;14456.927715361357;14526.346314415876;6636.900446493307;8287;8339.708110216114;8357.620992536164;8505.53219572917;8143.348532117417;8161.20453500229;8328.500289982621;8332.458390204618;8395.118512556215;4311.159323931804;4446.888827779331;4461.152381047591;4535.63714902807;4549.408576884984;1560.4148444333375;1705.155947805844;1872.5225067607946;1926.9421917342222;1935.2132928582796;685.4653370371118;812.7358608452158;882.1927935938672;945.716285114463;985.9901400986042;17887.56899448041;18357.541061473305;19764.308249211208;21029.843358615424;21376;709.7835160276165;861.5132450165636;902.7066203483894;913.0960349254191;923.9076092390842;8117;10992.120630349553;11089.83365249522;11143.442827858575;11160.330380177214;521455;522014.7798522042;534085;546953;547619;121369.78630213585;123067.76932230563;124197;124818.37590811988;125565;931.3247895276006;963.556763888605;988.9851652225078;1019.5412064570972;1024.3546565663733;16609.66780664404;17070.061146637054;19030.42908712741;19426.805731943066;19486.22055117836;53597.73201133969;54038.72980635072;55205.723971379884;55494.72252638872;55573;74588.62705686437;77302.61348693221;77353.61323193349;79447;79829.60085199536;7498.887516687363;7695.268949449794;7946.562939038177;8000.83998320042;8061.355091592776;11109.666709998713;11741.941290293495;12305.384730763248;12392.504299827906;12411.317377544321;9341.757978085076;9818.067283608047;10523.842142367717;10557.683269501927;10670;8481.40630155883;8664.960204775467;9494.145526902612;9531.666391676257;9554.61781528731;5843.094320380348;7328.890066649111;8953.328500362368;9134.310152621787;11045.558177673125;6282.403171698681;7744.225577442211;7876.448648594544;8062.234087761653;8088.555129467701;8440.366972477212;10051.145652619609;10542.947285263524;10819.891801081889;10853.782924341627 06:05:41 INFO - PROCESS | 1644 | |3;mootools.html;1315.5987423835732;1481.4592673674108;1633.7386018237078;1649.6288335124598;1792.9013904235262;6701.564398314118;7729.458937874337;7993;8427.789305267364;8445.366597505188;6883.79348619541;7926.28663420292;8218.712345067925;8366.874496882552;8368.832623347529;2287.736910255317;2316.5019520803025;2323.581755284048;2329.9184528541505;2331.4870728439714;2315.5947709150914;2342.4612339162004;2349.776771206741;2355.505343877779;2355.6231003039516;2287.7025986621798;2289.7710228977053;2313.5141620259765;2317.629179331307;2319.8724070176136;2262.8416010879164;2276.943076423086;2283.041122728458;2292.1633603734685;2292.9770702293013;2301.6432452969816;2320.988395058014;2330.4057465346227;2332.54515369503;2333.9649905251435;8245.670173193064;8306.127856575033;8384.371172162113;8398.958005209935;8459.900212972274;5034.14419548674;5185.559227465632;5211.088059589594;5211.42674305826;5216.765245563959;3254.8372581371073;3392.8633907640724;3537.8678822776724;3547.840347184357;3559.91422616102;1002.4386343647581;1036.6786296248188;1068.4871261794306;1069.107295408335;1077.8275475923892;10661.626843060456;10711.250212485129;10721.571137154582;10797.784044319149;10807;3893.5717071122153;4344.370066340426;4425.911481770347;4521.706089104197;4629.444466663955;9254;9351.625934962525;9385.5307234638;9385.671501497414;9395.342326037111;5183.663061900965;5213.635045546851;5213.765380557808;5215.400228973641;5231.973840130775;3565.4830049642655;4254.255505286563;4402.911941761146;4681.882952926136;4781.995780885984;3767.9246415072093;3787.242551489658;3840.8655697050467;3878.3988481784804;3891.9416208756893;1255.0649765924445;1268.9175203611735;1271.167385362589;1271.8219449277108;1278.654763213927;818.6234332207132;879.6481407437076;901.1394118616705;924.0851556958563;939.4691999020531;4759.881002974884;5239.716269513993;5766.509846662997;5773.826785196451;5782.306123265151;354.91304630365727;417.0366453492442;417.63039709857;420.445012583387;442.5530214483331;3821.5796262411113;3845.576986531479;3891.1828516011387;3933.4296527004;3962.445257663929;9519.809603808024;9867.901320986843;9960.053794889474;10028.997100289913;10060;9646.662366817269;9719.854202186973;9921.454320012324;9927.453990030474;9954.751131221778;7332.156801967842;7654.119776225582;7709.0749110107145;7782.6886924523515;7795.298423141944;5821.825345239649;5831.533477321889;5874.911876321944;5928.614640048383;5953.315368732651;7122.465815063994;7568.962155189189;8592.957035214784;9011.63953441855;9315.301352398461;7753.806154845948;9332.626694932398;9411.858822117536;9483.099105584959;9521.714348569554;6553.836154095995;6796.728130874907;6882.8623427532175;7075.610841403773;7255;6895.275996020547;7890.763277101696;7895.68417263303;7895.960520197362;7966.203379661987;6950.826229344105;7057.470689698191;7059.858802824017;7107.253738357398;7191.352778249982;5964.373740757158;6787.694553745192;6891.827704307432;6992.825179370557;7034.191068027242;6552.57408268461;6639.4688424924925;6691.330866913269;6701.296363881917;6704;4806.206975848946;4872;4911.214205727209;4930.728809915489;4994.550490455877;4180.912962629677;4787.970586323957;4882.389701287339;4889.19328310839;5033.345665063518 06:05:41 INFO - PROCESS | 1644 | |4;prototype.html;349.94400895856666;351.89267273481585;355.75452937473125;361.3567849228373;370.9703223742099;4569.748663823489;5017.42299635542;5117.5650069744115;5258.4215736269025;5359.464053594638;4261.4673165854265;4380.678240532523;4418.896174917975;5242.580593552516;5325.162818827508;3940.6847452203756;4156.958430415695;4169.749815011094;4181.874543763692;4203.453551038361;3964.484616999786;4153.501579810427;4163.666906647476;4176.68674849386;4176.914002359378;4113.650339721127;4117.423560701489;4120.917581648365;4122.50529936408;4130.607592278729;3667.4877708769445;3926.6073392660505;4070.409790580349;4115.156392939441;4116;3110.3001824589514;3245.1238165695368;3631.364511210528;3633.7638053526703;3636.5636123665063;4926.507349265081;5177.430482646906;5181.5077567631015;5203.464977831549;5214.904869977309;4776.904461910743;4800.303955926406;4822.204336284509;4835.806567737286;4891.4863939286215;4631;5416.620836541444;5674.829755107354;5704.917705037631;5718.71406429681;3747.606501317377;3910.002949247952;3988.1824226033596;3991.2616166009093;4051.703454894435;5015.548600625924;5206.479352064764;5471.06991811393;5632.549396048306;5859.882802343972;4044.373122166069;4117.958820411757;4145;4164.562720914321;4187.890209094592;3529.717622590238;3975.980120099381;4021.2926854583798;4220.978895105566;4240.830366785356;3822.1782316801464;4247.426597409372;4770.499097594772;4811.821103829514;4821.059893320768;4837.7097374157665;5300.660583832161;5636.18275350072;5663.830085097454;5670.518005969457;1224.3388570172008;1231.5344739759657;1288.0082336600951;1333.4666133546466;1389.124851343647;784.4704824243613;854.974350769478;906.977325566866;962.2686758063921;976.82417164911;4262.680298977589;4291.570842915746;4740.976295118502;4899.363082799213;5034.546890779848;4411.523110969402;4689.343491911135;4936.333594964705;5444.515510073477;5582.637128586629;4777.976110119496;4984.700917944862;4986.576141028053;4996.4503904570465;5057.898842023139;2624.9893790890264;2754.228815931542;2808;2870.956935645967;2896.942061158807;4381.627561657295;5162.845114646567;5489.258950041693;5658.991058174372;5694.743736531866;4923.433805112458;5114.335136432314;5289.497497737709;5584.804531841366;5641.8589535261945;5059.873503162303;5571.247881535941;5667.858303542444;5668.943310566924;5683;4467.776611169494;4796.184648609815;4941.282294737808;5410.648307860134;5448.182772584144;5167.896642067213;5176.844694659167;5322.9467705324;5450.509454149145;5496.477834605706;5044.974775126101;5112.3865136183895;5128.0000399921655;5239.869003274796;5606.972234993058;3542.096765324826;3582.820858957094;3584.9245226431444;3853.8073096345634;3940.8029598520534;4763.476017638126;5153.587712983027;5379.892402152013;5385.40760516335;5417.241586178017;4474.79863406154;4623.445186577632;4998.175301075427;5115.514026167508;5263.605059697905;4946.777395017305;4992.825251116194;5119.385673719177;5232.1628539433505;5298.390685071112;4219.240536703423;4801.375821143229;4812.807487700453;5352.437994010573;5436.972815135899;4976.950230497649;5190.766415511235;5364.76183814782;5554.861128471821;5596.3284405871555;4774.164521208844;5208.713520756395;5429.267048948342;5446.537044351275;5482.205080263259 06:05:42 INFO - PROCESS | 1644 | |5;yui.html;690.9792706218813;739.452804924356;780.7072347869549;786.8386980668963;792.7383963292115;14627.926860365696;15459;15522.991005584629;15532.145731984736;15543.844561554395;13955.581332560014;14095.577132686036;14110.082844615094;14128.728414442698;14141.222232777192;691.0774116554394;713.2297119111373;829.6888666749969;867.2368315882046;891.8840550728396;867.9392442529025;879.9880137841469;882.7748924024365;882.8013696918206;885.5041176940902;936.3819878879941;944.4050248343534;948.1656142594508;949.9952500237489;950.8858936927544;913.6528119314685;930.6044930904372;940.1350757303297;940.6237504997987;940.7177846645978;669.357416879796;695.3533214110874;698.4028655499526;702.2240424331092;702.9789106326818;11172;11222.66332010041;12138.878611213862;13515.932420337933;15049.849501505063;11666;12978.221306721533;14064.929675351661;14315.928420357935;14379.640508987255;10084.546195421224;11118.444077796077;11765.823512647317;11780.764384712258;11953.043756499459;3131.373725254958;3665.505156803824;3666.7178271008224;3697.593264740903;3728.776273423576;100513.49743251236;103869;108964;114558.85441145566;114977;10675.145988320915;10899.83650245247;10925.125989920787;11007.834882476769;11315.377654229096;19593.706094408597;20611.58776824455;20651.96740162986;22361.664575031387;22404.10383584671;7859.921400786034;7930.682772689143;8050.033995920527;8121.634526446324;8197;4303.698741088157;4397.362382454527;4445.977770111129;4471.6646251531265;4557.361969324297;3233.9029829105166;3588.318219538279;3650.963490365062;3679.319325924659;3690.501782259414;650.7559665125578;653.4706887421204;654.0352979355508;658.8352911772057;674.9831254218684;519.0638916840207;553.5765139668157;560.0702833296708;638.6966191059303;640.3756337570924;8841.823163536694;9310.767230819283;9457.33798634089;9457.716268511818;9733.075357840993;544.861060429588;610.7343305662051;618.5082859127004;643.8454770855054;681.5672048249298;4353.738775673406;4472.195004899149;4585.679002469862;4616.28447590624;4707.435107787088;93970;95298.57052144223;96016.51991740137;99157;101205.98794012112;73307;75053;86655;86782.13217867867;88906;76310;76833.61583192048;79368.60315698385;80916;82356.76464853033;9239.307051971264;9699.389618536681;10103.646372376932;10122.645707400206;10246.590136394461;51078.23382649189;51600.74199628978;51961.7401912988;52676.20985685295;53925;54576;57680.42319576918;68504.6574767123;78579.60710196412;78761;13147.474101035852;13354.465821367425;13686.384112714753;13718.45126194941;13810.585682429542;15024.924875375991;15351.539453816404;15673.529794106194;15673.921630391775;15896;13680.794788078387;13875.236861972284;14043.789343160066;14520.346584403516;14557.27213639335;13235.933820330836;13844.515441959484;13890.86109138936;14233.786493202404;14340.928295358457;13222.4049917752;13812.792808107686;13813.852577437563;13891.305434728021;14386.280685965869;8895.332850036402;9321.766955826159;11337.149713771336;11460.82808757886;11894.881051189723;9899.950500247453;10276.691699249035;10543.31468454548;11433.714157146138;11719.296842189155 06:05:42 INFO - PROCESS | 1644 | __end_tp_report 06:05:42 INFO - PROCESS | 1644 | __start_cc_report 06:05:42 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,383 06:05:42 INFO - PROCESS | 1644 | __end_cc_report 06:05:42 INFO - PROCESS | 1644 | __startTimestamp1481292341987__endTimestamp 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | ------- Summary: start ------- 06:05:42 INFO - PROCESS | 1644 | Number of tests: 6 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5639.72 Median:5817.83 stddev:637.89 (11.0%) stddev-sans-first:614.42 06:05:42 INFO - PROCESS | 1644 | Values: 3366.6 3392.8 3426.6 3431.6 3438.7 5533.4 5610.2 5654.0 5660.9 5695.9 5288.3 5584.2 5658.1 5696.6 5703.1 5121.4 5177.7 5189.6 5193.5 5196.1 5138.6 5260.1 5265.1 5284.2 5304.1 5209.9 5251.2 5266.7 5269.2 5279.1 5032.9 5080.4 5116.3 5117.2 5136.2 5046.9 5053.7 5111.4 5118.8 5121.9 4207.7 4602.6 5404.0 5433.3 5630.4 6132.5 6137.4 6149.1 6181.9 6211.5 5653.9 5891.8 6238.3 6254.5 6256.2 4950.7 5579.5 5772.9 5778.0 5799.1 6147.8 6161.1 6173.0 6203.0 6238.1 5259.3 5932.0 6100.7 6116.1 6138.4 6179.4 6186.1 6188.7 6190.7 6202.5 5078.4 5980.5 5988.3 6048.0 6128.7 6097.0 6115.9 6132.4 6137.0 6139.9 4820.7 4834.7 4859.9 4884.5 4890.0 4363.3 4390.5 4399.4 4432.5 4443.0 5784.3 5785.4 5793.7 5802.2 5806.7 6042.4 6119.6 6143.2 6237.7 6241.7 5707.4 5769.6 5798.0 5825.8 5829.4 5338.3 5382.7 5392.4 5396.8 5400.4 6203.3 6282.1 6289.8 6303.3 6310.1 6149.9 6163.0 6202.1 6266.7 6296.2 6295.1 6295.4 6301.0 6312.7 6323.8 5944.4 6186.1 6202.7 6206.9 6244.2 5139.2 5232.9 6112.4 6134.7 6178.3 5993.6 5995.6 6006.1 6014.2 6022.2 4919.6 5962.3 5964.4 5973.0 6005.8 5724.6 5741.6 5766.8 5817.8 5821.4 5970.4 6001.8 6005.2 6037.0 6039.9 5824.9 5849.9 5855.8 5862.4 5873.6 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:66946.99 Median:32514.27 stddev:151648.29 (466.4%) stddev-sans-first:151991.41 06:05:42 INFO - PROCESS | 1644 | Values: 405.8 448.8 463.3 486.8 488.5 36715.8 38531.2 38975.0 39071.6 40846.2 39290.0 39895.6 39897.6 40063.4 40192.4 8272.8 8491.4 9117.6 9334.8 9348.3 10824.5 11200.3 11266.4 11349.9 11366.4 11067.7 11147.6 11153.8 11179.3 11180.2 11123.7 11146.4 11161.7 11211.0 11235.6 10988.6 11041.6 11057.7 11075.2 11085.9 37738.8 37893.1 38292.2 38324.6 38434.8 2976.8 3398.3 3423.9 3605.3 3636.0 28663.6 28812.0 29507.4 29513.4 29619.7 3142.0 3200.6 3213.1 3339.5 3353.7 476165.0 476994.0 480069.0 480974.0 482234.0 55693.2 55874.7 55919.7 56057.0 56185.2 48817.3 55775.0 58525.0 58553.4 58605.4 15239.9 15459.0 15478.7 15479.9 15481.5 10815.5 11073.8 12002.8 12035.3 12321.3 14671.3 14877.6 14921.0 14948.0 14971.0 6764.5 6770.7 6782.0 6810.7 6813.3 847.6 952.8 981.5 1061.7 1069.2 28538.0 28866.0 29218.9 29467.1 29499.6 1040.5 1057.3 1080.5 1113.6 1166.6 14658.8 14996.8 15112.3 15351.5 15389.0 584437.0 673196.0 709900.0 713591.0 725052.0 39523.2 40444.4 45040.8 48915.8 49004.8 1111.3 1333.9 1346.8 1356.6 1361.7 24792.4 25949.9 27143.9 27608.7 27839.9 41883.0 42319.4 42330.0 42370.0 42543.6 486576.0 514949.0 519283.0 521560.0 522335.0 22633.8 23020.9 23270.0 23427.0 23448.6 37022.4 37377.0 37758.6 37977.6 38150.9 25603.6 28904.0 32236.9 32372.4 35777.6 27905.0 32898.0 33051.5 33549.2 34243.7 32656.2 33002.2 33248.8 33253.2 33527.5 23188.7 27904.0 30079.9 30150.5 30153.0 19365.6 22843.5 23185.5 23552.3 23701.8 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:32484.40 Median:4542.52 stddev:89749.76 (1975.8%) stddev-sans-first:89969.04 06:05:42 INFO - PROCESS | 1644 | Values: 322.0 341.7 344.0 379.6 380.0 18499.7 18766.5 19241.6 19739.0 20203.3 11568.9 13701.8 19147.3 19408.3 19500.5 5042.1 5294.8 5300.8 5308.8 5314.9 3797.9 5229.4 5238.9 5992.4 6025.5 6040.9 6046.7 6067.4 6067.4 6081.6 6041.5 6049.5 6323.7 6350.3 6362.2 5382.8 5632.1 5634.1 5641.9 5651.6 20199.8 20524.9 20527.0 22199.6 22797.3 2134.9 2213.6 2288.0 2497.7 2800.0 9625.9 9665.2 9811.7 10203.3 10203.7 1822.5 1874.8 1893.5 1894.9 1898.9 109473.0 111754.0 114402.4 115251.4 116679.0 11311.8 11401.1 11539.7 11678.8 11698.9 14300.8 14398.9 14448.8 14456.9 14526.3 6636.9 8287.0 8339.7 8357.6 8505.5 8143.3 8161.2 8328.5 8332.5 8395.1 4311.2 4446.9 4461.2 4535.6 4549.4 1560.4 1705.2 1872.5 1926.9 1935.2 685.5 812.7 882.2 945.7 986.0 17887.6 18357.5 19764.3 21029.8 21376.0 709.8 861.5 902.7 913.1 923.9 8117.0 10992.1 11089.8 11143.4 11160.3 521455.0 522014.8 534085.0 546953.0 547619.0 121369.8 123067.8 124197.0 124818.4 125565.0 931.3 963.6 989.0 1019.5 1024.4 16609.7 17070.1 19030.4 19426.8 19486.2 53597.7 54038.7 55205.7 55494.7 55573.0 74588.6 77302.6 77353.6 79447.0 79829.6 7498.9 7695.3 7946.6 8000.8 8061.4 11109.7 11741.9 12305.4 12392.5 12411.3 9341.8 9818.1 10523.8 10557.7 10670.0 8481.4 8665.0 9494.1 9531.7 9554.6 5843.1 7328.9 8953.3 9134.3 11045.6 6282.4 7744.2 7876.4 8062.2 8088.6 8440.4 10051.1 10542.9 10819.9 10853.8 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5338.69 Median:5198.32 stddev:2915.41 (56.1%) stddev-sans-first:2907.91 06:05:42 INFO - PROCESS | 1644 | Values: 1315.6 1481.5 1633.7 1649.6 1792.9 6701.6 7729.5 7993.0 8427.8 8445.4 6883.8 7926.3 8218.7 8366.9 8368.8 2287.7 2316.5 2323.6 2329.9 2331.5 2315.6 2342.5 2349.8 2355.5 2355.6 2287.7 2289.8 2313.5 2317.6 2319.9 2262.8 2276.9 2283.0 2292.2 2293.0 2301.6 2321.0 2330.4 2332.5 2334.0 8245.7 8306.1 8384.4 8399.0 8459.9 5034.1 5185.6 5211.1 5211.4 5216.8 3254.8 3392.9 3537.9 3547.8 3559.9 1002.4 1036.7 1068.5 1069.1 1077.8 10661.6 10711.3 10721.6 10797.8 10807.0 3893.6 4344.4 4425.9 4521.7 4629.4 9254.0 9351.6 9385.5 9385.7 9395.3 5183.7 5213.6 5213.8 5215.4 5232.0 3565.5 4254.3 4402.9 4681.9 4782.0 3767.9 3787.2 3840.9 3878.4 3891.9 1255.1 1268.9 1271.2 1271.8 1278.7 818.6 879.6 901.1 924.1 939.5 4759.9 5239.7 5766.5 5773.8 5782.3 354.9 417.0 417.6 420.4 442.6 3821.6 3845.6 3891.2 3933.4 3962.4 9519.8 9867.9 9960.1 10029.0 10060.0 9646.7 9719.9 9921.5 9927.5 9954.8 7332.2 7654.1 7709.1 7782.7 7795.3 5821.8 5831.5 5874.9 5928.6 5953.3 7122.5 7569.0 8593.0 9011.6 9315.3 7753.8 9332.6 9411.9 9483.1 9521.7 6553.8 6796.7 6882.9 7075.6 7255.0 6895.3 7890.8 7895.7 7896.0 7966.2 6950.8 7057.5 7059.9 7107.3 7191.4 5964.4 6787.7 6891.8 6992.8 7034.2 6552.6 6639.5 6691.3 6701.3 6704.0 4806.2 4872.0 4911.2 4930.7 4994.6 4180.9 4788.0 4882.4 4889.2 5033.3 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4403.29 Median:4864.60 stddev:1281.91 (26.4%) stddev-sans-first:1248.88 06:05:42 INFO - PROCESS | 1644 | Values: 349.9 351.9 355.8 361.4 371.0 4569.7 5017.4 5117.6 5258.4 5359.5 4261.5 4380.7 4418.9 5242.6 5325.2 3940.7 4157.0 4169.7 4181.9 4203.5 3964.5 4153.5 4163.7 4176.7 4176.9 4113.7 4117.4 4120.9 4122.5 4130.6 3667.5 3926.6 4070.4 4115.2 4116.0 3110.3 3245.1 3631.4 3633.8 3636.6 4926.5 5177.4 5181.5 5203.5 5214.9 4776.9 4800.3 4822.2 4835.8 4891.5 4631.0 5416.6 5674.8 5704.9 5718.7 3747.6 3910.0 3988.2 3991.3 4051.7 5015.5 5206.5 5471.1 5632.5 5859.9 4044.4 4118.0 4145.0 4164.6 4187.9 3529.7 3976.0 4021.3 4221.0 4240.8 3822.2 4247.4 4770.5 4811.8 4821.1 4837.7 5300.7 5636.2 5663.8 5670.5 1224.3 1231.5 1288.0 1333.5 1389.1 784.5 855.0 907.0 962.3 976.8 4262.7 4291.6 4741.0 4899.4 5034.5 4411.5 4689.3 4936.3 5444.5 5582.6 4778.0 4984.7 4986.6 4996.5 5057.9 2625.0 2754.2 2808.0 2871.0 2896.9 4381.6 5162.8 5489.3 5659.0 5694.7 4923.4 5114.3 5289.5 5584.8 5641.9 5059.9 5571.2 5667.9 5668.9 5683.0 4467.8 4796.2 4941.3 5410.6 5448.2 5167.9 5176.8 5322.9 5450.5 5496.5 5045.0 5112.4 5128.0 5239.9 5607.0 3542.1 3582.8 3584.9 3853.8 3940.8 4763.5 5153.6 5379.9 5385.4 5417.2 4474.8 4623.4 4998.2 5115.5 5263.6 4946.8 4992.8 5119.4 5232.2 5298.4 4219.2 4801.4 4812.8 5352.4 5437.0 4977.0 5190.8 5364.8 5554.9 5596.3 4774.2 5208.7 5429.3 5446.5 5482.2 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20233.16 Median:4471.93 stddev:28961.81 (647.6%) stddev-sans-first:29005.88 06:05:42 INFO - PROCESS | 1644 | Values: 691.0 739.5 780.7 786.8 792.7 14627.9 15459.0 15523.0 15532.1 15543.8 13955.6 14095.6 14110.1 14128.7 14141.2 691.1 713.2 829.7 867.2 891.9 867.9 880.0 882.8 882.8 885.5 936.4 944.4 948.2 950.0 950.9 913.7 930.6 940.1 940.6 940.7 669.4 695.4 698.4 702.2 703.0 11172.0 11222.7 12138.9 13515.9 15049.8 11666.0 12978.2 14064.9 14315.9 14379.6 10084.5 11118.4 11765.8 11780.8 11953.0 3131.4 3665.5 3666.7 3697.6 3728.8 100513.5 103869.0 108964.0 114558.9 114977.0 10675.1 10899.8 10925.1 11007.8 11315.4 19593.7 20611.6 20652.0 22361.7 22404.1 7859.9 7930.7 8050.0 8121.6 8197.0 4303.7 4397.4 4446.0 4471.7 4557.4 3233.9 3588.3 3651.0 3679.3 3690.5 650.8 653.5 654.0 658.8 675.0 519.1 553.6 560.1 638.7 640.4 8841.8 9310.8 9457.3 9457.7 9733.1 544.9 610.7 618.5 643.8 681.6 4353.7 4472.2 4585.7 4616.3 4707.4 93970.0 95298.6 96016.5 99157.0 101206.0 73307.0 75053.0 86655.0 86782.1 88906.0 76310.0 76833.6 79368.6 80916.0 82356.8 9239.3 9699.4 10103.6 10122.6 10246.6 51078.2 51600.7 51961.7 52676.2 53925.0 54576.0 57680.4 68504.7 78579.6 78761.0 13147.5 13354.5 13686.4 13718.5 13810.6 15024.9 15351.5 15673.5 15673.9 15896.0 13680.8 13875.2 14043.8 14520.3 14557.3 13235.9 13844.5 13890.9 14233.8 14340.9 13222.4 13812.8 13813.9 13891.3 14386.3 8895.3 9321.8 11337.1 11460.8 11894.9 9900.0 10276.7 10543.3 11433.7 11719.3 06:05:42 INFO - PROCESS | 1644 | -------- Summary: end -------- 06:05:42 INFO - PROCESS | 1644 | 06:05:42 INFO - TEST-INFO | 1644: exit 0 06:05:42 INFO - TEST-OK | dromaeo_css | took 1117270ms 06:05:42 INFO - TEST-START | kraken 06:05:42 INFO - operating with platform_type : mac_ 06:05:42 INFO - Initialising browser for kraken test... 06:05:42 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpJkqB9c/profile http://localhost:49241/getInfo.html) 06:05:45 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 06:05:45 INFO - PROCESS | 1651 | colorDepth:24 06:05:45 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 06:05:45 INFO - PROCESS | 1651 | __metrics 06:05:45 INFO - PROCESS | 1651 | 2016-12-09 06:05:45.408 plugin-container[1652:10553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 06:05:45 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:45 INFO - PROCESS | 1651 | 2016-12-09 06:05:45.411 plugin-container[1652:10553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 06:05:45 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:45 INFO - PROCESS | 1651 | 2016-12-09 06:05:45.411 plugin-container[1652:10553] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:45 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 06:05:46 INFO - TEST-INFO | 1651: exit 0 06:05:46 INFO - Browser initialized. 06:05:46 INFO - Running cycle 1/1 for kraken test... 06:05:46 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpJkqB9c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:48 INFO - PROCESS | 1653 | 2016-12-09 06:05:48.579 plugin-container[1654:10674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 06:05:48 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:48 INFO - PROCESS | 1653 | 2016-12-09 06:05:48.580 plugin-container[1654:10674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 06:05:48 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:48 INFO - PROCESS | 1653 | 2016-12-09 06:05:48.580 plugin-container[1654:10674] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:58 INFO - PROCESS | 1653 | RSS: Main: 236871680 06:05:58 INFO - PROCESS | 1653 | 06:06:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:02 INFO - PROCESS | 1653 | RSS: Main: 249294848 06:06:02 INFO - PROCESS | 1653 | 06:06:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:06:05 INFO - PROCESS | 1653 | RSS: Main: 256823296 06:06:05 INFO - PROCESS | 1653 | 06:06:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:06:09 INFO - PROCESS | 1653 | RSS: Main: 259338240 06:06:09 INFO - PROCESS | 1653 | 06:06:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:06:12 INFO - PROCESS | 1653 | RSS: Main: 261644288 06:06:12 INFO - PROCESS | 1653 | 06:06:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:14 INFO - PROCESS | 1653 | RSS: Main: 262246400 06:06:14 INFO - PROCESS | 1653 | 06:06:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:18 INFO - PROCESS | 1653 | RSS: Main: 267968512 06:06:18 INFO - PROCESS | 1653 | 06:06:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:22 INFO - PROCESS | 1653 | RSS: Main: 267182080 06:06:22 INFO - PROCESS | 1653 | 06:06:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:06:26 INFO - PROCESS | 1653 | RSS: Main: 267534336 06:06:26 INFO - PROCESS | 1653 | 06:06:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:28 INFO - PROCESS | 1653 | RSS: Main: 266797056 06:06:28 INFO - PROCESS | 1653 | 06:06:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:30 INFO - PROCESS | 1653 | RSS: Main: 266809344 06:06:30 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:33 INFO - PROCESS | 1653 | RSS: Main: 266850304 06:06:33 INFO - PROCESS | 1653 | 06:06:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:37 INFO - PROCESS | 1653 | RSS: Main: 267345920 06:06:37 INFO - PROCESS | 1653 | 06:06:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:41 INFO - PROCESS | 1653 | RSS: Main: 266878976 06:06:41 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:06:43 INFO - PROCESS | 1653 | RSS: Main: 268029952 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | __start_tp_report 06:06:43 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 06:06:43 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 06:06:43 INFO - PROCESS | 1653 | |i|pagename|runs| 06:06:43 INFO - PROCESS | 1653 | |0;ai-astar;143;115;172;163;116;119;114;115;117;119 06:06:43 INFO - PROCESS | 1653 | |1;audio-beat-detection;148;123;145;189;117;117;118;121;135;144 06:06:43 INFO - PROCESS | 1653 | |2;audio-dft;204;205;206;203;192;198;197;196;194;196 06:06:43 INFO - PROCESS | 1653 | |3;audio-fft;80;58;59;85;60;63;82;65;100;83 06:06:43 INFO - PROCESS | 1653 | |4;audio-oscillator;88;70;83;73;86;101;116;99;71;81 06:06:43 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;116;114;111;135;117;103;167;162;166;136 06:06:43 INFO - PROCESS | 1653 | |6;imaging-darkroom;103;96;97;96;98;94;97;119;153;107 06:06:43 INFO - PROCESS | 1653 | |7;imaging-desaturate;95;91;99;144;144;92;93;92;93;83 06:06:43 INFO - PROCESS | 1653 | |8;json-parse-financial;60;58;57;60;60;60;61;61;65;61 06:06:43 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;69;75;75;81;71;68;68;71;71;73 06:06:43 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;91;122;116;93;94;95;96;139;113 06:06:43 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;150;147;156;162;139;151;137;158;169;162 06:06:43 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;184;172;239;242;183;178;178;177;179;193 06:06:43 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;63;90;88;70;65;63;68;70;71;65 06:06:43 INFO - PROCESS | 1653 | __end_tp_report 06:06:43 INFO - PROCESS | 1653 | __start_cc_report 06:06:43 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,941 06:06:43 INFO - PROCESS | 1653 | __end_cc_report 06:06:43 INFO - PROCESS | 1653 | __startTimestamp1481292403263__endTimestamp 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | ------- Summary: start ------- 06:06:43 INFO - PROCESS | 1653 | Number of tests: 14 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:129.30 Median:119.00 stddev:21.93 (18.4%) stddev-sans-first:22.70 06:06:43 INFO - PROCESS | 1653 | Values: 143.0 115.0 172.0 163.0 116.0 119.0 114.0 115.0 117.0 119.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:139.50 stddev:22.46 (16.1%) stddev-sans-first:23.37 06:06:43 INFO - PROCESS | 1653 | Values: 148.0 123.0 145.0 189.0 117.0 117.0 118.0 121.0 135.0 144.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:199.10 Median:200.50 stddev:4.98 (2.5%) stddev-sans-first:4.95 06:06:43 INFO - PROCESS | 1653 | Values: 204.0 205.0 206.0 203.0 192.0 198.0 197.0 196.0 194.0 196.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.50 Median:72.50 stddev:14.35 (19.8%) stddev-sans-first:15.03 06:06:43 INFO - PROCESS | 1653 | Values: 80.0 58.0 59.0 85.0 60.0 63.0 82.0 65.0 100.0 83.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:82.00 stddev:14.82 (18.1%) stddev-sans-first:15.71 06:06:43 INFO - PROCESS | 1653 | Values: 88.0 70.0 83.0 73.0 86.0 101.0 116.0 99.0 71.0 81.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:132.70 Median:135.50 stddev:24.47 (18.1%) stddev-sans-first:25.19 06:06:43 INFO - PROCESS | 1653 | Values: 116.0 114.0 111.0 135.0 117.0 103.0 167.0 162.0 166.0 136.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:96.00 stddev:18.13 (18.9%) stddev-sans-first:19.20 06:06:43 INFO - PROCESS | 1653 | Values: 103.0 96.0 97.0 96.0 98.0 94.0 97.0 119.0 153.0 107.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:92.50 stddev:22.18 (24.0%) stddev-sans-first:23.35 06:06:43 INFO - PROCESS | 1653 | Values: 95.0 91.0 99.0 144.0 144.0 92.0 93.0 92.0 93.0 83.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:2.11 (3.5%) stddev-sans-first:2.24 06:06:43 INFO - PROCESS | 1653 | Values: 60.0 58.0 57.0 60.0 60.0 60.0 61.0 61.0 65.0 61.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.99 (5.5%) stddev-sans-first:4.07 06:06:43 INFO - PROCESS | 1653 | Values: 69.0 75.0 75.0 81.0 71.0 68.0 68.0 71.0 71.0 73.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:104.50 Median:92.00 stddev:17.10 (18.6%) stddev-sans-first:16.77 06:06:43 INFO - PROCESS | 1653 | Values: 86.0 91.0 122.0 116.0 93.0 94.0 95.0 96.0 139.0 113.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:157.00 stddev:10.29 (6.6%) stddev-sans-first:10.85 06:06:43 INFO - PROCESS | 1653 | Values: 150.0 147.0 156.0 162.0 139.0 151.0 137.0 158.0 169.0 162.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:183.50 stddev:25.90 (14.1%) stddev-sans-first:27.29 06:06:43 INFO - PROCESS | 1653 | Values: 184.0 172.0 239.0 242.0 183.0 178.0 178.0 177.0 179.0 193.0 06:06:43 INFO - PROCESS | 1653 | 06:06:43 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:70.00 stddev:9.78 (14.0%) stddev-sans-first:9.90 06:06:43 INFO - PROCESS | 1653 | Values: 63.0 90.0 88.0 70.0 65.0 63.0 68.0 70.0 71.0 65.0 06:06:43 INFO - PROCESS | 1653 | -------- Summary: end -------- 06:06:43 INFO - PROCESS | 1653 | 06:06:44 INFO - TEST-INFO | 1653: exit 0 06:06:44 INFO - TEST-OK | kraken | took 61551ms 06:06:44 INFO - SUITE-END | took 1178s 06:06:44 INFO - Completed test suite (00:19:39) 06:06:44 INFO - javascript benchmark 06:06:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7033.496555226841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.612839523454, 3392.796432214067, 3426.5716785401823, 3431.571053618298, 3438.707709844663, 5533.418991005947, 5610.1865229541745, 5654.010548154072, 5660.915086273709, 5695.943040569593, 5288.312519372476, 5584.21820945068, 5658.094704847225, 5696.601237913348, 5703.144528320754, 5121.359830021247, 5177.663451875635, 5189.584833213334, 5193.480651934814, 5196.090684130262, 5138.5889128869785, 5260.079486089938, 5265.131253343194, 5284.180951952434, 5304.124819404813, 5209.921851172236, 5251.186066159751, 5266.710330931797, 5269.235960785703, 5279.102552566073, 5032.924506132411, 5080.441151473335, 5116.334876466073, 5117.181250999822, 5136.178211486144, 5046.873828154326, 5053.747312634354, 5111.386633603955, 5118.820841270538, 5121.923171152435, 4207.705460617758, 4602.562756538124, 5404.0, 5433.293671822677, 5630.352509461423, 6132.508481341068, 6137.41694539018, 6149.077638354238, 6181.938180618226, 6211.47202487789, 5653.8586535336535, 5891.82163567284, 6238.2825975013, 6254.46837018854, 6256.249250090018, 4950.6782059166035, 5579.497845193952, 5772.855678608068, 5777.959967205943, 5799.101139323369, 6147.770445910835, 6161.075838624242, 6172.969135154295, 6203.0, 6238.1266622672865, 5259.289995850511, 5932.0, 6100.664463454553, 6116.122740413114, 6138.447539721446, 6179.443850053427, 6186.133941248228, 6188.690565471798, 6190.690465476709, 6202.503799696014, 5078.4413714491375, 5980.491658209014, 5988.251468566429, 6048.0, 6128.724207410677, 6096.980278560325, 6115.879294474695, 6132.448079672851, 6137.009281402767, 6139.907901381483, 4820.71075735457, 4834.709917404967, 4859.902801944012, 4884.462709101996, 4889.997550502138, 4363.258246098171, 4390.4511936008, 4399.406080179199, 4432.468103827497, 4443.0, 5784.2769653793275, 5785.392533783976, 5793.7392817323325, 5802.24570805801, 5806.709664516758, 6042.395760423922, 6119.571629985947, 6143.204841796972, 6237.719302631393, 6241.687915604201, 5707.3721890592005, 5769.567282453749, 5798.0, 5825.766969321265, 5829.387914269026, 5338.332708411449, 5382.67703937765, 5392.433794451605, 5396.83809485716, 5400.378956419983, 6203.348648391854, 6282.089097080989, 6289.811305660837, 6303.306636270098, 6310.11658367838, 6149.938500614937, 6163.013917773134, 6202.069689546604, 6266.686665666607, 6296.244450665949, 6295.055741638791, 6295.370462953668, 6300.9684951574945, 6312.6528040956355, 6323.841903952438, 5944.405559444021, 6186.072089186658, 6202.658853763086, 6206.875862482815, 6244.219472565929, 5139.203423469368, 5232.947670523246, 6112.381899552462, 6134.723937422916, 6178.320384757583, 5993.640381577119, 5995.580309378476, 6006.129111278928, 6014.248218972629, 6022.187004754477, 4919.581835543876, 5962.284525856925, 5964.373740757332, 5972.970135149297, 6005.849853753691, 5724.599278050497, 5741.598088133791, 5766.826995190151, 5817.825465236049, 5821.359650438364, 5970.402959703995, 6001.819945401645, 6005.1892994446935, 6037.0, 6039.909401359071, 5824.94175058244, 5849.94150058511, 5855.824325270249, 5862.443067908542, 5873.588848780544], "value": 5601.560609792507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.80926964326767, 448.8182286174099, 463.3281741474862, 486.7955458707344, 488.474889493794, 36715.816420917894, 38531.22937541248, 38975.02562435937, 39071.60928390715, 40846.18307633853, 39290.0177495562, 39895.601043989554, 39897.60102398975, 40063.39904901429, 40192.39711404331, 8272.83454330913, 8491.363147763943, 9117.635294588208, 9334.813303733921, 9348.345615806897, 10824.512896919618, 11200.271982321165, 11266.4366781661, 11349.886501134966, 11366.37484938328, 11067.72330691731, 11147.609833655824, 11153.832692509619, 11179.32924024557, 11180.217384783069, 11123.666290011271, 11146.386948717818, 11161.665150045512, 11211.047060999825, 11235.550577976872, 10988.615398461016, 11041.558337666484, 11057.723556911062, 11075.224734268604, 11085.889141108648, 37738.811305943294, 37893.0526736831, 38292.234155316735, 38324.61675383266, 38434.80782596097, 2976.776741744356, 3398.303347813692, 3423.8972830815114, 3605.296967091418, 3636.0, 28663.57004644932, 28812.0, 29507.377094259806, 29513.409731805245, 29619.70380296191, 3142.0, 3200.647928727838, 3213.1324542373663, 3339.465685490334, 3353.748468864845, 476165.0, 476994.0, 480069.0, 480974.0, 482234.0, 55693.164602531, 55874.72062639661, 55919.72040139855, 56057.0, 56185.15722264169, 48817.267740983916, 55775.0, 58525.0, 58553.414465854796, 58605.41394586085, 15239.933204675566, 15459.0, 15478.690426191413, 15479.922600386926, 15481.5355539334, 10815.513301901434, 11073.778524429466, 12002.75994480123, 12035.338056406981, 12321.260724356389, 14671.266436678123, 14877.553673389815, 14921.0, 14948.028378155384, 14971.0, 6764.526483146231, 6770.661466926634, 6782.0, 6810.727570897207, 6813.284605116491, 847.5887647067686, 952.8380175370204, 981.5028272624215, 1061.7345663584103, 1069.2194697870598, 28538.001169958952, 28866.0, 29218.853905730335, 29467.11598652044, 29499.55750663699, 1040.5109598488698, 1057.3233130796295, 1080.5353697909975, 1113.5991043224433, 1166.6091859227254, 14658.780118298235, 14996.775048374284, 15112.319945602474, 15351.462698805712, 15389.0, 584437.0, 673196.0, 709900.0, 713591.0, 725052.0, 39523.209535809125, 40444.393334100016, 45040.77479612647, 48915.75542122267, 49004.75497622489, 1111.3387534417009, 1333.8999575031912, 1346.8451128120196, 1356.6404902700594, 1361.7072329449215, 24792.38019049466, 25949.891654933625, 27143.86428067847, 27608.723912760615, 27839.86080069668, 41883.0, 42319.3652095225, 42330.0, 42370.0, 42543.5745642552, 486576.0, 514949.0, 519283.0, 521560.0, 522335.0, 22633.773662263167, 23020.884895575415, 23270.0, 23427.0, 23448.64827027562, 37022.44466333061, 37377.0, 37758.62241377661, 37977.62022379741, 38150.85547433581, 25603.6159457612, 28904.0, 32236.871709490057, 32372.35255294928, 35777.64222357743, 27905.0, 32898.02667622901, 33051.504227436126, 33549.16127096842, 34243.65756342404, 32656.183595410304, 33002.17494562559, 33248.836290729705, 33253.16867078342, 33527.49708754322, 23188.652170217123, 27904.0, 30079.94720184783, 30150.54774178433, 30153.0, 19365.612687745885, 22843.543129137655, 23185.536289274456, 23552.293431197093, 23701.762982370645], "value": 18737.810786435086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.0242664725881, 341.6998321387123, 343.9903882106021, 379.6014185105639, 379.98290076946535, 18499.722504162433, 18766.53083672909, 19241.615167696655, 19739.0, 20203.292884749037, 11568.884311156886, 13701.794473082888, 19147.32984345548, 19408.320708775194, 19500.512487187792, 5042.142835717937, 5294.814681486148, 5300.814471493499, 5308.787648494055, 5314.92027619586, 3797.905052373685, 5229.37247530295, 5238.895222095575, 5992.43071908168, 6025.457708806207, 6040.879182416349, 6046.727897244635, 6067.393260673919, 6067.423594758513, 6081.6351018938785, 6041.486473649723, 6049.455549000589, 6323.74705011799, 6350.333215012403, 6362.2365316161895, 5382.757775900094, 5632.07070833312, 5634.098544232944, 5641.943580564182, 5651.632643878176, 20199.79800201994, 20524.897375513177, 20527.0, 22199.556008879732, 22797.316080517612, 2134.935951921445, 2213.5904857601395, 2287.9885600572056, 2497.675302210719, 2800.0, 9625.903740962642, 9665.178459830922, 9811.705648830546, 10203.336783109075, 10203.693889183336, 1822.5261432027635, 1874.7843997940138, 1893.5171531259577, 1894.9242030318908, 1898.9240430382767, 109473.0, 111754.0, 114402.42798786036, 115251.42374288158, 116679.0, 11311.773764524663, 11401.144914131473, 11539.711507212387, 11678.824817627743, 11698.94150529242, 14300.785488217685, 14398.85601143996, 14448.783268250985, 14456.927715361357, 14526.346314415876, 6636.900446493307, 8287.0, 8339.708110216114, 8357.620992536164, 8505.53219572917, 8143.348532117417, 8161.20453500229, 8328.500289982621, 8332.458390204618, 8395.118512556215, 4311.159323931804, 4446.888827779331, 4461.152381047591, 4535.63714902807, 4549.408576884984, 1560.4148444333375, 1705.155947805844, 1872.5225067607946, 1926.9421917342222, 1935.2132928582796, 685.4653370371118, 812.7358608452158, 882.1927935938672, 945.716285114463, 985.9901400986042, 17887.56899448041, 18357.541061473305, 19764.308249211208, 21029.843358615424, 21376.0, 709.7835160276165, 861.5132450165636, 902.7066203483894, 913.0960349254191, 923.9076092390842, 8117.0, 10992.120630349553, 11089.83365249522, 11143.442827858575, 11160.330380177214, 521455.0, 522014.7798522042, 534085.0, 546953.0, 547619.0, 121369.78630213585, 123067.76932230563, 124197.0, 124818.37590811988, 125565.0, 931.3247895276006, 963.556763888605, 988.9851652225078, 1019.5412064570972, 1024.3546565663733, 16609.66780664404, 17070.061146637054, 19030.42908712741, 19426.805731943066, 19486.22055117836, 53597.73201133969, 54038.72980635072, 55205.723971379884, 55494.72252638872, 55573.0, 74588.62705686437, 77302.61348693221, 77353.61323193349, 79447.0, 79829.60085199536, 7498.887516687363, 7695.268949449794, 7946.562939038177, 8000.83998320042, 8061.355091592776, 11109.666709998713, 11741.941290293495, 12305.384730763248, 12392.504299827906, 12411.317377544321, 9341.757978085076, 9818.067283608047, 10523.842142367717, 10557.683269501927, 10670.0, 8481.40630155883, 8664.960204775467, 9494.145526902612, 9531.666391676257, 9554.61781528731, 5843.094320380348, 7328.890066649111, 8953.328500362368, 9134.310152621787, 11045.558177673125, 6282.403171698681, 7744.225577442211, 7876.448648594544, 8062.234087761653, 8088.555129467701, 8440.366972477212, 10051.145652619609, 10542.947285263524, 10819.891801081889, 10853.782924341627], "value": 9056.561451006952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.5987423835732, 1481.4592673674108, 1633.7386018237078, 1649.6288335124598, 1792.9013904235262, 6701.564398314118, 7729.458937874337, 7993.0, 8427.789305267364, 8445.366597505188, 6883.79348619541, 7926.28663420292, 8218.712345067925, 8366.874496882552, 8368.832623347529, 2287.736910255317, 2316.5019520803025, 2323.581755284048, 2329.9184528541505, 2331.4870728439714, 2315.5947709150914, 2342.4612339162004, 2349.776771206741, 2355.505343877779, 2355.6231003039516, 2287.7025986621798, 2289.7710228977053, 2313.5141620259765, 2317.629179331307, 2319.8724070176136, 2262.8416010879164, 2276.943076423086, 2283.041122728458, 2292.1633603734685, 2292.9770702293013, 2301.6432452969816, 2320.988395058014, 2330.4057465346227, 2332.54515369503, 2333.9649905251435, 8245.670173193064, 8306.127856575033, 8384.371172162113, 8398.958005209935, 8459.900212972274, 5034.14419548674, 5185.559227465632, 5211.088059589594, 5211.42674305826, 5216.765245563959, 3254.8372581371073, 3392.8633907640724, 3537.8678822776724, 3547.840347184357, 3559.91422616102, 1002.4386343647581, 1036.6786296248188, 1068.4871261794306, 1069.107295408335, 1077.8275475923892, 10661.626843060456, 10711.250212485129, 10721.571137154582, 10797.784044319149, 10807.0, 3893.5717071122153, 4344.370066340426, 4425.911481770347, 4521.706089104197, 4629.444466663955, 9254.0, 9351.625934962525, 9385.5307234638, 9385.671501497414, 9395.342326037111, 5183.663061900965, 5213.635045546851, 5213.765380557808, 5215.400228973641, 5231.973840130775, 3565.4830049642655, 4254.255505286563, 4402.911941761146, 4681.882952926136, 4781.995780885984, 3767.9246415072093, 3787.242551489658, 3840.8655697050467, 3878.3988481784804, 3891.9416208756893, 1255.0649765924445, 1268.9175203611735, 1271.167385362589, 1271.8219449277108, 1278.654763213927, 818.6234332207132, 879.6481407437076, 901.1394118616705, 924.0851556958563, 939.4691999020531, 4759.881002974884, 5239.716269513993, 5766.509846662997, 5773.826785196451, 5782.306123265151, 354.91304630365727, 417.0366453492442, 417.63039709857, 420.445012583387, 442.5530214483331, 3821.5796262411113, 3845.576986531479, 3891.1828516011387, 3933.4296527004, 3962.445257663929, 9519.809603808024, 9867.901320986843, 9960.053794889474, 10028.997100289913, 10060.0, 9646.662366817269, 9719.854202186973, 9921.454320012324, 9927.453990030474, 9954.751131221778, 7332.156801967842, 7654.119776225582, 7709.0749110107145, 7782.6886924523515, 7795.298423141944, 5821.825345239649, 5831.533477321889, 5874.911876321944, 5928.614640048383, 5953.315368732651, 7122.465815063994, 7568.962155189189, 8592.957035214784, 9011.63953441855, 9315.301352398461, 7753.806154845948, 9332.626694932398, 9411.858822117536, 9483.099105584959, 9521.714348569554, 6553.836154095995, 6796.728130874907, 6882.8623427532175, 7075.610841403773, 7255.0, 6895.275996020547, 7890.763277101696, 7895.68417263303, 7895.960520197362, 7966.203379661987, 6950.826229344105, 7057.470689698191, 7059.858802824017, 7107.253738357398, 7191.352778249982, 5964.373740757158, 6787.694553745192, 6891.827704307432, 6992.825179370557, 7034.191068027242, 6552.57408268461, 6639.4688424924925, 6691.330866913269, 6701.296363881917, 6704.0, 4806.206975848946, 4872.0, 4911.214205727209, 4930.728809915489, 4994.550490455877, 4180.912962629677, 4787.970586323957, 4882.389701287339, 4889.19328310839, 5033.345665063518], "value": 4272.357271271026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.94400895856666, 351.89267273481585, 355.75452937473125, 361.3567849228373, 370.9703223742099, 4569.748663823489, 5017.42299635542, 5117.5650069744115, 5258.4215736269025, 5359.464053594638, 4261.4673165854265, 4380.678240532523, 4418.896174917975, 5242.580593552516, 5325.162818827508, 3940.6847452203756, 4156.958430415695, 4169.749815011094, 4181.874543763692, 4203.453551038361, 3964.484616999786, 4153.501579810427, 4163.666906647476, 4176.68674849386, 4176.914002359378, 4113.650339721127, 4117.423560701489, 4120.917581648365, 4122.50529936408, 4130.607592278729, 3667.4877708769445, 3926.6073392660505, 4070.409790580349, 4115.156392939441, 4116.0, 3110.3001824589514, 3245.1238165695368, 3631.364511210528, 3633.7638053526703, 3636.5636123665063, 4926.507349265081, 5177.430482646906, 5181.5077567631015, 5203.464977831549, 5214.904869977309, 4776.904461910743, 4800.303955926406, 4822.204336284509, 4835.806567737286, 4891.4863939286215, 4631.0, 5416.620836541444, 5674.829755107354, 5704.917705037631, 5718.71406429681, 3747.606501317377, 3910.002949247952, 3988.1824226033596, 3991.2616166009093, 4051.703454894435, 5015.548600625924, 5206.479352064764, 5471.06991811393, 5632.549396048306, 5859.882802343972, 4044.373122166069, 4117.958820411757, 4145.0, 4164.562720914321, 4187.890209094592, 3529.717622590238, 3975.980120099381, 4021.2926854583798, 4220.978895105566, 4240.830366785356, 3822.1782316801464, 4247.426597409372, 4770.499097594772, 4811.821103829514, 4821.059893320768, 4837.7097374157665, 5300.660583832161, 5636.18275350072, 5663.830085097454, 5670.518005969457, 1224.3388570172008, 1231.5344739759657, 1288.0082336600951, 1333.4666133546466, 1389.124851343647, 784.4704824243613, 854.974350769478, 906.977325566866, 962.2686758063921, 976.82417164911, 4262.680298977589, 4291.570842915746, 4740.976295118502, 4899.363082799213, 5034.546890779848, 4411.523110969402, 4689.343491911135, 4936.333594964705, 5444.515510073477, 5582.637128586629, 4777.976110119496, 4984.700917944862, 4986.576141028053, 4996.4503904570465, 5057.898842023139, 2624.9893790890264, 2754.228815931542, 2808.0, 2870.956935645967, 2896.942061158807, 4381.627561657295, 5162.845114646567, 5489.258950041693, 5658.991058174372, 5694.743736531866, 4923.433805112458, 5114.335136432314, 5289.497497737709, 5584.804531841366, 5641.8589535261945, 5059.873503162303, 5571.247881535941, 5667.858303542444, 5668.943310566924, 5683.0, 4467.776611169494, 4796.184648609815, 4941.282294737808, 5410.648307860134, 5448.182772584144, 5167.896642067213, 5176.844694659167, 5322.9467705324, 5450.509454149145, 5496.477834605706, 5044.974775126101, 5112.3865136183895, 5128.0000399921655, 5239.869003274796, 5606.972234993058, 3542.096765324826, 3582.820858957094, 3584.9245226431444, 3853.8073096345634, 3940.8029598520534, 4763.476017638126, 5153.587712983027, 5379.892402152013, 5385.40760516335, 5417.241586178017, 4474.79863406154, 4623.445186577632, 4998.175301075427, 5115.514026167508, 5263.605059697905, 4946.777395017305, 4992.825251116194, 5119.385673719177, 5232.1628539433505, 5298.390685071112, 4219.240536703423, 4801.375821143229, 4812.807487700453, 5352.437994010573, 5436.972815135899, 4976.950230497649, 5190.766415511235, 5364.76183814782, 5554.861128471821, 5596.3284405871555, 4774.164521208844, 5208.713520756395, 5429.267048948342, 5446.537044351275, 5482.205080263259], "value": 4011.0157593572235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.9792706218813, 739.452804924356, 780.7072347869549, 786.8386980668963, 792.7383963292115, 14627.926860365696, 15459.0, 15522.991005584629, 15532.145731984736, 15543.844561554395, 13955.581332560014, 14095.577132686036, 14110.082844615094, 14128.728414442698, 14141.222232777192, 691.0774116554394, 713.2297119111373, 829.6888666749969, 867.2368315882046, 891.8840550728396, 867.9392442529025, 879.9880137841469, 882.7748924024365, 882.8013696918206, 885.5041176940902, 936.3819878879941, 944.4050248343534, 948.1656142594508, 949.9952500237489, 950.8858936927544, 913.6528119314685, 930.6044930904372, 940.1350757303297, 940.6237504997987, 940.7177846645978, 669.357416879796, 695.3533214110874, 698.4028655499526, 702.2240424331092, 702.9789106326818, 11172.0, 11222.66332010041, 12138.878611213862, 13515.932420337933, 15049.849501505063, 11666.0, 12978.221306721533, 14064.929675351661, 14315.928420357935, 14379.640508987255, 10084.546195421224, 11118.444077796077, 11765.823512647317, 11780.764384712258, 11953.043756499459, 3131.373725254958, 3665.505156803824, 3666.7178271008224, 3697.593264740903, 3728.776273423576, 100513.49743251236, 103869.0, 108964.0, 114558.85441145566, 114977.0, 10675.145988320915, 10899.83650245247, 10925.125989920787, 11007.834882476769, 11315.377654229096, 19593.706094408597, 20611.58776824455, 20651.96740162986, 22361.664575031387, 22404.10383584671, 7859.921400786034, 7930.682772689143, 8050.033995920527, 8121.634526446324, 8197.0, 4303.698741088157, 4397.362382454527, 4445.977770111129, 4471.6646251531265, 4557.361969324297, 3233.9029829105166, 3588.318219538279, 3650.963490365062, 3679.319325924659, 3690.501782259414, 650.7559665125578, 653.4706887421204, 654.0352979355508, 658.8352911772057, 674.9831254218684, 519.0638916840207, 553.5765139668157, 560.0702833296708, 638.6966191059303, 640.3756337570924, 8841.823163536694, 9310.767230819283, 9457.33798634089, 9457.716268511818, 9733.075357840993, 544.861060429588, 610.7343305662051, 618.5082859127004, 643.8454770855054, 681.5672048249298, 4353.738775673406, 4472.195004899149, 4585.679002469862, 4616.28447590624, 4707.435107787088, 93970.0, 95298.57052144223, 96016.51991740137, 99157.0, 101205.98794012112, 73307.0, 75053.0, 86655.0, 86782.13217867867, 88906.0, 76310.0, 76833.61583192048, 79368.60315698385, 80916.0, 82356.76464853033, 9239.307051971264, 9699.389618536681, 10103.646372376932, 10122.645707400206, 10246.590136394461, 51078.23382649189, 51600.74199628978, 51961.7401912988, 52676.20985685295, 53925.0, 54576.0, 57680.42319576918, 68504.6574767123, 78579.60710196412, 78761.0, 13147.474101035852, 13354.465821367425, 13686.384112714753, 13718.45126194941, 13810.585682429542, 15024.924875375991, 15351.539453816404, 15673.529794106194, 15673.921630391775, 15896.0, 13680.794788078387, 13875.236861972284, 14043.789343160066, 14520.346584403516, 14557.27213639335, 13235.933820330836, 13844.515441959484, 13890.86109138936, 14233.786493202404, 14340.928295358457, 13222.4049917752, 13812.792808107686, 13813.852577437563, 13891.305434728021, 14386.280685965869, 8895.332850036402, 9321.766955826159, 11337.149713771336, 11460.82808757886, 11894.881051189723, 9899.950500247453, 10276.691699249035, 10543.31468454548, 11433.714157146138, 11719.296842189155], "value": 7431.354493604375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 172.0, 163.0, 116.0, 119.0, 114.0, 115.0, 117.0, 119.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 145.0, 189.0, 117.0, 117.0, 118.0, 121.0, 135.0, 144.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 205.0, 206.0, 203.0, 192.0, 198.0, 197.0, 196.0, 194.0, 196.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 85.0, 60.0, 63.0, 82.0, 65.0, 100.0, 83.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 83.0, 73.0, 86.0, 101.0, 116.0, 99.0, 71.0, 81.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 111.0, 135.0, 117.0, 103.0, 167.0, 162.0, 166.0, 136.0], "value": 132.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 97.0, 96.0, 98.0, 94.0, 97.0, 119.0, 153.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 91.0, 99.0, 144.0, 144.0, 92.0, 93.0, 92.0, 93.0, 83.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 57.0, 60.0, 60.0, 60.0, 61.0, 61.0, 65.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 75.0, 81.0, 71.0, 68.0, 68.0, 71.0, 71.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 122.0, 116.0, 93.0, 94.0, 95.0, 96.0, 139.0, 113.0], "value": 104.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 156.0, 162.0, 139.0, 151.0, 137.0, 158.0, 169.0, 162.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 172.0, 239.0, 242.0, 183.0, 178.0, 178.0, 177.0, 179.0, 193.0], "value": 192.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 90.0, 88.0, 70.0, 65.0, 63.0, 68.0, 70.0, 71.0, 65.0], "value": 71.3, "unit": "score"}]}]} 06:06:44 INFO - Return code: 0 06:06:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:44 ERROR - # TBPL SUCCESS # 06:06:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:44 INFO - 2016-12-09 06:06:44.611 screenresolution[1658:11066] starting screenresolution argv=screenresolution get 06:06:44 INFO - 2016-12-09 06:06:44.613 screenresolution[1658:11066] Display 0: 1600x1200x32@60 06:06:44 INFO - 2016-12-09 06:06:44.619 screenresolution[1659:11069] starting screenresolution argv=screenresolution list 06:06:44 INFO - Available Modes on Display 0 06:06:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:44 INFO - Intel Iris: 06:06:44 INFO - Chipset Model: Intel Iris 06:06:44 INFO - Type: GPU 06:06:44 INFO - Bus: Built-In 06:06:44 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:44 INFO - Vendor: Intel (0x8086) 06:06:44 INFO - Device ID: 0x0a2e 06:06:44 INFO - Revision ID: 0x0009 06:06:44 INFO - Displays: 06:06:44 INFO - Display: 06:06:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:44 INFO - Display Serial Number: 1600x1200 60 06:06:44 INFO - Main Display: Yes 06:06:44 INFO - Mirror: Off 06:06:44 INFO - Online: Yes 06:06:44 INFO - Rotation: Supported 06:06:44 INFO - Return code: 0 06:06:44 INFO - Running post-action listener: _resource_record_post_action 06:06:44 INFO - [mozharness: 2016-12-09 14:06:44.852595Z] Finished run-tests step (success) 06:06:44 INFO - Running post-run listener: _resource_record_post_run 06:06:44 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 34505216; Write bytes: 553988608; Read time: 317; Write time: 2304 06:06:44 INFO - TinderboxPrint: CPU usage
54.8% 06:06:44 INFO - TinderboxPrint: I/O read bytes / time
34,505,216 / 317 06:06:44 INFO - TinderboxPrint: I/O write bytes / time
553,988,608 / 2,304 06:06:44 INFO - TinderboxPrint: CPU idle
2,175.6 (45.2%) 06:06:44 INFO - TinderboxPrint: CPU system
972.7 (20.2%) 06:06:44 INFO - TinderboxPrint: CPU user
1,661.4 (34.5%) 06:06:44 INFO - TinderboxPrint: Swap in / out
279,805,952 / 0 06:06:44 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241154560; Write bytes: 235956224; Read time: 18221; Write time: 481 06:06:44 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 32535040; Write bytes: 300415488; Read time: 296; Write time: 1783 06:06:45 INFO - Running post-run listener: _upload_blobber_files 06:06:45 INFO - Blob upload gear active. 06:06:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:06:45 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'] 06:06:45 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 06:06:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:46 INFO - (blobuploader) - INFO - Done attempting. 06:06:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:47 INFO - (blobuploader) - INFO - Done attempting. 06:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:50 INFO - (blobuploader) - INFO - Done attempting. 06:06:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:50 INFO - Return code: 0 06:06:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9c834fa8c65952d6a5fbc6a124b5788ae1ad05a96f8b09b9ea5858169cb8295442b8546d63ab4fc1ae46989337f4d28085a39e9b704c7c18d9ad0233fb2f132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/177cdcdc1bce1abbb3a9c42efea6856d35dc5fe4ea0d9bb9d517055c65e66efbde9032c03a4a77c0353e1d434d04e6bb38d18752b5ca43eedbe154eb9b805320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4200558b977c52b5b3a337858a2cb3e3aeba4a1b4dbd092b2ea97f5d7575bfce8b36d0a6c97a3677b29ed7447b806d76c62f570f9a0f1b987d0a4e64fd1326c"} 06:06:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:50 INFO - Contents: 06:06:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9c834fa8c65952d6a5fbc6a124b5788ae1ad05a96f8b09b9ea5858169cb8295442b8546d63ab4fc1ae46989337f4d28085a39e9b704c7c18d9ad0233fb2f132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/177cdcdc1bce1abbb3a9c42efea6856d35dc5fe4ea0d9bb9d517055c65e66efbde9032c03a4a77c0353e1d434d04e6bb38d18752b5ca43eedbe154eb9b805320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4200558b977c52b5b3a337858a2cb3e3aeba4a1b4dbd092b2ea97f5d7575bfce8b36d0a6c97a3677b29ed7447b806d76c62f570f9a0f1b987d0a4e64fd1326c"} 06:06:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:50 INFO - Copying logs to upload dir... 06:06:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.391928 ========= master_lag: 0.98 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-09 06:06:51.161825) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-12-09 06:06:51.167751) ========= 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.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/c9c834fa8c65952d6a5fbc6a124b5788ae1ad05a96f8b09b9ea5858169cb8295442b8546d63ab4fc1ae46989337f4d28085a39e9b704c7c18d9ad0233fb2f132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/177cdcdc1bce1abbb3a9c42efea6856d35dc5fe4ea0d9bb9d517055c65e66efbde9032c03a4a77c0353e1d434d04e6bb38d18752b5ca43eedbe154eb9b805320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4200558b977c52b5b3a337858a2cb3e3aeba4a1b4dbd092b2ea97f5d7575bfce8b36d0a6c97a3677b29ed7447b806d76c62f570f9a0f1b987d0a4e64fd1326c"} build_url:https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/L8gcCvOWTvqj_GwtcMQ4vQ/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9c834fa8c65952d6a5fbc6a124b5788ae1ad05a96f8b09b9ea5858169cb8295442b8546d63ab4fc1ae46989337f4d28085a39e9b704c7c18d9ad0233fb2f132", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/177cdcdc1bce1abbb3a9c42efea6856d35dc5fe4ea0d9bb9d517055c65e66efbde9032c03a4a77c0353e1d434d04e6bb38d18752b5ca43eedbe154eb9b805320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4200558b977c52b5b3a337858a2cb3e3aeba4a1b4dbd092b2ea97f5d7575bfce8b36d0a6c97a3677b29ed7447b806d76c62f570f9a0f1b987d0a4e64fd1326c"}' ========= master_lag: 1.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-12-09 06:06:52.386429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-12-09 06:06:52.386764) ========= 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.XGFtFdyUoF/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.YmrE2HseGV/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005193 ========= master_lag: 4.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-12-09 06:06:56.533035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 06:06:56.533431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 06:06:56.559238) ========= ========= Total master_lag: 6.43 =========