builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1485971273.52 results: success (0) buildid: 20170201082708 builduid: 7500aa1ef7b54f48a609f26d83c96a86 revision: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.523156) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.523590) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.523872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.548998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.549285) ========= 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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-01 09:47:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 34.8M=0s 2017-02-01 09:47:53 (34.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.694778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.695096) ========= 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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.024551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:53.746890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 09:47:53.750235) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4f2c6889112c9f7e4d3edd2cec93e6ced66270d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4f2c6889112c9f7e4d3edd2cec93e6ced66270d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-01 09:47:53,859 truncating revision to first 12 chars 2017-02-01 09:47:53,859 Setting DEBUG logging. 2017-02-01 09:47:53,859 attempt 1/10 2017-02-01 09:47:53,859 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a4f2c6889112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 09:47:54,946 unpacking tar archive at: mozilla-aurora-a4f2c6889112/testing/mozharness/ program finished with exit code 0 elapsedTime=1.360550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 09:47:55.133483) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:55.133808) ========= script_repo_revision: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:55.137217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:55.137493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:55.156731) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-01 09:47:55.157009) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:47:55 INFO - MultiFileLogger online at 20170201 09:47:55 in /builds/slave/test 09:47:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:55 INFO - {'append_to_log': False, 09:47:55 INFO - 'base_work_dir': '/builds/slave/test', 09:47:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:55 INFO - 'branch': 'Mozilla-Aurora', 09:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:55 INFO - 'config_files': ('talos/mac_config.py',), 09:47:55 INFO - 'default_actions': ('clobber', 09:47:55 INFO - 'read-buildbot-config', 09:47:55 INFO - 'download-and-extract', 09:47:55 INFO - 'populate-webroot', 09:47:55 INFO - 'create-virtualenv', 09:47:55 INFO - 'install', 09:47:55 INFO - 'run-tests'), 09:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:55 INFO - 'download_minidump_stackwalk': True, 09:47:55 INFO - 'download_symbols': 'ondemand', 09:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:55 INFO - 'installer_path': 'installer.exe', 09:47:55 INFO - 'log_level': 'info', 09:47:55 INFO - 'log_name': 'talos', 09:47:55 INFO - 'log_to_console': True, 09:47:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:47:55 INFO - 'opt_config_files': (), 09:47:55 INFO - 'pip_index': False, 09:47:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:55 INFO - 'cmd': ('bash', 09:47:55 INFO - '-c', 09:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:55 INFO - 'enabled': True, 09:47:55 INFO - 'halt_on_failure': False, 09:47:55 INFO - 'name': 'check_screen_resolution'},), 09:47:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:55 INFO - 'cmd': ('bash', 09:47:55 INFO - '-c', 09:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:55 INFO - 'enabled': True, 09:47:55 INFO - 'halt_on_failure': False, 09:47:55 INFO - 'name': 'check_screen_resolution'},), 09:47:55 INFO - 'run_cmd_checks_enabled': True, 09:47:55 INFO - 'sps_profile': False, 09:47:55 INFO - 'sps_profile_interval': 0, 09:47:55 INFO - 'suite': 'dromaeojs-e10s', 09:47:55 INFO - 'system_bits': '32', 09:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:55 INFO - 'title': 't-yosemite-r7-0320', 09:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:55 INFO - 'use_talos_json': True, 09:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:55 INFO - 'work_dir': 'build'} 09:47:55 INFO - [mozharness: 2017-02-01 17:47:55.374301Z] Running clobber step. 09:47:55 INFO - Running pre-action listener: _resource_record_pre_action 09:47:55 INFO - Running main action method: clobber 09:47:55 INFO - rmtree: /builds/slave/test/build 09:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - [mozharness: 2017-02-01 17:47:57.821937Z] Finished clobber step (success) 09:47:57 INFO - [mozharness: 2017-02-01 17:47:57.822068Z] Running read-buildbot-config step. 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: read_buildbot_config 09:47:57 INFO - Using buildbot properties: 09:47:57 INFO - { 09:47:57 INFO - "project": "", 09:47:57 INFO - "product": "firefox", 09:47:57 INFO - "script_repo_revision": "production", 09:47:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:47:57 INFO - "repository": "", 09:47:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:47:57 INFO - "buildid": "20170201082708", 09:47:57 INFO - "pgo_build": "False", 09:47:57 INFO - "basedir": "/builds/slave/test", 09:47:57 INFO - "buildnumber": 42, 09:47:57 INFO - "slavename": "t-yosemite-r7-0320", 09:47:57 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:47:57 INFO - "platform": "yosemite_r7", 09:47:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:47:57 INFO - "branch": "mozilla-aurora", 09:47:57 INFO - "repo_path": "releases/mozilla-aurora", 09:47:57 INFO - "revision": "a4f2c6889112c9f7e4d3edd2cec93e6ced66270d", 09:47:57 INFO - "stage_platform": "macosx64", 09:47:57 INFO - "builduid": "7500aa1ef7b54f48a609f26d83c96a86", 09:47:57 INFO - "slavebuilddir": "test" 09:47:57 INFO - } 09:47:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - [mozharness: 2017-02-01 17:47:57.825446Z] Finished read-buildbot-config step (success) 09:47:57 INFO - [mozharness: 2017-02-01 17:47:57.825577Z] Running download-and-extract step. 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: download_and_extract 09:47:57 INFO - mkdir: /builds/slave/test/build/tests 09:47:57 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')]} 09:47:57 INFO - trying https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:47:57 INFO - Downloading https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:47:58 INFO - Downloaded 1199 bytes. 09:47:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:47:58 INFO - Using the following test package requirements: 09:47:58 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:47:58 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:47:58 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:47:58 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'jsshell-mac.zip'], 09:47:58 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:47:58 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:47:58 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:47:58 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:47:58 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:47:58 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:47:58 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:47:59 INFO - Expected file size: 16354738 09:47:59 INFO - Obtained file size: 16354738 09:48:06 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:48:07 INFO - Expected file size: 16354738 09:48:07 INFO - Obtained file size: 16354738 09:48:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:48:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:48:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:48:15 INFO - Expected file size: 14403485 09:48:15 INFO - Obtained file size: 14403485 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - trying https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:15 INFO - Downloading https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:48:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:48:17 INFO - Downloaded 73846347 bytes. 09:48:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:17 INFO - mkdir: /builds/slave/test/properties 09:48:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:17 INFO - Contents: 09:48:17 INFO - build_url:https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:48:18 INFO - Running post-action listener: _resource_record_post_action 09:48:18 INFO - Running post-action listener: set_extra_try_arguments 09:48:18 INFO - [mozharness: 2017-02-01 17:48:18.337518Z] Finished download-and-extract step (success) 09:48:18 INFO - [mozharness: 2017-02-01 17:48:18.337675Z] Running populate-webroot step. 09:48:18 INFO - Running pre-action listener: _resource_record_pre_action 09:48:18 INFO - Running main action method: populate_webroot 09:48:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:18 INFO - '--tppagecycles', 09:48:18 INFO - '7'], 09:48:18 INFO - 'tests': ['tsvgm']}}, 09:48:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['damp', 'tps']}, 09:48:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'tests': ['damp', 'tps']}, 09:48:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['dromaeo_dom']}, 09:48:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['basic_compositor_video']}, 09:48:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['a11yr', 09:48:18 INFO - 'ts_paint', 09:48:18 INFO - 'tpaint', 09:48:18 INFO - 'sessionrestore', 09:48:18 INFO - 'sessionrestore_no_auto_restore', 09:48:18 INFO - 'tabpaint']}, 09:48:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['tsvgx', 09:48:18 INFO - 'tsvgr_opacity', 09:48:18 INFO - 'tart', 09:48:18 INFO - 'tscrollx', 09:48:18 INFO - 'cart', 09:48:18 INFO - 'tsvg_static']}, 09:48:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:18 INFO - 'tsvgr_opacity', 09:48:18 INFO - 'tart', 09:48:18 INFO - 'tscrollx', 09:48:18 INFO - 'cart', 09:48:18 INFO - 'tsvg_static']}, 09:48:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'talos_options': ['--disable-e10s'], 09:48:18 INFO - 'tests': ['tp5o']}, 09:48:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:48:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'talos_options': ['--disable-e10s', 09:48:18 INFO - '--xperf_path', 09:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:18 INFO - 'tests': ['tp5n']}, 09:48:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:48:18 INFO - 'talos_options': ['--xperf_path', 09:48:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:18 INFO - 'tests': ['tp5n']}}, 09:48:18 INFO - 'talos.zip': {'path': '', 09:48:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:18 INFO - Running post-action listener: _resource_record_post_action 09:48:18 INFO - [mozharness: 2017-02-01 17:48:18.356099Z] Finished populate-webroot step (success) 09:48:18 INFO - [mozharness: 2017-02-01 17:48:18.356251Z] Running create-virtualenv step. 09:48:18 INFO - Running pre-action listener: _resource_record_pre_action 09:48:18 INFO - Running main action method: create_virtualenv 09:48:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:18 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 09:48:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:18 INFO - Using real prefix '/tools/python27' 09:48:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:22 INFO - Installing pip.................done. 09:48:22 INFO - Return code: 0 09:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:22 INFO - Reading from file tmpfile_stdout 09:48:22 INFO - Output received: 09:48:22 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) 09:48:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48: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', 'pip>=1.5'] in /builds/slave/test/build 09:48: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 pip>=1.5 09:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:22 INFO - 'HOME': '/Users/cltbld', 09:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:22 INFO - 'LOGNAME': 'cltbld', 09:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:22 INFO - 'MOZ_NO_REMOTE': '1', 09:48:22 INFO - 'NO_EM_RESTART': '1', 09:48:22 INFO - 'PAGER': '/bin/cat', 09:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:22 INFO - 'PWD': '/builds/slave/test', 09:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:22 INFO - 'SHELL': '/bin/bash', 09:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:22 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:22 INFO - 'USER': 'cltbld', 09:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:22 INFO - 'XPC_FLAGS': '0x0', 09:48:22 INFO - 'XPC_SERVICE_NAME': '0', 09:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:22 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 09:48:22 INFO - Cleaning up... 09:48:22 INFO - Return code: 0 09:48:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', '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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:48: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 psutil>=3.1.1 09:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:22 INFO - 'HOME': '/Users/cltbld', 09:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:22 INFO - 'LOGNAME': 'cltbld', 09:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:22 INFO - 'MOZ_NO_REMOTE': '1', 09:48:22 INFO - 'NO_EM_RESTART': '1', 09:48:22 INFO - 'PAGER': '/bin/cat', 09:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:22 INFO - 'PWD': '/builds/slave/test', 09:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:22 INFO - 'SHELL': '/bin/bash', 09:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:22 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:22 INFO - 'USER': 'cltbld', 09:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:22 INFO - 'XPC_FLAGS': '0x0', 09:48:22 INFO - 'XPC_SERVICE_NAME': '0', 09:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:22 INFO - Downloading/unpacking psutil>=3.1.1 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:26 INFO - Installing collected packages: psutil 09:48:26 INFO - Running setup.py install for psutil 09:48:26 INFO - building 'psutil._psutil_osx' extension 09:48:26 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 09:48:27 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 09:48:27 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 09:48:27 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 09:48:27 INFO - building 'psutil._psutil_posix' extension 09:48:27 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 09:48:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:48:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:48:27 INFO - ^ 09:48:27 INFO - 1 warning generated. 09:48:27 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 09:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:27 INFO - Successfully installed psutil 09:48:27 INFO - Cleaning up... 09:48:27 INFO - Return code: 0 09:48:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:27 INFO - 'HOME': '/Users/cltbld', 09:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:27 INFO - 'LOGNAME': 'cltbld', 09:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:27 INFO - 'MOZ_NO_REMOTE': '1', 09:48:27 INFO - 'NO_EM_RESTART': '1', 09:48:27 INFO - 'PAGER': '/bin/cat', 09:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:27 INFO - 'PWD': '/builds/slave/test', 09:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:27 INFO - 'SHELL': '/bin/bash', 09:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:27 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:27 INFO - 'USER': 'cltbld', 09:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:27 INFO - 'XPC_FLAGS': '0x0', 09:48:27 INFO - 'XPC_SERVICE_NAME': '0', 09:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:30 INFO - Installing collected packages: mozsystemmonitor 09:48:30 INFO - Running setup.py install for mozsystemmonitor 09:48:30 INFO - Successfully installed mozsystemmonitor 09:48:30 INFO - Cleaning up... 09:48:30 INFO - Return code: 0 09:48:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:30 INFO - 'HOME': '/Users/cltbld', 09:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PAGER': '/bin/cat', 09:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:30 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - 'XPC_FLAGS': '0x0', 09:48:30 INFO - 'XPC_SERVICE_NAME': '0', 09:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:34 INFO - warning: no files found matching '*.txt' 09:48:34 INFO - no previously-included directories found matching 'build' 09:48:34 INFO - no previously-included directories found matching 'dist' 09:48:34 INFO - no previously-included directories found matching '.git*' 09:48:34 INFO - Installing collected packages: jsonschema, functools32 09:48:34 INFO - Running setup.py install for functools32 09:48:34 INFO - warning: no files found matching '*.txt' 09:48:34 INFO - no previously-included directories found matching 'build' 09:48:34 INFO - no previously-included directories found matching 'dist' 09:48:34 INFO - no previously-included directories found matching '.git*' 09:48:34 INFO - Successfully installed jsonschema functools32 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48:34 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')]} 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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')]} 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:34 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 09:48:34 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 09:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:34 INFO - 'HOME': '/Users/cltbld', 09:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:34 INFO - 'LOGNAME': 'cltbld', 09:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:34 INFO - 'MOZ_NO_REMOTE': '1', 09:48:34 INFO - 'NO_EM_RESTART': '1', 09:48:34 INFO - 'PAGER': '/bin/cat', 09:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:34 INFO - 'PWD': '/builds/slave/test', 09:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:34 INFO - 'SHELL': '/bin/bash', 09:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:34 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:34 INFO - 'USER': 'cltbld', 09:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:34 INFO - 'XPC_FLAGS': '0x0', 09:48:34 INFO - 'XPC_SERVICE_NAME': '0', 09:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:34 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')]} 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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')]} 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:34 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 09:48:34 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 09:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:34 INFO - 'HOME': '/Users/cltbld', 09:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:34 INFO - 'LOGNAME': 'cltbld', 09:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:34 INFO - 'MOZ_NO_REMOTE': '1', 09:48:34 INFO - 'NO_EM_RESTART': '1', 09:48:34 INFO - 'PAGER': '/bin/cat', 09:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:34 INFO - 'PWD': '/builds/slave/test', 09:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:34 INFO - 'SHELL': '/bin/bash', 09:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:34 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:34 INFO - 'USER': 'cltbld', 09:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:34 INFO - 'XPC_FLAGS': '0x0', 09:48:34 INFO - 'XPC_SERVICE_NAME': '0', 09:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:38 INFO - Downloading docopt-0.6.1.tar.gz 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:38 INFO - Running setup.py install for blobuploader 09:48:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:39 INFO - Running setup.py install for requests 09:48:39 INFO - Running setup.py install for docopt 09:48:39 INFO - Successfully installed blobuploader requests docopt 09:48:39 INFO - Cleaning up... 09:48:39 INFO - Return code: 0 09:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:40 INFO - 'HOME': '/Users/cltbld', 09:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PAGER': '/bin/cat', 09:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:40 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - 'XPC_FLAGS': '0x0', 09:48:40 INFO - 'XPC_SERVICE_NAME': '0', 09:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4dHC6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KVjLx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rHa_RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-unM7fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-bI4hBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HO4ZEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-DLFAtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Ur0HaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-cPy92s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jWeqhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-BG8OzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-lBmWpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-90p0ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-tDCwuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-050mzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZrEI16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-wIvYrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:42 INFO - Running setup.py install for manifestparser 09:48:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozcrash 09:48:43 INFO - Running setup.py install for mozdebug 09:48:43 INFO - Running setup.py install for mozdevice 09:48:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozfile 09:48:43 INFO - Running setup.py install for mozhttpd 09:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozinfo 09:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozInstall 09:48:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozleak 09:48:44 INFO - Running setup.py install for mozlog 09:48:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for moznetwork 09:48:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozprocess 09:48:44 INFO - Running setup.py install for mozprofile 09:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozrunner 09:48:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:45 INFO - Running setup.py install for mozscreenshot 09:48:45 INFO - Running setup.py install for moztest 09:48:45 INFO - Running setup.py install for mozversion 09:48:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:45 INFO - Cleaning up... 09:48:45 INFO - Return code: 0 09:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:45 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')]} 09:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 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')]} 09:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:45 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 09:48:45 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 09:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:45 INFO - 'HOME': '/Users/cltbld', 09:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:45 INFO - 'LOGNAME': 'cltbld', 09:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:45 INFO - 'MOZ_NO_REMOTE': '1', 09:48:45 INFO - 'NO_EM_RESTART': '1', 09:48:45 INFO - 'PAGER': '/bin/cat', 09:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:45 INFO - 'PWD': '/builds/slave/test', 09:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:45 INFO - 'SHELL': '/bin/bash', 09:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:45 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:45 INFO - 'USER': 'cltbld', 09:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:45 INFO - 'XPC_FLAGS': '0x0', 09:48:45 INFO - 'XPC_SERVICE_NAME': '0', 09:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mDsfvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-iut9BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-PQdRC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-r75cAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rWOSba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-FI0d9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2bP65G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:46 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-etQLEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZcIk7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-hsi0ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-SvofP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-R60KpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-T60PHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-VndvzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-z1AQ8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:47 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)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-hE2tIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-fTxqCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:48 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)) 09:48:48 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)) 09:48:48 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)) 09:48:48 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)) 09:48:48 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)) 09:48:48 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)) 09:48:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:50 INFO - Downloading blessings-1.6.tar.gz 09:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:51 INFO - Installing collected packages: blessings 09:48:51 INFO - Running setup.py install for blessings 09:48:51 INFO - Successfully installed blessings 09:48:51 INFO - Cleaning up... 09:48:51 INFO - Return code: 0 09:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:51 INFO - Reading from file tmpfile_stdout 09:48:51 INFO - Current package versions: 09:48:51 INFO - blessings == 1.6 09:48:51 INFO - blobuploader == 1.2.4 09:48:51 INFO - docopt == 0.6.1 09:48:51 INFO - functools32 == 3.2.3-2 09:48:51 INFO - jsonschema == 2.5.1 09:48:51 INFO - manifestparser == 1.1 09:48:51 INFO - mozInstall == 1.12 09:48:51 INFO - mozcrash == 1.0 09:48:51 INFO - mozdebug == 0.1 09:48:51 INFO - mozdevice == 0.49 09:48:51 INFO - mozfile == 1.2 09:48:51 INFO - mozhttpd == 0.7 09:48:51 INFO - mozinfo == 0.9 09:48:51 INFO - mozleak == 0.1 09:48:51 INFO - mozlog == 3.4 09:48:51 INFO - moznetwork == 0.27 09:48:51 INFO - mozprocess == 0.24 09:48:51 INFO - mozprofile == 0.28 09:48:51 INFO - mozrunner == 6.13 09:48:51 INFO - mozscreenshot == 0.1 09:48:51 INFO - mozsystemmonitor == 0.3 09:48:51 INFO - moztest == 0.8 09:48:51 INFO - mozversion == 1.4 09:48:51 INFO - psutil == 3.1.1 09:48:51 INFO - requests == 1.2.3 09:48:51 INFO - wsgiref == 0.1.2 09:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:51 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:51 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 09:48:51 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 09:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:51 INFO - 'HOME': '/Users/cltbld', 09:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:51 INFO - 'LOGNAME': 'cltbld', 09:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:51 INFO - 'MOZ_NO_REMOTE': '1', 09:48:51 INFO - 'NO_EM_RESTART': '1', 09:48:51 INFO - 'PAGER': '/bin/cat', 09:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:51 INFO - 'PWD': '/builds/slave/test', 09:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:51 INFO - 'SHELL': '/bin/bash', 09:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:51 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:51 INFO - 'USER': 'cltbld', 09:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:51 INFO - 'XPC_FLAGS': '0x0', 09:48:51 INFO - 'XPC_SERVICE_NAME': '0', 09:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 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)) 09:48:51 INFO - Cleaning up... 09:48:51 INFO - Return code: 0 09:48:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:51 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 0x10d1d1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb892de31c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, '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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:48:51 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 09:48:51 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 09:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:51 INFO - 'HOME': '/Users/cltbld', 09:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:51 INFO - 'LOGNAME': 'cltbld', 09:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:51 INFO - 'MOZ_NO_REMOTE': '1', 09:48:51 INFO - 'NO_EM_RESTART': '1', 09:48:51 INFO - 'PAGER': '/bin/cat', 09:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:51 INFO - 'PWD': '/builds/slave/test', 09:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:51 INFO - 'SHELL': '/bin/bash', 09:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:48:51 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:51 INFO - 'USER': 'cltbld', 09:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:51 INFO - 'XPC_FLAGS': '0x0', 09:48:51 INFO - 'XPC_SERVICE_NAME': '0', 09:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:52 INFO - Cleaning up... 09:48:52 INFO - Return code: 0 09:48:52 INFO - Running post-action listener: _resource_record_post_action 09:48:52 INFO - Running post-action listener: _start_resource_monitoring 09:48:52 INFO - Starting resource monitoring. 09:48:52 INFO - [mozharness: 2017-02-01 17:48:52.172624Z] Finished create-virtualenv step (success) 09:48:52 INFO - [mozharness: 2017-02-01 17:48:52.173386Z] Running install step. 09:48:52 INFO - Running pre-action listener: _resource_record_pre_action 09:48:52 INFO - Running main action method: install 09:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:52 INFO - Reading from file tmpfile_stdout 09:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:52 INFO - Reading from file tmpfile_stdout 09:48:52 INFO - Output received: 09:48:52 INFO - Usage: mozinstall [options] installer 09:48:52 INFO - Options: 09:48:52 INFO - -h, --help show this help message and exit 09:48:52 INFO - -d DEST, --destination=DEST 09:48:52 INFO - Directory to install application into. [default: 09:48:52 INFO - "/builds/slave/test"] 09:48:52 INFO - --app=APP Application being installed. [default: firefox] 09:48:52 INFO - mkdir: /builds/slave/test/build/application 09:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:49:13 INFO - Reading from file tmpfile_stdout 09:49:13 INFO - Output received: 09:49:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:49:13 INFO - Running post-action listener: _resource_record_post_action 09:49:13 INFO - [mozharness: 2017-02-01 17:49:13.084659Z] Finished install step (success) 09:49:13 INFO - [mozharness: 2017-02-01 17:49:13.084808Z] Running run-tests step. 09:49:13 INFO - Running pre-action listener: _resource_record_pre_action 09:49:13 INFO - Running main action method: run_tests 09:49:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:13 INFO - 2017-02-01 09:49:13.097 screenresolution[1624:7396] starting screenresolution argv=screenresolution get 09:49:13 INFO - 2017-02-01 09:49:13.100 screenresolution[1624:7396] Display 0: 1600x1200x32@60 09:49:13 INFO - 2017-02-01 09:49:13.105 screenresolution[1625:7399] starting screenresolution argv=screenresolution list 09:49:13 INFO - Available Modes on Display 0 09:49:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:13 INFO - Intel Iris: 09:49:13 INFO - Chipset Model: Intel Iris 09:49:13 INFO - Type: GPU 09:49:13 INFO - Bus: Built-In 09:49:13 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:13 INFO - Vendor: Intel (0x8086) 09:49:13 INFO - Device ID: 0x0a2e 09:49:13 INFO - Revision ID: 0x0009 09:49:13 INFO - Displays: 09:49:13 INFO - Display: 09:49:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:13 INFO - Display Serial Number: 1600x1200 60 09:49:13 INFO - Main Display: Yes 09:49:13 INFO - Mirror: Off 09:49:13 INFO - Online: Yes 09:49:13 INFO - Rotation: Supported 09:49:13 INFO - Return code: 0 09:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:13 INFO - Python 2.7.3 09:49:13 INFO - Return code: 0 09:49:13 INFO - grabbing minidump binary from tooltool 09:49: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')]} 09:49:13 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 0x10cfafd30>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:13 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 09:49:13 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 09:49:13 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 09:49:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:13 INFO - Return code: 0 09:49:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 09:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 09:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDBN0c2xXJ/Render', 09:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:13 INFO - 'HOME': '/Users/cltbld', 09:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:13 INFO - 'LOGNAME': 'cltbld', 09:49:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:13 INFO - 'MOZ_NO_REMOTE': '1', 09:49:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:13 INFO - 'NO_EM_RESTART': '1', 09:49:13 INFO - 'PAGER': '/bin/cat', 09:49:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:13 INFO - 'PWD': '/builds/slave/test', 09:49:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:13 INFO - 'SHELL': '/bin/bash', 09:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UYZ4rmb2S1/Listeners', 09:49:13 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:13 INFO - 'USER': 'cltbld', 09:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:13 INFO - 'XPC_FLAGS': '0x0', 09:49:13 INFO - 'XPC_SERVICE_NAME': '0', 09:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 09:49:13 INFO - mozversion application_buildid: 20170201082708 09:49:13 INFO - mozversion application_changeset: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d 09:49:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:49:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:13 INFO - mozversion application_name: Firefox 09:49:13 INFO - mozversion application_remotingname: firefox-dev 09:49:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:13 INFO - mozversion application_vendor: Mozilla 09:49:13 INFO - mozversion application_version: 53.0a2 09:49:13 INFO - mozversion platform_buildid: 20170201082708 09:49:13 INFO - mozversion platform_changeset: a4f2c6889112c9f7e4d3edd2cec93e6ced66270d 09:49:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:49:13 INFO - mozversion platform_version: 53.0a2 09:49:13 INFO - using testdate: 1485971353 09:49:13 INFO - actual date: 1485971353 09:49:13 INFO - starting webserver on 'localhost:49241' 09:49:13 INFO - SUITE-START | Running 2 tests 09:49:13 INFO - TEST-START | dromaeo_css 09:49:13 INFO - operating with platform_type : mac_ 09:49:13 INFO - Initialising browser for dromaeo_css test... 09:49:13 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpPzaa_Z/profile http://localhost:49241/getInfo.html) 09:49:16 INFO - PROCESS | 1635 | 2017-02-01 09:49:16.742 plugin-container[1637:7709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 09:49:16 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:16 INFO - PROCESS | 1635 | 2017-02-01 09:49:16.745 plugin-container[1637:7709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 09:49:16 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:16 INFO - PROCESS | 1635 | 2017-02-01 09:49:16.745 plugin-container[1637:7709] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:49:16 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:49:16 INFO - PROCESS | 1635 | colorDepth:24 09:49:16 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:49:16 INFO - PROCESS | 1635 | __metrics 09:49:16 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:49:17 INFO - TEST-INFO | 1635: exit 0 09:49:17 INFO - Browser initialized. 09:49:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:17 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpPzaa_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:20 INFO - PROCESS | 1638 | 2017-02-01 09:49:20.056 plugin-container[1639:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 09:49:20 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:20 INFO - PROCESS | 1638 | 2017-02-01 09:49:20.056 plugin-container[1639:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 09:49:20 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:20 INFO - PROCESS | 1638 | 2017-02-01 09:49:20.056 plugin-container[1639:7839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:49:29 INFO - PROCESS | 1638 | RSS: Main: 218824704 09:49:29 INFO - PROCESS | 1638 | 09:52:32 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:52:33 INFO - PROCESS | 1638 | RSS: Main: 236027904 09:52:33 INFO - PROCESS | 1638 | 09:54:18 INFO - PROCESS | 1638 | ************************* 09:54:18 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 09:54:18 INFO - PROCESS | 1638 | 09:54:18 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:18 INFO - PROCESS | 1638 | Full stack: 09:54:18 INFO - PROCESS | 1638 | ************************* 09:55:36 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:55:36 INFO - PROCESS | 1638 | RSS: Main: 245321728 09:55:36 INFO - PROCESS | 1638 | 09:58:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:58:39 INFO - PROCESS | 1638 | RSS: Main: 253652992 09:58:39 INFO - PROCESS | 1638 | 10:01:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:01:42 INFO - PROCESS | 1638 | RSS: Main: 250204160 10:01:42 INFO - PROCESS | 1638 | 10:04:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:04:45 INFO - PROCESS | 1638 | RSS: Main: 254771200 10:04:45 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:07:48 INFO - PROCESS | 1638 | RSS: Main: 256385024 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | __start_tp_report 10:07:48 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:07:48 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:07:48 INFO - PROCESS | 1638 | |i|pagename|runs| 10:07:48 INFO - PROCESS | 1638 | |0;dojo.html;3362.0586235853957;3364.6467120952298;3378.814165220912;3410.147463134215;3417.743669224808;5671.631343962645;5672.886542269157;5737.082066869301;5747.942520574793;5752.7411266493;5476.479734425233;5601.943980560193;5751.223584816049;5755.913661295084;5778.335491418488;5178.585713142958;5227.712475813829;5254.395744489375;5259.237410575464;5311.601629877775;5299.708516031616;5308.6814791112465;5315.415304316542;5322.33470816148;5358.946410535903;4276.87169384919;5052.545270925634;5307.708076055816;5315.309009828717;5326.760295786679;4394.582514661134;4409.382686423904;5190.2214667800135;5220.112580861262;5264.263003179539;4269.252880745888;4366.214081465335;5149.974250128763;5254.579633629339;5293.100172970566;5557.694326812064;5724.198612194296;5736.2256095427;5798.304203495565;5823.592348535604;6111.926012480395;6116.5183814016455;6124.9912799099075;6210.534209934228;6277.560570760049;6208.286047104596;6213.00591905293;6222.973209420486;6231.065340198961;6299.023651334051;4943.752812359367;5937.109433584954;5958.046712525975;5976.402359764033;6024.006039003603;6131.356207598227;6153.046277826944;6205.627662340274;6205.751769929152;6242.032484964838;6076.3316035236085;6149.538784591174;6152.8049405570855;6166;6174.197354343906;5605.607607467438;5906.995810712189;6213.844653883599;6263.749450022039;6326.620402775849;6116.418940200674;6142.324344322121;6144.648177400964;6162.014077747628;6272.059191121369;6250.093736408196;6280.874382512324;6286.402791734869;6294.937050629526;6295.905561416583;4992.201247800334;4997.85006449807;4997.85006449807;5002.324686167321;5021.799128034838;4375.912481750347;4400.119976004812;4434.091011342667;4503.211937910918;4518.638508919278;5095.337606111182;5445.556927414238;5482.671039737628;5850.707464626837;5912.940870591325;5905.143754155623;6296.65368404733;6300.495960323163;6321.589096708699;6322.620642761449;5656.208130861683;5702.372738998707;5796;5835.095560188178;5849.736761845727;5483.396826349099;5490;5501.834944951658;5504.394516603171;5505.284313039279;6348.841278968062;6353.587016843982;6362.0774987627465;6370.235571731422;6375.234971803413;6133.793750436688;6163.229596300463;6197.132401463708;6251.499880009497;6348.746050157942;6321.146645203023;6332.905006424815;6358.1734374531015;6364.554481186273;6368.522360822864;6240.469560087444;6248.187735594525;6258.812235632939;6258.843528911813;6267.0286105653695;4632.2819962905805;6061.818145455643;6230.875382492415;6324.146240257691;6328.588641738273;6116.457510225689;6185.195924529782;6187.566870319034;6196.876062478816;6209.379062093935;6103.908441373472;6141.7543298267565;6148.723307451086;6183.288921774054;6220.098085777628;5791.247137872049;5891.351951285441;5907.17299578068;6015.458608725061;6064.787732429344;6081;6122.611623597813;6133.172021777003;6145.539084568586;6160.568760186744;6003.159557661844;6019.608725432833;6030.30651475086;6035.1249068885645;6058.182145410489 10:07:48 INFO - PROCESS | 1638 | |1;ext.html;416.63544398651175;447.9942529022345;452.69895519479525;513.8997895410391;539.8488423241491;35213.11967200818;41185.17629647413;41231.99999999996;41247.79376103119;41467.37798933018;42197;42952;42955.35566966498;43119;43821.78089109558;8002.559859207741;9287.349885508;9419.576119074658;9540;9540.284478664093;11102.222844400896;11199.944000279987;11200.887991120107;11222;11248.100151987863;11226.943865280662;11260.380679062648;11272.943635281812;11281.943590282037;11346.149038822081;11218.102551795837;11267.26762760418;11268.887311126866;11274.379909105037;11297.09623230148;11072.280301780358;11125.221234513587;11129.109671226282;11145.777084458265;11166.720831979266;36874.63125368739;37227.62772372269;37274;37287;37307.25385492275;3850.903727406809;3914.412838074312;3945.1123497213184;3960.742551734128;3978.900527486836;27485.86257068702;28158;28172.295692607848;29148.854255728587;29252.561211581844;3178.284885900677;3179.5230715392877;3197.216681912946;3210.6949839765184;3226.370857682753;433849;434797;436625;437533.8123309395;438446;54249;54618.726906366006;54620;54836.451635483136;54843;51121.233181502306;54419;56904;56975.715121424124;57224.56938576486;15666.921665391601;15843.683126337639;15854.128022958848;15869.96845205058;15899;9943;11193.27243729155;11483.827742583868;12532.937335313265;12539.122261441611;17999.910000449912;18046.909765451088;18125.637487250446;18144.092795360444;18261.908690456727;6520.706568204442;6739;7999.880001799977;8006.1570446185;8022.593222033367;790.4901338636547;872.228078150841;885.8892638420198;893.5889490834289;916.6608354908593;29616.851915740714;30186.396272074435;30418.847905760773;30970.380592388025;31163.220919477193;1032.2670903658336;1080.2276372393776;1094.7755710079573;1111.522045520434;1195.0738177912015;15682.921585392;15872;15890.205489725467;16098.678026439406;16127.435539756052;622721;627331.8633406804;627425;627435;628386;61186.69406652938;61770.69114654488;61836;61965.69017154886;62123.6893815528;1242.4967888005372;1439.4242303078852;1442.7186698593882;1457.3441951122038;1463.3268696399562;29014.419711605227;29412.852935735184;29931.85034074816;30038.24904377408;30558.84720576383;48812;51967.480325196266;52122;52208.47791522188;52379;481622;525193;544078;571627;580868;24596.631050534615;25101.99592016299;25324.240272791845;25385.365365865262;25526.872365638053;36116.63883361133;42223.366649499665;42618.50835220752;43177.3523397143;43569.78215108904;34192;34336.82831585926;34431.311373772885;34559.30881382308;34816.82591587026;35760.28479430345;35839.82080089583;36005.45991810073;36427.81786091052;36649;29224.56163157597;34874;35132.12169695778;35803.28393432064;36073.458898117075;23193.304200874;29692.960746374636;31696.841515792272;31761.841190793897;33649.83175084109;20465.59068818645;22310.930612649456;23974.52050959006;24146.034158633458;24491.26526204217 10:07:48 INFO - PROCESS | 1638 | |2;jquery.html;394.2332163941136;394.8361430006547;399.8740396775016;403.0769537758532;421.9724969698782;14551.563453096423;16086.59783505413;19777;21212.151513939443;21226.787732122673;16952.83047169528;20722.89638551809;21503;21734.3479695609;21978.780212197875;5692.743826527816;5770.596058275912;5947.910781338283;6019.849503762397;6034.24571928509;5688.63023903447;5900.881982360372;5957.910631340534;5970.940290597104;5986.102084687288;5829.358770535237;5887.705614719268;5889.558283128761;5894.115882617621;5902.203202567663;5758.56810739192;5766.336871259796;5868.647881127104;5879.67661778602;5900.734466948998;5772.8845423091725;5787.450192231731;5801.390853960315;5805.10020946754;5808.332041815203;12928.353582320846;20786;23257.7674223259;24707;24845.62731559028;2594;2608.178423796498;2636.3540932471474;2722.42829005909;2883.2935930696904;9741.610335586569;10013.449260290681;10233.334833235816;11375.715607109805;15976.680466390724;1775.5649865782837;1817;1832.7800663920282;1834.9449516514392;1835.9908200459047;111890.88109118886;117816;123620;127063;129361.70638293496;11661.533538658528;11786.469608867621;12012.87987120135;12059.698507537207;12092.516299348103;15807.446739364066;15809.683806323808;15822.446214382442;15824.446144385121;15838.445654402041;8597.871031934526;8732.738017859474;8817.426867253607;8833.293336533063;8940.50827204497;8542.487450752975;8572.571371431404;8680.956595216983;8707.738767836974;8716.477011379338;4641.721496710208;4706.670533062653;4741.407324084489;4743.715377077387;4774.594159496412;1733.4712912561538;2004.8797072175716;2025.43287879394;2060.9896950515154;2064.8038436348525;859.3898332184219;875.8292133033997;883.9734807955772;899.487292243415;913.8949020862686;19541.804581954282;20813;20957.26649567258;20963.475913102295;21164.36506904795;900.8513595256709;904.2720609908955;925.0795458518817;925.1257561604353;926.9258459323238;9338.90661093394;10547.736306592244;10975.012248897478;10994.725131871608;11020.063294620048;462435;528607;604837;605859;702548;115508.42245788885;129384;131562;135553;161359;946.6118891254553;1029.5006921642996;1044.9007344302431;1075.784363669049;1078.2021304234809;18908.810911890705;19249.807501925363;19557.51106222356;19644.80355196487;19651.606967860847;43573.56426435822;45737.542624573325;51559;59118.40881591301;60639.69680151571;61117.69441152766;66688.66655666885;76937;79109.0222744436;82662;7966.322862556747;8196.508209507449;8248.876266855881;8422.157784221528;8557.486550806723;12233.143679942674;12571.93714031424;12739.74520509566;13015.47938082504;13052.934735326262;9211.907880921373;10959.287646302964;11141.610043648758;11270.718232044264;11275.210735248455;10608.52261648243;10995.945020274847;10996.835047474135;11033.172512061466;11457.369844658624;10847.67456976292;11050.060744836457;11073.667789966314;11140.053095486974;11421.1434142438;7962.442629016145;8079.394045446497;8084.797880053045;8150.4294699370475;8209.958950205211;7683.807904802425;10287.639932602324;10359.482025898524;10556.736081598021;10699.197560183173 10:07:48 INFO - PROCESS | 1638 | |3;mootools.html;1375.1061809823614;1403.1440821099127;1424.679447124397;1444.913305201688;1450.876675482584;7456.142543607473;7694.269044440784;7951.681932722691;8391.748247552576;8401.159884011597;7903.012123484565;8198.42611017229;8207;8322.375821813357;8335.291500222489;2233.888305584718;2282.5549017941507;2287.2909398086645;2290.6334986402094;2291.656251562271;2068.4932191613075;2150.483883867876;2324.535092981402;2347.6947996760396;2362.7637236276405;2251;2325.1280769711357;2328.092044102801;2329.895154718042;2332.1371092695726;2273.27255278311;2279.247848210095;2283.6917016202765;2283.931482055541;2301.0450662974845;2183.716116904792;2309.976900230993;2319.988400058006;2366.2073205476013;2368.9170879019325;7222.819429514252;8347.83304333916;8374.49753014821;8387.538685372301;8411;5021.39743230811;5167.819126330561;5188.5849132069725;5188.8962220755375;5192.506711862405;3127.6090488688915;3228;3262.869485220588;3287.7534184936226;3358.227607650254;1044.8798388185303;1078.5362294213485;1087.331291255872;1152.9077673786162;1698.626302213511;9921.958194389557;10016.649417270433;10490.31812932157;10725.999999999922;10727.302725322828;4231.4710661167355;4413.7793110344355;4480.059187570647;4480.148771733426;4498.0104377037;8512.914870851337;8553.144685531397;8578.871316930252;8602.655893764178;8606.526641034803;4321.416608757841;4510.255807791743;4848.248521479177;5037.29477873098;5050.621203409759;4599.540045995441;4717.457492388419;4726.976365118221;4750.5249475052215;4773.570378665937;3427.280271143038;3813.828377723009;3905.8047097645003;3959.6634286085427;3989.3218152914073;1194.940252987347;1231.96920076997;1269.3716610277972;1282.9422675979604;1300.8634093420244;898.276887105873;913.9908600914039;922.2222774318898;930.3766476460787;947.9526023698926;5488.7530061147345;5623.943760562342;5655.604107712503;5760.8271751847515;5797.971010144923;975.5561219645044;992.6079198716467;1007.3955626624113;1019.4851599941982;1021.0759262867117;3589.6589823966683;3596.8381422836037;3601.3877640801124;3846.6345697158727;3881.874256465593;9643.951780241054;9865.753356166153;9914.058164474363;9940.652077177409;9941.806983161921;9790.461524616214;9811.509424528746;9812.852807207897;9817.214622830157;9822.508874556244;7418.554886706815;7612.809679757939;7743.45795794289;7747.922520774833;7822.530648161242;5414.891702165856;5430.511253987002;5434.2120392542065;5597.888042239214;5601.943980560142;8968.327375446737;8991;9128.361014728906;9158.816823663623;9215.815683686424;8683.739487815375;9130.497822619554;9141.908580914105;9143.862842057242;9268.304877134107;7009.228984811564;7222.711091556279;7238.674259658434;7240.710371585288;7248.166460857069;7661.961690191513;7689.192634773492;7697.46117771773;7767.495112817649;7781.182975787461;6340.240724655664;7052.612106334201;7088.17238691101;7089.503734738519;7212.990181374506;6978.302169782981;6990.126234220723;6997.650117494207;7108;7113.964430177816;5491.258680078298;6379.96810015947;6413.935860641333;6462.127612772216;6483.870322593616;3972.0467087899274;4021.4973128358956;4050.837966481308;4076.551579326331;4152.501699795923;4721.315409265706;4779.948411349497;4853.733044682435;4926.852194434173;5018.623603229699 10:07:48 INFO - PROCESS | 1638 | |4;prototype.html;283.4048498153877;302.92275469755214;324.3512974051896;357.3960007587178;363.6508951406648;4454.554544545548;5011.849644510661;5322.9620224056325;5389.595780316477;5468.7539060742265;4222.514410842754;5236;5344.35867695877;5349.164942580439;5349.973250133744;3583.9641603584023;3951.8221680024394;4069.8429832188986;4195.559466256045;4199.685023623225;3644.835982380799;3944.704147188958;4186.974191323115;4217.367394890775;4229;3951.7628942263414;4143.129942712034;4210.663146948237;4235.830566777326;4241.809118589656;3330.8834190803204;3901.7073719471155;4037.222478097857;4223.260929337353;4251.298535741599;3135.4826453635123;3539.239063601338;3674.5223120994365;3707.5921648618632;3712.535933008374;4615.561521655437;5092.6180536459915;5348.625596208267;5361.212169671788;5373.59698022646;4358.5205627380965;4498.752568608726;4742.928856067162;4906.092372910987;4929.260610908356;5017.04335309226;5318.9202161967605;5713.54304652311;5721.227634269362;5734.741936612862;3500.859965601373;3678;3890.440247173861;3917.882463526099;3923.470331505239;4781.713097214143;5647.216365035436;5969.37321581232;6039.909401358983;6055.850173188499;3861.7489863158803;3867.535895692479;3885.9222815544094;3920.1179734560064;3922.4116382542275;3928.3518219493462;3938.8621398250925;3965.8810235692977;3981.3629819228786;3985.561588225293;4414.6247568957;4625.514320996314;4625.976870115628;4639.489656137822;4670.6497012724185;4417.046743164849;5027;5387.9461205388225;5482.5613950883835;5795.275590551181;1228.238492134882;1236.1532350340046;1297.8702129786946;1305.3668970549465;1313.7175507265983;754;837.8240569480478;846.4328899637258;863.2144748279036;876.1895246896595;4545.181867263858;5065.518775716301;5219.269302297681;5264.42091369949;5431.565474762009;4842.377803435818;5017.949820501822;5400.432954539795;5576.347492392409;5922.585419020627;5068.771905264272;5269.578433725293;5330.786768529293;5343.644929382541;5352.91970620441;2501.912433064834;2585.4958283134606;2672.6347182743025;2685.879135438871;2908.578256152846;4842.903141937212;5241.266222728821;5442.265294185234;5901.203337549462;5934.970325148347;4690.217717267416;5466.508014278734;5829.8251052468495;5862.062070068854;5868.559858010581;4999.42506611737;5294.9205761912835;5498.80754173602;5892.234009578813;5912.497437717756;4709.163426263828;4772.117158325721;4947.505249475023;5532.5020748132865;5661.801836935852;5373.892522149613;5592.804251851166;5863.20846685692;5872.26939473147;5882.823515294548;4892.510748925079;5411.594130440154;5843.328017278068;6149.446549810538;6236.906446403217;3917.373220284741;3928.253631809947;3935.2916475034767;3967.147063381387;3975.5428125765907;4709.552592503706;5535.667859928417;5851.561132915133;5864.9413505866105;5885.14570433348;5718.542516598579;5721.885562288648;5727.942720572908;5743.07103377289;5763.250777398911;4772.546608072227;5168.689878607145;5503.862403439946;5520.944790552204;5543.863507980774;5096.541311282002;5157.613179011514;5618.550515958632;5622.184783206494;5624.831255062355;4548.727076375428;4874.4150701916;5029.698218106779;5703.657780533182;5760;5435.782568697208;5580.972095139498;5611.494965453129;5629.521490673339;5629.634073785191 10:07:48 INFO - PROCESS | 1638 | |5;yui.html;693.358643254989;694.6075467360938;765.7090305683839;819.4386845011167;829.3531045784289;13066.869331306683;13142.540011099614;14712;14800.481983130592;15710.371585136609;12900.419481123348;14467.710645787078;14575.34410951507;14609.707805843876;14707.264636768146;629.6064959400375;684.264415753065;686.3822559696264;827.1108558299852;851.0170752780548;859.7893516088567;861.6682577207757;865.5066612031145;867.0462491259627;873.6767396063466;911.1344222988188;915.1580545897757;915.6749353979342;917.5045475443253;918.5269586163131;782.6008735544884;908.0737647599411;908.2960705453261;913.5477938420524;913.7624217703378;672.8553361027354;678.2268214235775;679.0086473748333;679.966001699913;680.3706571421465;14491.565253042425;14749;14867.702645947129;15214.087154770748;15254.847451525564;12358.25850448967;14170.504032358818;14499.927500362535;14605.853941460555;14644.194569298685;10708.089812365959;10761.30051546647;10897.83653245202;10986.505607247693;11233.32600044;3688.7602305850032;3706.721995850295;3755.6056614055406;3779.5653499847595;3873.8837834865;95409.5229523855;97094.51452742761;97275.51362243215;97632.51183744035;97985;10678.412687302118;10736.248462607542;10830.350178989285;10846;11004.724881877857;22275.777242227694;22395.32814015582;22495.43761405945;22963.425914352276;22969.88515057414;7830.33442157423;7864.528128312205;7881.724139655199;7910.090339611018;8028.157043510348;4214.346627531121;4281.807318670667;4382.496012958487;4394.231009573376;4399.62603178727;3537.2394935088564;3606.7294952878638;3609.639036096422;3612.6387361263664;3614.584322802859;691.778630838137;707.992920070803;717.1430140981477;717.8887272472775;741.7033186725353;671.2314400011959;674.7537148940602;691.4606606846668;699.3251512290664;726.9927300726926;9875.061869122423;10224.539895704562;10226.199577281024;10259.846102308471;10554.788904221872;691.515938842812;691.9100516932766;693.9618320992394;697.6442014572503;706.8762966480846;4066.9389959150635;4082.0203151243486;4764.523547645208;5062.215356619729;5081.822136225214;60992.695036524536;79890.60054699806;81921.77117343244;90790.54604726934;99693.50153249188;50038.74903127378;78623.21376786158;80808.59595701983;82149.58925205335;82882.75675864867;47769.28346074812;69720.30279697239;71308.2869171312;72395.91406128912;74304.62847685727;10328.225383096147;10637.627683031365;10729.356238625707;10840.241183117107;10914.727131821768;42880;43072;44605.330920036875;44622;45244.86887827831;57824.71087644535;58794;59458.70270648619;61525.69237153786;61572;11771.823422648496;11813.527458901548;12774.74450510966;12783.105182637126;12808.935955320163;14024.509142179975;14605.415783368971;14778.77831832502;14808.111513309235;14892.7766083511;12857.421416036113;13010.869891301345;13109.868901311247;14211;14235.572932812032;12723.618291451272;13525.729485410433;13527.458901644217;13748.793768093286;13772.380242888894;12672;13387.464501420223;13673.931630341785;13794.724105518035;13825.377857996213;10829.729256768644;11078.833817492583;11368.374739389414;11392.886071139183;11639.127065469955;9316.906830931875;9692.854607180758;10489.213309001703;10737.14102871784;10813.67558973232 10:07:48 INFO - PROCESS | 1638 | __end_tp_report 10:07:48 INFO - PROCESS | 1638 | __start_cc_report 10:07:48 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,372 10:07:48 INFO - PROCESS | 1638 | __end_cc_report 10:07:48 INFO - PROCESS | 1638 | __startTimestamp1485972468820__endTimestamp 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:07:48 INFO - PROCESS | 1638 | Number of tests: 6 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5725.31 Median:6015.46 stddev:678.99 (11.3%) stddev-sans-first:655.28 10:07:48 INFO - PROCESS | 1638 | Values: 3362.1 3364.6 3378.8 3410.1 3417.7 5671.6 5672.9 5737.1 5747.9 5752.7 5476.5 5601.9 5751.2 5755.9 5778.3 5178.6 5227.7 5254.4 5259.2 5311.6 5299.7 5308.7 5315.4 5322.3 5358.9 4276.9 5052.5 5307.7 5315.3 5326.8 4394.6 4409.4 5190.2 5220.1 5264.3 4269.3 4366.2 5150.0 5254.6 5293.1 5557.7 5724.2 5736.2 5798.3 5823.6 6111.9 6116.5 6125.0 6210.5 6277.6 6208.3 6213.0 6223.0 6231.1 6299.0 4943.8 5937.1 5958.0 5976.4 6024.0 6131.4 6153.0 6205.6 6205.8 6242.0 6076.3 6149.5 6152.8 6166.0 6174.2 5605.6 5907.0 6213.8 6263.7 6326.6 6116.4 6142.3 6144.6 6162.0 6272.1 6250.1 6280.9 6286.4 6294.9 6295.9 4992.2 4997.9 4997.9 5002.3 5021.8 4375.9 4400.1 4434.1 4503.2 4518.6 5095.3 5445.6 5482.7 5850.7 5912.9 5905.1 6296.7 6300.5 6321.6 6322.6 5656.2 5702.4 5796.0 5835.1 5849.7 5483.4 5490.0 5501.8 5504.4 5505.3 6348.8 6353.6 6362.1 6370.2 6375.2 6133.8 6163.2 6197.1 6251.5 6348.7 6321.1 6332.9 6358.2 6364.6 6368.5 6240.5 6248.2 6258.8 6258.8 6267.0 4632.3 6061.8 6230.9 6324.1 6328.6 6116.5 6185.2 6187.6 6196.9 6209.4 6103.9 6141.8 6148.7 6183.3 6220.1 5791.2 5891.4 5907.2 6015.5 6064.8 6081.0 6122.6 6133.2 6145.5 6160.6 6003.2 6019.6 6030.3 6035.1 6058.2 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:66508.74 Median:35003.06 stddev:144401.64 (412.5%) stddev-sans-first:144721.46 10:07:48 INFO - PROCESS | 1638 | Values: 416.6 448.0 452.7 513.9 539.8 35213.1 41185.2 41232.0 41247.8 41467.4 42197.0 42952.0 42955.4 43119.0 43821.8 8002.6 9287.3 9419.6 9540.0 9540.3 11102.2 11199.9 11200.9 11222.0 11248.1 11226.9 11260.4 11272.9 11281.9 11346.1 11218.1 11267.3 11268.9 11274.4 11297.1 11072.3 11125.2 11129.1 11145.8 11166.7 36874.6 37227.6 37274.0 37287.0 37307.3 3850.9 3914.4 3945.1 3960.7 3978.9 27485.9 28158.0 28172.3 29148.9 29252.6 3178.3 3179.5 3197.2 3210.7 3226.4 433849.0 434797.0 436625.0 437533.8 438446.0 54249.0 54618.7 54620.0 54836.5 54843.0 51121.2 54419.0 56904.0 56975.7 57224.6 15666.9 15843.7 15854.1 15870.0 15899.0 9943.0 11193.3 11483.8 12532.9 12539.1 17999.9 18046.9 18125.6 18144.1 18261.9 6520.7 6739.0 7999.9 8006.2 8022.6 790.5 872.2 885.9 893.6 916.7 29616.9 30186.4 30418.8 30970.4 31163.2 1032.3 1080.2 1094.8 1111.5 1195.1 15682.9 15872.0 15890.2 16098.7 16127.4 622721.0 627331.9 627425.0 627435.0 628386.0 61186.7 61770.7 61836.0 61965.7 62123.7 1242.5 1439.4 1442.7 1457.3 1463.3 29014.4 29412.9 29931.9 30038.2 30558.8 48812.0 51967.5 52122.0 52208.5 52379.0 481622.0 525193.0 544078.0 571627.0 580868.0 24596.6 25102.0 25324.2 25385.4 25526.9 36116.6 42223.4 42618.5 43177.4 43569.8 34192.0 34336.8 34431.3 34559.3 34816.8 35760.3 35839.8 36005.5 36427.8 36649.0 29224.6 34874.0 35132.1 35803.3 36073.5 23193.3 29693.0 31696.8 31761.8 33649.8 20465.6 22310.9 23974.5 24146.0 24491.3 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34620.39 Median:2601.09 stddev:98323.19 (3780.1%) stddev-sans-first:98565.43 10:07:48 INFO - PROCESS | 1638 | Values: 394.2 394.8 399.9 403.1 422.0 14551.6 16086.6 19777.0 21212.2 21226.8 16952.8 20722.9 21503.0 21734.3 21978.8 5692.7 5770.6 5947.9 6019.8 6034.2 5688.6 5900.9 5957.9 5970.9 5986.1 5829.4 5887.7 5889.6 5894.1 5902.2 5758.6 5766.3 5868.6 5879.7 5900.7 5772.9 5787.5 5801.4 5805.1 5808.3 12928.4 20786.0 23257.8 24707.0 24845.6 2594.0 2608.2 2636.4 2722.4 2883.3 9741.6 10013.4 10233.3 11375.7 15976.7 1775.6 1817.0 1832.8 1834.9 1836.0 111890.9 117816.0 123620.0 127063.0 129361.7 11661.5 11786.5 12012.9 12059.7 12092.5 15807.4 15809.7 15822.4 15824.4 15838.4 8597.9 8732.7 8817.4 8833.3 8940.5 8542.5 8572.6 8681.0 8707.7 8716.5 4641.7 4706.7 4741.4 4743.7 4774.6 1733.5 2004.9 2025.4 2061.0 2064.8 859.4 875.8 884.0 899.5 913.9 19541.8 20813.0 20957.3 20963.5 21164.4 900.9 904.3 925.1 925.1 926.9 9338.9 10547.7 10975.0 10994.7 11020.1 462435.0 528607.0 604837.0 605859.0 702548.0 115508.4 129384.0 131562.0 135553.0 161359.0 946.6 1029.5 1044.9 1075.8 1078.2 18908.8 19249.8 19557.5 19644.8 19651.6 43573.6 45737.5 51559.0 59118.4 60639.7 61117.7 66688.7 76937.0 79109.0 82662.0 7966.3 8196.5 8248.9 8422.2 8557.5 12233.1 12571.9 12739.7 13015.5 13052.9 9211.9 10959.3 11141.6 11270.7 11275.2 10608.5 10995.9 10996.8 11033.2 11457.4 10847.7 11050.1 11073.7 11140.1 11421.1 7962.4 8079.4 8084.8 8150.4 8210.0 7683.8 10287.6 10359.5 10556.7 10699.2 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5307.44 Median:5190.70 stddev:2876.20 (55.4%) stddev-sans-first:2869.08 10:07:48 INFO - PROCESS | 1638 | Values: 1375.1 1403.1 1424.7 1444.9 1450.9 7456.1 7694.3 7951.7 8391.7 8401.2 7903.0 8198.4 8207.0 8322.4 8335.3 2233.9 2282.6 2287.3 2290.6 2291.7 2068.5 2150.5 2324.5 2347.7 2362.8 2251.0 2325.1 2328.1 2329.9 2332.1 2273.3 2279.2 2283.7 2283.9 2301.0 2183.7 2310.0 2320.0 2366.2 2368.9 7222.8 8347.8 8374.5 8387.5 8411.0 5021.4 5167.8 5188.6 5188.9 5192.5 3127.6 3228.0 3262.9 3287.8 3358.2 1044.9 1078.5 1087.3 1152.9 1698.6 9922.0 10016.6 10490.3 10726.0 10727.3 4231.5 4413.8 4480.1 4480.1 4498.0 8512.9 8553.1 8578.9 8602.7 8606.5 4321.4 4510.3 4848.2 5037.3 5050.6 4599.5 4717.5 4727.0 4750.5 4773.6 3427.3 3813.8 3905.8 3959.7 3989.3 1194.9 1232.0 1269.4 1282.9 1300.9 898.3 914.0 922.2 930.4 948.0 5488.8 5623.9 5655.6 5760.8 5798.0 975.6 992.6 1007.4 1019.5 1021.1 3589.7 3596.8 3601.4 3846.6 3881.9 9644.0 9865.8 9914.1 9940.7 9941.8 9790.5 9811.5 9812.9 9817.2 9822.5 7418.6 7612.8 7743.5 7747.9 7822.5 5414.9 5430.5 5434.2 5597.9 5601.9 8968.3 8991.0 9128.4 9158.8 9215.8 8683.7 9130.5 9141.9 9143.9 9268.3 7009.2 7222.7 7238.7 7240.7 7248.2 7662.0 7689.2 7697.5 7767.5 7781.2 6340.2 7052.6 7088.2 7089.5 7213.0 6978.3 6990.1 6997.7 7108.0 7114.0 5491.3 6380.0 6413.9 6462.1 6483.9 3972.0 4021.5 4050.8 4076.6 4152.5 4721.3 4779.9 4853.7 4926.9 5018.6 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4530.26 Median:5022.47 stddev:1388.39 (27.6%) stddev-sans-first:1355.20 10:07:48 INFO - PROCESS | 1638 | Values: 283.4 302.9 324.4 357.4 363.7 4454.6 5011.8 5323.0 5389.6 5468.8 4222.5 5236.0 5344.4 5349.2 5350.0 3584.0 3951.8 4069.8 4195.6 4199.7 3644.8 3944.7 4187.0 4217.4 4229.0 3951.8 4143.1 4210.7 4235.8 4241.8 3330.9 3901.7 4037.2 4223.3 4251.3 3135.5 3539.2 3674.5 3707.6 3712.5 4615.6 5092.6 5348.6 5361.2 5373.6 4358.5 4498.8 4742.9 4906.1 4929.3 5017.0 5318.9 5713.5 5721.2 5734.7 3500.9 3678.0 3890.4 3917.9 3923.5 4781.7 5647.2 5969.4 6039.9 6055.9 3861.7 3867.5 3885.9 3920.1 3922.4 3928.4 3938.9 3965.9 3981.4 3985.6 4414.6 4625.5 4626.0 4639.5 4670.6 4417.0 5027.0 5387.9 5482.6 5795.3 1228.2 1236.2 1297.9 1305.4 1313.7 754.0 837.8 846.4 863.2 876.2 4545.2 5065.5 5219.3 5264.4 5431.6 4842.4 5017.9 5400.4 5576.3 5922.6 5068.8 5269.6 5330.8 5343.6 5352.9 2501.9 2585.5 2672.6 2685.9 2908.6 4842.9 5241.3 5442.3 5901.2 5935.0 4690.2 5466.5 5829.8 5862.1 5868.6 4999.4 5294.9 5498.8 5892.2 5912.5 4709.2 4772.1 4947.5 5532.5 5661.8 5373.9 5592.8 5863.2 5872.3 5882.8 4892.5 5411.6 5843.3 6149.4 6236.9 3917.4 3928.3 3935.3 3967.1 3975.5 4709.6 5535.7 5851.6 5864.9 5885.1 5718.5 5721.9 5727.9 5743.1 5763.3 4772.5 5168.7 5503.9 5520.9 5543.9 5096.5 5157.6 5618.6 5622.2 5624.8 4548.7 4874.4 5029.7 5703.7 5760.0 5435.8 5581.0 5611.5 5629.5 5629.6 10:07:48 INFO - PROCESS | 1638 | 10:07:48 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:18569.23 Median:23580.90 stddev:25335.00 (107.4%) stddev-sans-first:25370.51 10:07:48 INFO - PROCESS | 1638 | Values: 693.4 694.6 765.7 819.4 829.4 13066.9 13142.5 14712.0 14800.5 15710.4 12900.4 14467.7 14575.3 14609.7 14707.3 629.6 684.3 686.4 827.1 851.0 859.8 861.7 865.5 867.0 873.7 911.1 915.2 915.7 917.5 918.5 782.6 908.1 908.3 913.5 913.8 672.9 678.2 679.0 680.0 680.4 14491.6 14749.0 14867.7 15214.1 15254.8 12358.3 14170.5 14499.9 14605.9 14644.2 10708.1 10761.3 10897.8 10986.5 11233.3 3688.8 3706.7 3755.6 3779.6 3873.9 95409.5 97094.5 97275.5 97632.5 97985.0 10678.4 10736.2 10830.4 10846.0 11004.7 22275.8 22395.3 22495.4 22963.4 22969.9 7830.3 7864.5 7881.7 7910.1 8028.2 4214.3 4281.8 4382.5 4394.2 4399.6 3537.2 3606.7 3609.6 3612.6 3614.6 691.8 708.0 717.1 717.9 741.7 671.2 674.8 691.5 699.3 727.0 9875.1 10224.5 10226.2 10259.8 10554.8 691.5 691.9 694.0 697.6 706.9 4066.9 4082.0 4764.5 5062.2 5081.8 60992.7 79890.6 81921.8 90790.5 99693.5 50038.7 78623.2 80808.6 82149.6 82882.8 47769.3 69720.3 71308.3 72395.9 74304.6 10328.2 10637.6 10729.4 10840.2 10914.7 42880.0 43072.0 44605.3 44622.0 45244.9 57824.7 58794.0 59458.7 61525.7 61572.0 11771.8 11813.5 12774.7 12783.1 12808.9 14024.5 14605.4 14778.8 14808.1 14892.8 12857.4 13010.9 13109.9 14211.0 14235.6 12723.6 13525.7 13527.5 13748.8 13772.4 12672.0 13387.5 13673.9 13794.7 13825.4 10829.7 11078.8 11368.4 11392.9 11639.1 9316.9 9692.9 10489.2 10737.1 10813.7 10:07:48 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:07:48 INFO - PROCESS | 1638 | 10:07:49 INFO - TEST-INFO | 1638: exit 0 10:07:49 INFO - TEST-OK | dromaeo_css | took 1115742ms 10:07:49 INFO - TEST-START | kraken 10:07:49 INFO - operating with platform_type : mac_ 10:07:49 INFO - Initialising browser for kraken test... 10:07:49 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpE2xFsu/profile http://localhost:49241/getInfo.html) 10:07:52 INFO - PROCESS | 1650 | 2017-02-01 10:07:52.035 plugin-container[1651:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 10:07:52 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:52 INFO - PROCESS | 1650 | 2017-02-01 10:07:52.037 plugin-container[1651:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 10:07:52 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:52 INFO - PROCESS | 1650 | 2017-02-01 10:07:52.037 plugin-container[1651:10279] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:07:52 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:07:52 INFO - PROCESS | 1650 | colorDepth:24 10:07:52 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:07:52 INFO - PROCESS | 1650 | __metrics 10:07:52 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:07:52 INFO - TEST-INFO | 1650: exit 0 10:07:52 INFO - Browser initialized. 10:07:52 INFO - Running cycle 1/1 for kraken test... 10:07:52 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpE2xFsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:55 INFO - PROCESS | 1652 | 2017-02-01 10:07:55.328 plugin-container[1653:10406] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 10:07:55 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:55 INFO - PROCESS | 1652 | 2017-02-01 10:07:55.328 plugin-container[1653:10406] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.CFPasteboardClient' 10:07:55 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:55 INFO - PROCESS | 1652 | 2017-02-01 10:07:55.328 plugin-container[1653:10406] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:08:05 INFO - PROCESS | 1652 | RSS: Main: 218955776 10:08:05 INFO - PROCESS | 1652 | 10:08:08 INFO - PROCESS | 1652 | 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) 10:08:08 INFO - PROCESS | 1652 | RSS: Main: 233074688 10:08:08 INFO - PROCESS | 1652 | 10:08:11 INFO - PROCESS | 1652 | 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) 10:08:12 INFO - PROCESS | 1652 | RSS: Main: 241946624 10:08:12 INFO - PROCESS | 1652 | 10:08:15 INFO - PROCESS | 1652 | 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) 10:08:16 INFO - PROCESS | 1652 | RSS: Main: 245157888 10:08:16 INFO - PROCESS | 1652 | 10:08:18 INFO - PROCESS | 1652 | 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) 10:08:18 INFO - PROCESS | 1652 | RSS: Main: 246407168 10:08:18 INFO - PROCESS | 1652 | 10:08:21 INFO - PROCESS | 1652 | 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) 10:08:21 INFO - PROCESS | 1652 | RSS: Main: 246435840 10:08:21 INFO - PROCESS | 1652 | 10:08:24 INFO - PROCESS | 1652 | 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) 10:08:25 INFO - PROCESS | 1652 | RSS: Main: 250662912 10:08:25 INFO - PROCESS | 1652 | 10:08:28 INFO - PROCESS | 1652 | 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) 10:08:29 INFO - PROCESS | 1652 | RSS: Main: 247853056 10:08:29 INFO - PROCESS | 1652 | 10:08:32 INFO - PROCESS | 1652 | 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) 10:08:33 INFO - PROCESS | 1652 | RSS: Main: 248569856 10:08:33 INFO - PROCESS | 1652 | 10:08:34 INFO - PROCESS | 1652 | 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) 10:08:35 INFO - PROCESS | 1652 | RSS: Main: 248578048 10:08:35 INFO - PROCESS | 1652 | 10:08:37 INFO - PROCESS | 1652 | 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) 10:08:38 INFO - PROCESS | 1652 | RSS: Main: 248606720 10:08:38 INFO - PROCESS | 1652 | 10:08:40 INFO - PROCESS | 1652 | 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) 10:08:40 INFO - PROCESS | 1652 | RSS: Main: 248750080 10:08:40 INFO - PROCESS | 1652 | 10:08:43 INFO - PROCESS | 1652 | 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) 10:08:44 INFO - PROCESS | 1652 | RSS: Main: 249012224 10:08:44 INFO - PROCESS | 1652 | 10:08:47 INFO - PROCESS | 1652 | 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) 10:08:48 INFO - PROCESS | 1652 | RSS: Main: 257093632 10:08:48 INFO - PROCESS | 1652 | 10:08:49 INFO - PROCESS | 1652 | 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) 10:08:50 INFO - PROCESS | 1652 | RSS: Main: 258609152 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | __start_tp_report 10:08:50 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:08:50 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:08:50 INFO - PROCESS | 1652 | |i|pagename|runs| 10:08:50 INFO - PROCESS | 1652 | |0;ai-astar;104;117;118;117;118;118;119;123;122;111 10:08:50 INFO - PROCESS | 1652 | |1;audio-beat-detection;141;132;146;168;115;115;112;139;160;95 10:08:50 INFO - PROCESS | 1652 | |2;audio-dft;201;195;200;195;200;196;230;277;198;195 10:08:50 INFO - PROCESS | 1652 | |3;audio-fft;84;85;83;91;61;60;59;61;73;52 10:08:50 INFO - PROCESS | 1652 | |4;audio-oscillator;88;78;71;60;59;69;115;101;104;104 10:08:50 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;90;88;90;88;91;111;138;88;90;87 10:08:50 INFO - PROCESS | 1652 | |6;imaging-darkroom;108;173;119;169;171;170;122;175;173;176 10:08:50 INFO - PROCESS | 1652 | |7;imaging-desaturate;93;80;147;147;92;94;92;94;108;116 10:08:50 INFO - PROCESS | 1652 | |8;json-parse-financial;61;59;60;65;62;63;63;62;63;63 10:08:50 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;106;65;86;115;126;83;72;72;74;74 10:08:50 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;85;86;83;90;85;85;86;88;84 10:08:50 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;142;139;146;159;164;142;142;146;218;148 10:08:50 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;178;163;171;169;171;171;200;238;185;172 10:08:50 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;67;67;66;68;66;69;65;67;69 10:08:50 INFO - PROCESS | 1652 | __end_tp_report 10:08:50 INFO - PROCESS | 1652 | __start_cc_report 10:08:50 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,952 10:08:50 INFO - PROCESS | 1652 | __end_cc_report 10:08:50 INFO - PROCESS | 1652 | __startTimestamp1485972530213__endTimestamp 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:08:50 INFO - PROCESS | 1652 | Number of tests: 14 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:5.50 (4.7%) stddev-sans-first:3.41 10:08:50 INFO - PROCESS | 1652 | Values: 104.0 117.0 118.0 117.0 118.0 118.0 119.0 123.0 122.0 111.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:143.50 stddev:22.98 (16.0%) stddev-sans-first:24.16 10:08:50 INFO - PROCESS | 1652 | Values: 141.0 132.0 146.0 168.0 115.0 115.0 112.0 139.0 160.0 95.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:208.70 Median:200.00 stddev:26.18 (13.1%) stddev-sans-first:27.62 10:08:50 INFO - PROCESS | 1652 | Values: 201.0 195.0 200.0 195.0 200.0 196.0 230.0 277.0 198.0 195.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:70.90 Median:78.00 stddev:13.90 (17.8%) stddev-sans-first:13.91 10:08:50 INFO - PROCESS | 1652 | Values: 84.0 85.0 83.0 91.0 61.0 60.0 59.0 61.0 73.0 52.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:64.50 stddev:20.25 (31.4%) stddev-sans-first:21.44 10:08:50 INFO - PROCESS | 1652 | Values: 88.0 78.0 71.0 60.0 59.0 69.0 115.0 101.0 104.0 104.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:89.00 stddev:16.31 (18.3%) stddev-sans-first:17.15 10:08:50 INFO - PROCESS | 1652 | Values: 90.0 88.0 90.0 88.0 91.0 111.0 138.0 88.0 90.0 87.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:155.60 Median:172.00 stddev:27.40 (15.9%) stddev-sans-first:23.02 10:08:50 INFO - PROCESS | 1652 | Values: 108.0 173.0 119.0 169.0 171.0 170.0 122.0 175.0 173.0 176.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:92.00 stddev:23.55 (25.6%) stddev-sans-first:24.48 10:08:50 INFO - PROCESS | 1652 | Values: 93.0 80.0 147.0 147.0 92.0 94.0 92.0 94.0 108.0 116.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.73 (2.7%) stddev-sans-first:1.79 10:08:50 INFO - PROCESS | 1652 | Values: 61.0 59.0 60.0 65.0 62.0 63.0 63.0 62.0 63.0 63.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:87.30 Median:73.00 stddev:20.96 (28.7%) stddev-sans-first:21.11 10:08:50 INFO - PROCESS | 1652 | Values: 106.0 65.0 86.0 115.0 126.0 83.0 72.0 72.0 74.0 74.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:2.17 (2.5%) stddev-sans-first:2.11 10:08:50 INFO - PROCESS | 1652 | Values: 83.0 85.0 86.0 83.0 90.0 85.0 85.0 86.0 88.0 84.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:147.00 stddev:23.66 (16.1%) stddev-sans-first:24.65 10:08:50 INFO - PROCESS | 1652 | Values: 142.0 139.0 146.0 159.0 164.0 142.0 142.0 146.0 218.0 148.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:175.00 stddev:22.30 (12.7%) stddev-sans-first:23.62 10:08:50 INFO - PROCESS | 1652 | Values: 178.0 163.0 171.0 169.0 171.0 171.0 200.0 238.0 185.0 172.0 10:08:50 INFO - PROCESS | 1652 | 10:08:50 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 10:08:50 INFO - PROCESS | 1652 | Values: 65.0 67.0 67.0 66.0 68.0 66.0 69.0 65.0 67.0 69.0 10:08:50 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:08:50 INFO - PROCESS | 1652 | 10:08:51 INFO - TEST-INFO | 1652: exit 0 10:08:51 INFO - TEST-OK | kraken | took 61673ms 10:08:51 INFO - SUITE-END | took 1177s 10:08:51 INFO - Completed test suite (00:19:37) 10:08:51 INFO - javascript benchmark 10:08:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7199.351822018464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.0586235853957, 3364.6467120952298, 3378.814165220912, 3410.147463134215, 3417.743669224808, 5671.631343962645, 5672.886542269157, 5737.082066869301, 5747.942520574793, 5752.7411266493, 5476.479734425233, 5601.943980560193, 5751.223584816049, 5755.913661295084, 5778.335491418488, 5178.585713142958, 5227.712475813829, 5254.395744489375, 5259.237410575464, 5311.601629877775, 5299.708516031616, 5308.6814791112465, 5315.415304316542, 5322.33470816148, 5358.946410535903, 4276.87169384919, 5052.545270925634, 5307.708076055816, 5315.309009828717, 5326.760295786679, 4394.582514661134, 4409.382686423904, 5190.2214667800135, 5220.112580861262, 5264.263003179539, 4269.252880745888, 4366.214081465335, 5149.974250128763, 5254.579633629339, 5293.100172970566, 5557.694326812064, 5724.198612194296, 5736.2256095427, 5798.304203495565, 5823.592348535604, 6111.926012480395, 6116.5183814016455, 6124.9912799099075, 6210.534209934228, 6277.560570760049, 6208.286047104596, 6213.00591905293, 6222.973209420486, 6231.065340198961, 6299.023651334051, 4943.752812359367, 5937.109433584954, 5958.046712525975, 5976.402359764033, 6024.006039003603, 6131.356207598227, 6153.046277826944, 6205.627662340274, 6205.751769929152, 6242.032484964838, 6076.3316035236085, 6149.538784591174, 6152.8049405570855, 6166.0, 6174.197354343906, 5605.607607467438, 5906.995810712189, 6213.844653883599, 6263.749450022039, 6326.620402775849, 6116.418940200674, 6142.324344322121, 6144.648177400964, 6162.014077747628, 6272.059191121369, 6250.093736408196, 6280.874382512324, 6286.402791734869, 6294.937050629526, 6295.905561416583, 4992.201247800334, 4997.85006449807, 4997.85006449807, 5002.324686167321, 5021.799128034838, 4375.912481750347, 4400.119976004812, 4434.091011342667, 4503.211937910918, 4518.638508919278, 5095.337606111182, 5445.556927414238, 5482.671039737628, 5850.707464626837, 5912.940870591325, 5905.143754155623, 6296.65368404733, 6300.495960323163, 6321.589096708699, 6322.620642761449, 5656.208130861683, 5702.372738998707, 5796.0, 5835.095560188178, 5849.736761845727, 5483.396826349099, 5490.0, 5501.834944951658, 5504.394516603171, 5505.284313039279, 6348.841278968062, 6353.587016843982, 6362.0774987627465, 6370.235571731422, 6375.234971803413, 6133.793750436688, 6163.229596300463, 6197.132401463708, 6251.499880009497, 6348.746050157942, 6321.146645203023, 6332.905006424815, 6358.1734374531015, 6364.554481186273, 6368.522360822864, 6240.469560087444, 6248.187735594525, 6258.812235632939, 6258.843528911813, 6267.0286105653695, 4632.2819962905805, 6061.818145455643, 6230.875382492415, 6324.146240257691, 6328.588641738273, 6116.457510225689, 6185.195924529782, 6187.566870319034, 6196.876062478816, 6209.379062093935, 6103.908441373472, 6141.7543298267565, 6148.723307451086, 6183.288921774054, 6220.098085777628, 5791.247137872049, 5891.351951285441, 5907.17299578068, 6015.458608725061, 6064.787732429344, 6081.0, 6122.611623597813, 6133.172021777003, 6145.539084568586, 6160.568760186744, 6003.159557661844, 6019.608725432833, 6030.30651475086, 6035.1249068885645, 6058.182145410489], "value": 5682.408214148553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.63544398651175, 447.9942529022345, 452.69895519479525, 513.8997895410391, 539.8488423241491, 35213.11967200818, 41185.17629647413, 41231.99999999996, 41247.79376103119, 41467.37798933018, 42197.0, 42952.0, 42955.35566966498, 43119.0, 43821.78089109558, 8002.559859207741, 9287.349885508, 9419.576119074658, 9540.0, 9540.284478664093, 11102.222844400896, 11199.944000279987, 11200.887991120107, 11222.0, 11248.100151987863, 11226.943865280662, 11260.380679062648, 11272.943635281812, 11281.943590282037, 11346.149038822081, 11218.102551795837, 11267.26762760418, 11268.887311126866, 11274.379909105037, 11297.09623230148, 11072.280301780358, 11125.221234513587, 11129.109671226282, 11145.777084458265, 11166.720831979266, 36874.63125368739, 37227.62772372269, 37274.0, 37287.0, 37307.25385492275, 3850.903727406809, 3914.412838074312, 3945.1123497213184, 3960.742551734128, 3978.900527486836, 27485.86257068702, 28158.0, 28172.295692607848, 29148.854255728587, 29252.561211581844, 3178.284885900677, 3179.5230715392877, 3197.216681912946, 3210.6949839765184, 3226.370857682753, 433849.0, 434797.0, 436625.0, 437533.8123309395, 438446.0, 54249.0, 54618.726906366006, 54620.0, 54836.451635483136, 54843.0, 51121.233181502306, 54419.0, 56904.0, 56975.715121424124, 57224.56938576486, 15666.921665391601, 15843.683126337639, 15854.128022958848, 15869.96845205058, 15899.0, 9943.0, 11193.27243729155, 11483.827742583868, 12532.937335313265, 12539.122261441611, 17999.910000449912, 18046.909765451088, 18125.637487250446, 18144.092795360444, 18261.908690456727, 6520.706568204442, 6739.0, 7999.880001799977, 8006.1570446185, 8022.593222033367, 790.4901338636547, 872.228078150841, 885.8892638420198, 893.5889490834289, 916.6608354908593, 29616.851915740714, 30186.396272074435, 30418.847905760773, 30970.380592388025, 31163.220919477193, 1032.2670903658336, 1080.2276372393776, 1094.7755710079573, 1111.522045520434, 1195.0738177912015, 15682.921585392, 15872.0, 15890.205489725467, 16098.678026439406, 16127.435539756052, 622721.0, 627331.8633406804, 627425.0, 627435.0, 628386.0, 61186.69406652938, 61770.69114654488, 61836.0, 61965.69017154886, 62123.6893815528, 1242.4967888005372, 1439.4242303078852, 1442.7186698593882, 1457.3441951122038, 1463.3268696399562, 29014.419711605227, 29412.852935735184, 29931.85034074816, 30038.24904377408, 30558.84720576383, 48812.0, 51967.480325196266, 52122.0, 52208.47791522188, 52379.0, 481622.0, 525193.0, 544078.0, 571627.0, 580868.0, 24596.631050534615, 25101.99592016299, 25324.240272791845, 25385.365365865262, 25526.872365638053, 36116.63883361133, 42223.366649499665, 42618.50835220752, 43177.3523397143, 43569.78215108904, 34192.0, 34336.82831585926, 34431.311373772885, 34559.30881382308, 34816.82591587026, 35760.28479430345, 35839.82080089583, 36005.45991810073, 36427.81786091052, 36649.0, 29224.56163157597, 34874.0, 35132.12169695778, 35803.28393432064, 36073.458898117075, 23193.304200874, 29692.960746374636, 31696.841515792272, 31761.841190793897, 33649.83175084109, 20465.59068818645, 22310.930612649456, 23974.52050959006, 24146.034158633458, 24491.26526204217], "value": 19606.136152518986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.2332163941136, 394.8361430006547, 399.8740396775016, 403.0769537758532, 421.9724969698782, 14551.563453096423, 16086.59783505413, 19777.0, 21212.151513939443, 21226.787732122673, 16952.83047169528, 20722.89638551809, 21503.0, 21734.3479695609, 21978.780212197875, 5692.743826527816, 5770.596058275912, 5947.910781338283, 6019.849503762397, 6034.24571928509, 5688.63023903447, 5900.881982360372, 5957.910631340534, 5970.940290597104, 5986.102084687288, 5829.358770535237, 5887.705614719268, 5889.558283128761, 5894.115882617621, 5902.203202567663, 5758.56810739192, 5766.336871259796, 5868.647881127104, 5879.67661778602, 5900.734466948998, 5772.8845423091725, 5787.450192231731, 5801.390853960315, 5805.10020946754, 5808.332041815203, 12928.353582320846, 20786.0, 23257.7674223259, 24707.0, 24845.62731559028, 2594.0, 2608.178423796498, 2636.3540932471474, 2722.42829005909, 2883.2935930696904, 9741.610335586569, 10013.449260290681, 10233.334833235816, 11375.715607109805, 15976.680466390724, 1775.5649865782837, 1817.0, 1832.7800663920282, 1834.9449516514392, 1835.9908200459047, 111890.88109118886, 117816.0, 123620.0, 127063.0, 129361.70638293496, 11661.533538658528, 11786.469608867621, 12012.87987120135, 12059.698507537207, 12092.516299348103, 15807.446739364066, 15809.683806323808, 15822.446214382442, 15824.446144385121, 15838.445654402041, 8597.871031934526, 8732.738017859474, 8817.426867253607, 8833.293336533063, 8940.50827204497, 8542.487450752975, 8572.571371431404, 8680.956595216983, 8707.738767836974, 8716.477011379338, 4641.721496710208, 4706.670533062653, 4741.407324084489, 4743.715377077387, 4774.594159496412, 1733.4712912561538, 2004.8797072175716, 2025.43287879394, 2060.9896950515154, 2064.8038436348525, 859.3898332184219, 875.8292133033997, 883.9734807955772, 899.487292243415, 913.8949020862686, 19541.804581954282, 20813.0, 20957.26649567258, 20963.475913102295, 21164.36506904795, 900.8513595256709, 904.2720609908955, 925.0795458518817, 925.1257561604353, 926.9258459323238, 9338.90661093394, 10547.736306592244, 10975.012248897478, 10994.725131871608, 11020.063294620048, 462435.0, 528607.0, 604837.0, 605859.0, 702548.0, 115508.42245788885, 129384.0, 131562.0, 135553.0, 161359.0, 946.6118891254553, 1029.5006921642996, 1044.9007344302431, 1075.784363669049, 1078.2021304234809, 18908.810911890705, 19249.807501925363, 19557.51106222356, 19644.80355196487, 19651.606967860847, 43573.56426435822, 45737.542624573325, 51559.0, 59118.40881591301, 60639.69680151571, 61117.69441152766, 66688.66655666885, 76937.0, 79109.0222744436, 82662.0, 7966.322862556747, 8196.508209507449, 8248.876266855881, 8422.157784221528, 8557.486550806723, 12233.143679942674, 12571.93714031424, 12739.74520509566, 13015.47938082504, 13052.934735326262, 9211.907880921373, 10959.287646302964, 11141.610043648758, 11270.718232044264, 11275.210735248455, 10608.52261648243, 10995.945020274847, 10996.835047474135, 11033.172512061466, 11457.369844658624, 10847.67456976292, 11050.060744836457, 11073.667789966314, 11140.053095486974, 11421.1434142438, 7962.442629016145, 8079.394045446497, 8084.797880053045, 8150.4294699370475, 8209.958950205211, 7683.807904802425, 10287.639932602324, 10359.482025898524, 10556.736081598021, 10699.197560183173], "value": 9620.421310361751, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.1061809823614, 1403.1440821099127, 1424.679447124397, 1444.913305201688, 1450.876675482584, 7456.142543607473, 7694.269044440784, 7951.681932722691, 8391.748247552576, 8401.159884011597, 7903.012123484565, 8198.42611017229, 8207.0, 8322.375821813357, 8335.291500222489, 2233.888305584718, 2282.5549017941507, 2287.2909398086645, 2290.6334986402094, 2291.656251562271, 2068.4932191613075, 2150.483883867876, 2324.535092981402, 2347.6947996760396, 2362.7637236276405, 2251.0, 2325.1280769711357, 2328.092044102801, 2329.895154718042, 2332.1371092695726, 2273.27255278311, 2279.247848210095, 2283.6917016202765, 2283.931482055541, 2301.0450662974845, 2183.716116904792, 2309.976900230993, 2319.988400058006, 2366.2073205476013, 2368.9170879019325, 7222.819429514252, 8347.83304333916, 8374.49753014821, 8387.538685372301, 8411.0, 5021.39743230811, 5167.819126330561, 5188.5849132069725, 5188.8962220755375, 5192.506711862405, 3127.6090488688915, 3228.0, 3262.869485220588, 3287.7534184936226, 3358.227607650254, 1044.8798388185303, 1078.5362294213485, 1087.331291255872, 1152.9077673786162, 1698.626302213511, 9921.958194389557, 10016.649417270433, 10490.31812932157, 10725.999999999922, 10727.302725322828, 4231.4710661167355, 4413.7793110344355, 4480.059187570647, 4480.148771733426, 4498.0104377037, 8512.914870851337, 8553.144685531397, 8578.871316930252, 8602.655893764178, 8606.526641034803, 4321.416608757841, 4510.255807791743, 4848.248521479177, 5037.29477873098, 5050.621203409759, 4599.540045995441, 4717.457492388419, 4726.976365118221, 4750.5249475052215, 4773.570378665937, 3427.280271143038, 3813.828377723009, 3905.8047097645003, 3959.6634286085427, 3989.3218152914073, 1194.940252987347, 1231.96920076997, 1269.3716610277972, 1282.9422675979604, 1300.8634093420244, 898.276887105873, 913.9908600914039, 922.2222774318898, 930.3766476460787, 947.9526023698926, 5488.7530061147345, 5623.943760562342, 5655.604107712503, 5760.8271751847515, 5797.971010144923, 975.5561219645044, 992.6079198716467, 1007.3955626624113, 1019.4851599941982, 1021.0759262867117, 3589.6589823966683, 3596.8381422836037, 3601.3877640801124, 3846.6345697158727, 3881.874256465593, 9643.951780241054, 9865.753356166153, 9914.058164474363, 9940.652077177409, 9941.806983161921, 9790.461524616214, 9811.509424528746, 9812.852807207897, 9817.214622830157, 9822.508874556244, 7418.554886706815, 7612.809679757939, 7743.45795794289, 7747.922520774833, 7822.530648161242, 5414.891702165856, 5430.511253987002, 5434.2120392542065, 5597.888042239214, 5601.943980560142, 8968.327375446737, 8991.0, 9128.361014728906, 9158.816823663623, 9215.815683686424, 8683.739487815375, 9130.497822619554, 9141.908580914105, 9143.862842057242, 9268.304877134107, 7009.228984811564, 7222.711091556279, 7238.674259658434, 7240.710371585288, 7248.166460857069, 7661.961690191513, 7689.192634773492, 7697.46117771773, 7767.495112817649, 7781.182975787461, 6340.240724655664, 7052.612106334201, 7088.17238691101, 7089.503734738519, 7212.990181374506, 6978.302169782981, 6990.126234220723, 6997.650117494207, 7108.0, 7113.964430177816, 5491.258680078298, 6379.96810015947, 6413.935860641333, 6462.127612772216, 6483.870322593616, 3972.0467087899274, 4021.4973128358956, 4050.837966481308, 4076.551579326331, 4152.501699795923, 4721.315409265706, 4779.948411349497, 4853.733044682435, 4926.852194434173, 5018.623603229699], "value": 4339.962528187786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.4048498153877, 302.92275469755214, 324.3512974051896, 357.3960007587178, 363.6508951406648, 4454.554544545548, 5011.849644510661, 5322.9620224056325, 5389.595780316477, 5468.7539060742265, 4222.514410842754, 5236.0, 5344.35867695877, 5349.164942580439, 5349.973250133744, 3583.9641603584023, 3951.8221680024394, 4069.8429832188986, 4195.559466256045, 4199.685023623225, 3644.835982380799, 3944.704147188958, 4186.974191323115, 4217.367394890775, 4229.0, 3951.7628942263414, 4143.129942712034, 4210.663146948237, 4235.830566777326, 4241.809118589656, 3330.8834190803204, 3901.7073719471155, 4037.222478097857, 4223.260929337353, 4251.298535741599, 3135.4826453635123, 3539.239063601338, 3674.5223120994365, 3707.5921648618632, 3712.535933008374, 4615.561521655437, 5092.6180536459915, 5348.625596208267, 5361.212169671788, 5373.59698022646, 4358.5205627380965, 4498.752568608726, 4742.928856067162, 4906.092372910987, 4929.260610908356, 5017.04335309226, 5318.9202161967605, 5713.54304652311, 5721.227634269362, 5734.741936612862, 3500.859965601373, 3678.0, 3890.440247173861, 3917.882463526099, 3923.470331505239, 4781.713097214143, 5647.216365035436, 5969.37321581232, 6039.909401358983, 6055.850173188499, 3861.7489863158803, 3867.535895692479, 3885.9222815544094, 3920.1179734560064, 3922.4116382542275, 3928.3518219493462, 3938.8621398250925, 3965.8810235692977, 3981.3629819228786, 3985.561588225293, 4414.6247568957, 4625.514320996314, 4625.976870115628, 4639.489656137822, 4670.6497012724185, 4417.046743164849, 5027.0, 5387.9461205388225, 5482.5613950883835, 5795.275590551181, 1228.238492134882, 1236.1532350340046, 1297.8702129786946, 1305.3668970549465, 1313.7175507265983, 754.0, 837.8240569480478, 846.4328899637258, 863.2144748279036, 876.1895246896595, 4545.181867263858, 5065.518775716301, 5219.269302297681, 5264.42091369949, 5431.565474762009, 4842.377803435818, 5017.949820501822, 5400.432954539795, 5576.347492392409, 5922.585419020627, 5068.771905264272, 5269.578433725293, 5330.786768529293, 5343.644929382541, 5352.91970620441, 2501.912433064834, 2585.4958283134606, 2672.6347182743025, 2685.879135438871, 2908.578256152846, 4842.903141937212, 5241.266222728821, 5442.265294185234, 5901.203337549462, 5934.970325148347, 4690.217717267416, 5466.508014278734, 5829.8251052468495, 5862.062070068854, 5868.559858010581, 4999.42506611737, 5294.9205761912835, 5498.80754173602, 5892.234009578813, 5912.497437717756, 4709.163426263828, 4772.117158325721, 4947.505249475023, 5532.5020748132865, 5661.801836935852, 5373.892522149613, 5592.804251851166, 5863.20846685692, 5872.26939473147, 5882.823515294548, 4892.510748925079, 5411.594130440154, 5843.328017278068, 6149.446549810538, 6236.906446403217, 3917.373220284741, 3928.253631809947, 3935.2916475034767, 3967.147063381387, 3975.5428125765907, 4709.552592503706, 5535.667859928417, 5851.561132915133, 5864.9413505866105, 5885.14570433348, 5718.542516598579, 5721.885562288648, 5727.942720572908, 5743.07103377289, 5763.250777398911, 4772.546608072227, 5168.689878607145, 5503.862403439946, 5520.944790552204, 5543.863507980774, 5096.541311282002, 5157.613179011514, 5618.550515958632, 5622.184783206494, 5624.831255062355, 4548.727076375428, 4874.4150701916, 5029.698218106779, 5703.657780533182, 5760.0, 5435.782568697208, 5580.972095139498, 5611.494965453129, 5629.521490673339, 5629.634073785191], "value": 4087.734115129187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.358643254989, 694.6075467360938, 765.7090305683839, 819.4386845011167, 829.3531045784289, 13066.869331306683, 13142.540011099614, 14712.0, 14800.481983130592, 15710.371585136609, 12900.419481123348, 14467.710645787078, 14575.34410951507, 14609.707805843876, 14707.264636768146, 629.6064959400375, 684.264415753065, 686.3822559696264, 827.1108558299852, 851.0170752780548, 859.7893516088567, 861.6682577207757, 865.5066612031145, 867.0462491259627, 873.6767396063466, 911.1344222988188, 915.1580545897757, 915.6749353979342, 917.5045475443253, 918.5269586163131, 782.6008735544884, 908.0737647599411, 908.2960705453261, 913.5477938420524, 913.7624217703378, 672.8553361027354, 678.2268214235775, 679.0086473748333, 679.966001699913, 680.3706571421465, 14491.565253042425, 14749.0, 14867.702645947129, 15214.087154770748, 15254.847451525564, 12358.25850448967, 14170.504032358818, 14499.927500362535, 14605.853941460555, 14644.194569298685, 10708.089812365959, 10761.30051546647, 10897.83653245202, 10986.505607247693, 11233.32600044, 3688.7602305850032, 3706.721995850295, 3755.6056614055406, 3779.5653499847595, 3873.8837834865, 95409.5229523855, 97094.51452742761, 97275.51362243215, 97632.51183744035, 97985.0, 10678.412687302118, 10736.248462607542, 10830.350178989285, 10846.0, 11004.724881877857, 22275.777242227694, 22395.32814015582, 22495.43761405945, 22963.425914352276, 22969.88515057414, 7830.33442157423, 7864.528128312205, 7881.724139655199, 7910.090339611018, 8028.157043510348, 4214.346627531121, 4281.807318670667, 4382.496012958487, 4394.231009573376, 4399.62603178727, 3537.2394935088564, 3606.7294952878638, 3609.639036096422, 3612.6387361263664, 3614.584322802859, 691.778630838137, 707.992920070803, 717.1430140981477, 717.8887272472775, 741.7033186725353, 671.2314400011959, 674.7537148940602, 691.4606606846668, 699.3251512290664, 726.9927300726926, 9875.061869122423, 10224.539895704562, 10226.199577281024, 10259.846102308471, 10554.788904221872, 691.515938842812, 691.9100516932766, 693.9618320992394, 697.6442014572503, 706.8762966480846, 4066.9389959150635, 4082.0203151243486, 4764.523547645208, 5062.215356619729, 5081.822136225214, 60992.695036524536, 79890.60054699806, 81921.77117343244, 90790.54604726934, 99693.50153249188, 50038.74903127378, 78623.21376786158, 80808.59595701983, 82149.58925205335, 82882.75675864867, 47769.28346074812, 69720.30279697239, 71308.2869171312, 72395.91406128912, 74304.62847685727, 10328.225383096147, 10637.627683031365, 10729.356238625707, 10840.241183117107, 10914.727131821768, 42880.0, 43072.0, 44605.330920036875, 44622.0, 45244.86887827831, 57824.71087644535, 58794.0, 59458.70270648619, 61525.69237153786, 61572.0, 11771.823422648496, 11813.527458901548, 12774.74450510966, 12783.105182637126, 12808.935955320163, 14024.509142179975, 14605.415783368971, 14778.77831832502, 14808.111513309235, 14892.7766083511, 12857.421416036113, 13010.869891301345, 13109.868901311247, 14211.0, 14235.572932812032, 12723.618291451272, 13525.729485410433, 13527.458901644217, 13748.793768093286, 13772.380242888894, 12672.0, 13387.464501420223, 13673.931630341785, 13794.724105518035, 13825.377857996213, 10829.729256768644, 11078.833817492583, 11368.374739389414, 11392.886071139183, 11639.127065469955, 9316.906830931875, 9692.854607180758, 10489.213309001703, 10737.14102871784, 10813.67558973232], "value": 7321.934502322444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 123.0, 122.0, 111.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 146.0, 168.0, 115.0, 115.0, 112.0, 139.0, 160.0, 95.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 195.0, 200.0, 195.0, 200.0, 196.0, 230.0, 277.0, 198.0, 195.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 91.0, 61.0, 60.0, 59.0, 61.0, 73.0, 52.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 71.0, 60.0, 59.0, 69.0, 115.0, 101.0, 104.0, 104.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 91.0, 111.0, 138.0, 88.0, 90.0, 87.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 173.0, 119.0, 169.0, 171.0, 170.0, 122.0, 175.0, 173.0, 176.0], "value": 155.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 80.0, 147.0, 147.0, 92.0, 94.0, 92.0, 94.0, 108.0, 116.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 65.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 65.0, 86.0, 115.0, 126.0, 83.0, 72.0, 72.0, 74.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 83.0, 90.0, 85.0, 85.0, 86.0, 88.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 146.0, 159.0, 164.0, 142.0, 142.0, 146.0, 218.0, 148.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 163.0, 171.0, 169.0, 171.0, 171.0, 200.0, 238.0, 185.0, 172.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 68.0, 66.0, 69.0, 65.0, 67.0, 69.0], "value": 66.9, "unit": "score"}]}]} 10:08:51 INFO - Return code: 0 10:08:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:51 ERROR - # TBPL SUCCESS # 10:08:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:51 INFO - 2017-02-01 10:08:51.517 screenresolution[1657:10807] starting screenresolution argv=screenresolution get 10:08:51 INFO - 2017-02-01 10:08:51.520 screenresolution[1657:10807] Display 0: 1600x1200x32@60 10:08:51 INFO - 2017-02-01 10:08:51.526 screenresolution[1658:10810] starting screenresolution argv=screenresolution list 10:08:51 INFO - Available Modes on Display 0 10:08:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:51 INFO - Intel Iris: 10:08:51 INFO - Chipset Model: Intel Iris 10:08:51 INFO - Type: GPU 10:08:51 INFO - Bus: Built-In 10:08:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:51 INFO - Vendor: Intel (0x8086) 10:08:51 INFO - Device ID: 0x0a2e 10:08:51 INFO - Revision ID: 0x0009 10:08:51 INFO - Displays: 10:08:51 INFO - Display: 10:08:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:51 INFO - Display Serial Number: 1600x1200 60 10:08:51 INFO - Main Display: Yes 10:08:51 INFO - Mirror: Off 10:08:51 INFO - Online: Yes 10:08:51 INFO - Rotation: Supported 10:08:51 INFO - Return code: 0 10:08:51 INFO - Running post-action listener: _resource_record_post_action 10:08:51 INFO - [mozharness: 2017-02-01 18:08:51.764630Z] Finished run-tests step (success) 10:08:51 INFO - Running post-run listener: _resource_record_post_run 10:08:51 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38701568; Write bytes: 511044096; Read time: 245; Write time: 1614 10:08:51 INFO - TinderboxPrint: CPU usage
54.1% 10:08:51 INFO - TinderboxPrint: I/O read bytes / time
38,701,568 / 245 10:08:51 INFO - TinderboxPrint: I/O write bytes / time
511,044,096 / 1,614 10:08:51 INFO - TinderboxPrint: CPU idle
2,200.0 (45.9%) 10:08:51 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 10:08:51 INFO - TinderboxPrint: CPU user
1,632.9 (34.0%) 10:08:51 INFO - TinderboxPrint: Swap in / out
246,751,232 / 0 10:08:51 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 195758592; Write bytes: 188018688; Read time: 15801; Write time: 396 10:08:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37767680; Write bytes: 302565888; Read time: 232; Write time: 1157 10:08:52 INFO - Running post-run listener: _upload_blobber_files 10:08:52 INFO - Blob upload gear active. 10:08:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:52 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 10:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:53 INFO - (blobuploader) - INFO - Done attempting. 10:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:54 INFO - (blobuploader) - INFO - Done attempting. 10:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:55 INFO - (blobuploader) - INFO - Done attempting. 10:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:57 INFO - (blobuploader) - INFO - Done attempting. 10:08:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:57 INFO - Return code: 0 10:08:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61715a1fdaa565a3dbf90667677309156e434ef9bdf143a2eff4ce16928acb735004cff19aa3c632e796964abb3fe9c6a4bb8689de8a57c1d5166258580dcf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9e01d86b32db4015691a1d4fa5c74ece6ce7da222688d05508d57a60faa4871f039b381cc827b369e658af301e22d685ef47eac3fb7308455603b129d2dbae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/070fc942f0dadcd92dfe86b9e134a387db968757d6991065a98a9fa4e1e23e8c64f4b77404894df6b9a0c68782eb8d83ab92636c066145029d8752a24b8ad910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29014e09cddba348693fcefec7866fef4f1fc645b1c81301f6b41d2838ed61fccd97fc4819fd3281a25e8494c90e1e2709c2ceae875efa4fa43b61c9878ff310"} 10:08:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:57 INFO - Contents: 10:08:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61715a1fdaa565a3dbf90667677309156e434ef9bdf143a2eff4ce16928acb735004cff19aa3c632e796964abb3fe9c6a4bb8689de8a57c1d5166258580dcf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9e01d86b32db4015691a1d4fa5c74ece6ce7da222688d05508d57a60faa4871f039b381cc827b369e658af301e22d685ef47eac3fb7308455603b129d2dbae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/070fc942f0dadcd92dfe86b9e134a387db968757d6991065a98a9fa4e1e23e8c64f4b77404894df6b9a0c68782eb8d83ab92636c066145029d8752a24b8ad910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29014e09cddba348693fcefec7866fef4f1fc645b1c81301f6b41d2838ed61fccd97fc4819fd3281a25e8494c90e1e2709c2ceae875efa4fa43b61c9878ff310"} 10:08:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:57 INFO - Copying logs to upload dir... 10:08:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.582015 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-01 10:08:57.793040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:08:57.800651) ========= 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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/Mozilla-Aurora/sha512/61715a1fdaa565a3dbf90667677309156e434ef9bdf143a2eff4ce16928acb735004cff19aa3c632e796964abb3fe9c6a4bb8689de8a57c1d5166258580dcf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9e01d86b32db4015691a1d4fa5c74ece6ce7da222688d05508d57a60faa4871f039b381cc827b369e658af301e22d685ef47eac3fb7308455603b129d2dbae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/070fc942f0dadcd92dfe86b9e134a387db968757d6991065a98a9fa4e1e23e8c64f4b77404894df6b9a0c68782eb8d83ab92636c066145029d8752a24b8ad910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29014e09cddba348693fcefec7866fef4f1fc645b1c81301f6b41d2838ed61fccd97fc4819fd3281a25e8494c90e1e2709c2ceae875efa4fa43b61c9878ff310"} build_url:https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010491 build_url: 'https://queue.taskcluster.net/v1/task/BROaG3VBR6mhpBqM7ha5qQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61715a1fdaa565a3dbf90667677309156e434ef9bdf143a2eff4ce16928acb735004cff19aa3c632e796964abb3fe9c6a4bb8689de8a57c1d5166258580dcf00", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9e01d86b32db4015691a1d4fa5c74ece6ce7da222688d05508d57a60faa4871f039b381cc827b369e658af301e22d685ef47eac3fb7308455603b129d2dbae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/070fc942f0dadcd92dfe86b9e134a387db968757d6991065a98a9fa4e1e23e8c64f4b77404894df6b9a0c68782eb8d83ab92636c066145029d8752a24b8ad910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29014e09cddba348693fcefec7866fef4f1fc645b1c81301f6b41d2838ed61fccd97fc4819fd3281a25e8494c90e1e2709c2ceae875efa4fa43b61c9878ff310"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:08:57.841125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:08:57.841472) ========= 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.LDBN0c2xXJ/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.UYZ4rmb2S1/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005115 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:08:57.893232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:08:57.893557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:08:57.893871) ========= ========= Total master_lag: 0.20 =========