builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0123 starttime: 1485528801.52 results: success (0) buildid: 20170127052320 builduid: f078e340bcc149a78118696579dadae6 revision: bfd739f11ec69a228b01823577a6482a3ff9cc9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.524541) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.525000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.525285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.549829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.550151) ========= 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.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 06:53:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2017-01-27 06:53:21 (16.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.655537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.655878) ========= 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.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.020146 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.704480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:21.705308) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfd739f11ec69a228b01823577a6482a3ff9cc9a --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 bfd739f11ec69a228b01823577a6482a3ff9cc9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 06:53:21,798 truncating revision to first 12 chars 2017-01-27 06:53:21,798 Setting DEBUG logging. 2017-01-27 06:53:21,799 attempt 1/10 2017-01-27 06:53:21,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfd739f11ec6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 06:53:22,195 unpacking tar archive at: mozilla-aurora-bfd739f11ec6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640580 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:22.370833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:22.371148) ========= script_repo_revision: bfd739f11ec69a228b01823577a6482a3ff9cc9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:22.371537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:22.371824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 06:53:22.391090) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-27 06:53:22.391376) ========= /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.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:53:22 INFO - MultiFileLogger online at 20170127 06:53:22 in /builds/slave/test 06:53:22 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 06:53:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:53:22 INFO - {'append_to_log': False, 06:53:22 INFO - 'base_work_dir': '/builds/slave/test', 06:53:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:53:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:53:22 INFO - 'branch': 'Mozilla-Aurora', 06:53:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:22 INFO - 'config_files': ('talos/mac_config.py',), 06:53:22 INFO - 'default_actions': ('clobber', 06:53:22 INFO - 'read-buildbot-config', 06:53:22 INFO - 'download-and-extract', 06:53:22 INFO - 'populate-webroot', 06:53:22 INFO - 'create-virtualenv', 06:53:22 INFO - 'install', 06:53:22 INFO - 'run-tests'), 06:53:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:22 INFO - 'download_minidump_stackwalk': True, 06:53:22 INFO - 'download_symbols': 'ondemand', 06:53:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:22 INFO - 'installer_path': 'installer.exe', 06:53:22 INFO - 'log_level': 'info', 06:53:22 INFO - 'log_name': 'talos', 06:53:22 INFO - 'log_to_console': True, 06:53:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:53:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:53:22 INFO - 'opt_config_files': (), 06:53:22 INFO - 'pip_index': False, 06:53:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:22 INFO - 'cmd': ('bash', 06:53:22 INFO - '-c', 06:53:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:22 INFO - 'enabled': True, 06:53:22 INFO - 'halt_on_failure': False, 06:53:22 INFO - 'name': 'check_screen_resolution'},), 06:53:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:22 INFO - 'cmd': ('bash', 06:53:22 INFO - '-c', 06:53:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:22 INFO - 'enabled': True, 06:53:22 INFO - 'halt_on_failure': False, 06:53:22 INFO - 'name': 'check_screen_resolution'},), 06:53:22 INFO - 'run_cmd_checks_enabled': True, 06:53:22 INFO - 'sps_profile': False, 06:53:22 INFO - 'sps_profile_interval': 0, 06:53:22 INFO - 'suite': 'dromaeojs-e10s', 06:53:22 INFO - 'system_bits': '32', 06:53:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:22 INFO - 'title': 't-yosemite-r7-0123', 06:53:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:22 INFO - 'use_talos_json': True, 06:53:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:53:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:22 INFO - 'work_dir': 'build'} 06:53:22 INFO - [mozharness: 2017-01-27 14:53:22.607736Z] Running clobber step. 06:53:22 INFO - Running pre-action listener: _resource_record_pre_action 06:53:22 INFO - Running main action method: clobber 06:53:22 INFO - rmtree: /builds/slave/test/build 06:53:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:53:24 INFO - Running post-action listener: _resource_record_post_action 06:53:24 INFO - [mozharness: 2017-01-27 14:53:24.373775Z] Finished clobber step (success) 06:53:24 INFO - [mozharness: 2017-01-27 14:53:24.373930Z] Running read-buildbot-config step. 06:53:24 INFO - Running pre-action listener: _resource_record_pre_action 06:53:24 INFO - Running main action method: read_buildbot_config 06:53:24 INFO - Using buildbot properties: 06:53:24 INFO - { 06:53:24 INFO - "project": "", 06:53:24 INFO - "product": "firefox", 06:53:24 INFO - "script_repo_revision": "production", 06:53:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:53:24 INFO - "repository": "", 06:53:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:53:24 INFO - "buildid": "20170127052320", 06:53:24 INFO - "pgo_build": "False", 06:53:24 INFO - "basedir": "/builds/slave/test", 06:53:24 INFO - "buildnumber": 22, 06:53:24 INFO - "slavename": "t-yosemite-r7-0123", 06:53:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:53:24 INFO - "platform": "yosemite_r7", 06:53:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:53:24 INFO - "branch": "mozilla-aurora", 06:53:24 INFO - "repo_path": "releases/mozilla-aurora", 06:53:24 INFO - "revision": "bfd739f11ec69a228b01823577a6482a3ff9cc9a", 06:53:24 INFO - "stage_platform": "macosx64", 06:53:24 INFO - "builduid": "f078e340bcc149a78118696579dadae6", 06:53:24 INFO - "slavebuilddir": "test" 06:53:24 INFO - } 06:53:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 06:53:24 INFO - Running post-action listener: _resource_record_post_action 06:53:24 INFO - [mozharness: 2017-01-27 14:53:24.377192Z] Finished read-buildbot-config step (success) 06:53:24 INFO - [mozharness: 2017-01-27 14:53:24.377301Z] Running download-and-extract step. 06:53:24 INFO - Running pre-action listener: _resource_record_pre_action 06:53:24 INFO - Running main action method: download_and_extract 06:53:24 INFO - mkdir: /builds/slave/test/build/tests 06:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:24 INFO - trying https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 06:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 06:53:25 INFO - Downloaded 1199 bytes. 06:53:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:53:25 INFO - Using the following test package requirements: 06:53:25 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:53:25 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 06:53:25 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 06:53:25 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'jsshell-mac.zip'], 06:53:25 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 06:53:25 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:53:25 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 06:53:25 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 06:53:25 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 06:53:25 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:53:25 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 06:53:25 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:53:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:53:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:53:25 INFO - Fetch https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:53:26 INFO - Expected file size: 16350769 06:53:26 INFO - Obtained file size: 16350769 06:53:32 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:53:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:53:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:53:32 INFO - Fetch https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:53:33 INFO - Expected file size: 16350769 06:53:33 INFO - Obtained file size: 16350769 06:53:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 06:53:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:53:40 INFO - Fetch https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 06:53:41 INFO - Expected file size: 14403485 06:53:41 INFO - Obtained file size: 14403485 06:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:42 INFO - trying https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:53:42 INFO - Downloading https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 06:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 06:53:44 INFO - Downloaded 73895701 bytes. 06:53:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:53:44 INFO - mkdir: /builds/slave/test/properties 06:53:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:53:44 INFO - Writing to file /builds/slave/test/properties/build_url 06:53:44 INFO - Contents: 06:53:44 INFO - build_url:https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:53:44 INFO - Running post-action listener: _resource_record_post_action 06:53:44 INFO - Running post-action listener: set_extra_try_arguments 06:53:44 INFO - [mozharness: 2017-01-27 14:53:44.977064Z] Finished download-and-extract step (success) 06:53:44 INFO - [mozharness: 2017-01-27 14:53:44.977205Z] Running populate-webroot step. 06:53:44 INFO - Running pre-action listener: _resource_record_pre_action 06:53:44 INFO - Running main action method: populate_webroot 06:53:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:53:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:53:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:53:44 INFO - '--tppagecycles', 06:53:44 INFO - '7'], 06:53:44 INFO - 'tests': ['tsvgm']}}, 06:53:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:53:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:53:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:53:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:53:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['damp', 'tps']}, 06:53:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'tests': ['damp', 'tps']}, 06:53:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['dromaeo_dom']}, 06:53:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:53:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['basic_compositor_video']}, 06:53:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:53:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'other-e10s': {'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['a11yr', 06:53:44 INFO - 'ts_paint', 06:53:44 INFO - 'tpaint', 06:53:44 INFO - 'sessionrestore', 06:53:44 INFO - 'sessionrestore_no_auto_restore', 06:53:44 INFO - 'tabpaint']}, 06:53:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['tsvgx', 06:53:44 INFO - 'tsvgr_opacity', 06:53:44 INFO - 'tart', 06:53:44 INFO - 'tscrollx', 06:53:44 INFO - 'cart', 06:53:44 INFO - 'tsvg_static']}, 06:53:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:53:44 INFO - 'tsvgr_opacity', 06:53:44 INFO - 'tart', 06:53:44 INFO - 'tscrollx', 06:53:44 INFO - 'cart', 06:53:44 INFO - 'tsvg_static']}, 06:53:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'talos_options': ['--disable-e10s'], 06:53:44 INFO - 'tests': ['tp5o']}, 06:53:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:53:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'talos_options': ['--disable-e10s', 06:53:44 INFO - '--xperf_path', 06:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:44 INFO - 'tests': ['tp5n']}, 06:53:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:53:44 INFO - 'talos_options': ['--xperf_path', 06:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:44 INFO - 'tests': ['tp5n']}}, 06:53:44 INFO - 'talos.zip': {'path': '', 06:53:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:53:44 INFO - Running post-action listener: _resource_record_post_action 06:53:44 INFO - [mozharness: 2017-01-27 14:53:44.995927Z] Finished populate-webroot step (success) 06:53:44 INFO - [mozharness: 2017-01-27 14:53:44.996040Z] Running create-virtualenv step. 06:53:44 INFO - Running pre-action listener: _resource_record_pre_action 06:53:44 INFO - Running main action method: create_virtualenv 06:53:44 INFO - Creating virtualenv /builds/slave/test/build/venv 06:53:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:53:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:53:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:53:45 INFO - Using real prefix '/tools/python27' 06:53:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:53:45 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:48 INFO - Installing pip.................done. 06:53:48 INFO - Return code: 0 06:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:53:48 INFO - Reading from file tmpfile_stdout 06:53:48 INFO - Output received: 06:53:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:53:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:48 INFO - 'HOME': '/Users/cltbld', 06:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:48 INFO - 'LOGNAME': 'cltbld', 06:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:48 INFO - 'MOZ_NO_REMOTE': '1', 06:53:48 INFO - 'NO_EM_RESTART': '1', 06:53:48 INFO - 'PAGER': '/bin/cat', 06:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:48 INFO - 'PWD': '/builds/slave/test', 06:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:48 INFO - 'SHELL': '/bin/bash', 06:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:53:48 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:48 INFO - 'USER': 'cltbld', 06:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:48 INFO - 'XPC_FLAGS': '0x0', 06:53:48 INFO - 'XPC_SERVICE_NAME': '0', 06:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:53:49 INFO - Cleaning up... 06:53:49 INFO - Return code: 0 06:53:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:49 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:49 INFO - 'HOME': '/Users/cltbld', 06:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:49 INFO - 'LOGNAME': 'cltbld', 06:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:49 INFO - 'MOZ_NO_REMOTE': '1', 06:53:49 INFO - 'NO_EM_RESTART': '1', 06:53:49 INFO - 'PAGER': '/bin/cat', 06:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:49 INFO - 'PWD': '/builds/slave/test', 06:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:49 INFO - 'SHELL': '/bin/bash', 06:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:53:49 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:49 INFO - 'USER': 'cltbld', 06:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:49 INFO - 'XPC_FLAGS': '0x0', 06:53:49 INFO - 'XPC_SERVICE_NAME': '0', 06:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:49 INFO - Downloading/unpacking psutil>=3.1.1 06:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:53:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:53 INFO - Installing collected packages: psutil 06:53:53 INFO - Running setup.py install for psutil 06:53:53 INFO - building 'psutil._psutil_osx' extension 06:53:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:53:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:53:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:53:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:53:53 INFO - building 'psutil._psutil_posix' extension 06:53:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:53:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:53:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:53:53 INFO - ^ 06:53:53 INFO - 1 warning generated. 06:53:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:53:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:53 INFO - Successfully installed psutil 06:53:53 INFO - Cleaning up... 06:53:53 INFO - Return code: 0 06:53:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:53 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:53 INFO - 'HOME': '/Users/cltbld', 06:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:53 INFO - 'LOGNAME': 'cltbld', 06:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:53 INFO - 'MOZ_NO_REMOTE': '1', 06:53:53 INFO - 'NO_EM_RESTART': '1', 06:53:53 INFO - 'PAGER': '/bin/cat', 06:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:53 INFO - 'PWD': '/builds/slave/test', 06:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:53 INFO - 'SHELL': '/bin/bash', 06:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:53:53 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:53 INFO - 'USER': 'cltbld', 06:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:53 INFO - 'XPC_FLAGS': '0x0', 06:53:53 INFO - 'XPC_SERVICE_NAME': '0', 06:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:53:56 INFO - Installing collected packages: mozsystemmonitor 06:53:56 INFO - Running setup.py install for mozsystemmonitor 06:53:57 INFO - Successfully installed mozsystemmonitor 06:53:57 INFO - Cleaning up... 06:53:57 INFO - Return code: 0 06:53:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:53: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')]} 06:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53: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')]} 06:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:57 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:57 INFO - 'HOME': '/Users/cltbld', 06:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:57 INFO - 'LOGNAME': 'cltbld', 06:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:57 INFO - 'MOZ_NO_REMOTE': '1', 06:53:57 INFO - 'NO_EM_RESTART': '1', 06:53:57 INFO - 'PAGER': '/bin/cat', 06:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:57 INFO - 'PWD': '/builds/slave/test', 06:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:57 INFO - 'SHELL': '/bin/bash', 06:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:53:57 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:57 INFO - 'USER': 'cltbld', 06:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:57 INFO - 'XPC_FLAGS': '0x0', 06:53:57 INFO - 'XPC_SERVICE_NAME': '0', 06:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:57 INFO - Downloading/unpacking jsonschema==2.5.1 06:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:00 INFO - warning: no files found matching '*.txt' 06:54:00 INFO - no previously-included directories found matching 'build' 06:54:00 INFO - no previously-included directories found matching 'dist' 06:54:00 INFO - no previously-included directories found matching '.git*' 06:54:00 INFO - Installing collected packages: jsonschema, functools32 06:54:00 INFO - Running setup.py install for functools32 06:54:00 INFO - warning: no files found matching '*.txt' 06:54:00 INFO - no previously-included directories found matching 'build' 06:54:00 INFO - no previously-included directories found matching 'dist' 06:54:00 INFO - no previously-included directories found matching '.git*' 06:54:00 INFO - Successfully installed jsonschema functools32 06:54:00 INFO - Cleaning up... 06:54:00 INFO - Return code: 0 06:54:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:00 INFO - 'HOME': '/Users/cltbld', 06:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:00 INFO - 'LOGNAME': 'cltbld', 06:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:00 INFO - 'MOZ_NO_REMOTE': '1', 06:54:00 INFO - 'NO_EM_RESTART': '1', 06:54:00 INFO - 'PAGER': '/bin/cat', 06:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:00 INFO - 'PWD': '/builds/slave/test', 06:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:00 INFO - 'SHELL': '/bin/bash', 06:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:00 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:00 INFO - 'USER': 'cltbld', 06:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:00 INFO - 'XPC_FLAGS': '0x0', 06:54:00 INFO - 'XPC_SERVICE_NAME': '0', 06:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:54:01 INFO - Cleaning up... 06:54:01 INFO - Return code: 0 06:54:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:01 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:01 INFO - 'HOME': '/Users/cltbld', 06:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:01 INFO - 'LOGNAME': 'cltbld', 06:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:01 INFO - 'MOZ_NO_REMOTE': '1', 06:54:01 INFO - 'NO_EM_RESTART': '1', 06:54:01 INFO - 'PAGER': '/bin/cat', 06:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:01 INFO - 'PWD': '/builds/slave/test', 06:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:01 INFO - 'SHELL': '/bin/bash', 06:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:01 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:01 INFO - 'USER': 'cltbld', 06:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:01 INFO - 'XPC_FLAGS': '0x0', 06:54:01 INFO - 'XPC_SERVICE_NAME': '0', 06:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:05 INFO - Downloading docopt-0.6.1.tar.gz 06:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:05 INFO - Running setup.py install for blobuploader 06:54:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:05 INFO - Running setup.py install for requests 06:54:05 INFO - Running setup.py install for docopt 06:54:06 INFO - Successfully installed blobuploader requests docopt 06:54:06 INFO - Cleaning up... 06:54:06 INFO - Return code: 0 06:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:06 INFO - 'HOME': '/Users/cltbld', 06:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:06 INFO - 'LOGNAME': 'cltbld', 06:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:06 INFO - 'MOZ_NO_REMOTE': '1', 06:54:06 INFO - 'NO_EM_RESTART': '1', 06:54:06 INFO - 'PAGER': '/bin/cat', 06:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:06 INFO - 'PWD': '/builds/slave/test', 06:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:06 INFO - 'SHELL': '/bin/bash', 06:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:06 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:06 INFO - 'USER': 'cltbld', 06:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:06 INFO - 'XPC_FLAGS': '0x0', 06:54:06 INFO - 'XPC_SERVICE_NAME': '0', 06:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8dtejf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-9HGC9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-bDKUAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-LRD7tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DUez4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:06 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3Qy87U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-G7idbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Va2qBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-MoGFgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-U8TFXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-4huXhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0w_k_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-PDIGyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8E3T0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:07 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-G9xJus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:08 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-SmgX3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:08 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-wNDKId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:08 INFO - Running setup.py install for manifestparser 06:54:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:08 INFO - Running setup.py install for mozcrash 06:54:08 INFO - Running setup.py install for mozdebug 06:54:08 INFO - Running setup.py install for mozdevice 06:54:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:08 INFO - Running setup.py install for mozfile 06:54:08 INFO - Running setup.py install for mozhttpd 06:54:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Running setup.py install for mozinfo 06:54:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Running setup.py install for mozInstall 06:54:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Running setup.py install for mozleak 06:54:09 INFO - Running setup.py install for mozlog 06:54:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Running setup.py install for moznetwork 06:54:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:09 INFO - Running setup.py install for mozprocess 06:54:10 INFO - Running setup.py install for mozprofile 06:54:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:10 INFO - Running setup.py install for mozrunner 06:54:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:10 INFO - Running setup.py install for mozscreenshot 06:54:10 INFO - Running setup.py install for moztest 06:54:10 INFO - Running setup.py install for mozversion 06:54:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:10 INFO - Cleaning up... 06:54:10 INFO - Return code: 0 06:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:10 INFO - 'HOME': '/Users/cltbld', 06:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:10 INFO - 'LOGNAME': 'cltbld', 06:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:10 INFO - 'MOZ_NO_REMOTE': '1', 06:54:10 INFO - 'NO_EM_RESTART': '1', 06:54:10 INFO - 'PAGER': '/bin/cat', 06:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:10 INFO - 'PWD': '/builds/slave/test', 06:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:10 INFO - 'SHELL': '/bin/bash', 06:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:10 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:10 INFO - 'USER': 'cltbld', 06:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:10 INFO - 'XPC_FLAGS': '0x0', 06:54:10 INFO - 'XPC_SERVICE_NAME': '0', 06:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-1krma5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-gbuJa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3KbKay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-IGmDNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-bebh68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-32nPxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8YgFxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Wr40_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:11 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xogSVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-sVeDTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3PuMSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-RYv6fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8URlyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-g1wzDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BsfMcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DDsj16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:12 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NdgDhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 INFO - Downloading blessings-1.6.tar.gz 06:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:15 INFO - Installing collected packages: blessings 06:54:15 INFO - Running setup.py install for blessings 06:54:15 INFO - Successfully installed blessings 06:54:15 INFO - Cleaning up... 06:54:15 INFO - Return code: 0 06:54:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:16 INFO - Reading from file tmpfile_stdout 06:54:16 INFO - Current package versions: 06:54:16 INFO - blessings == 1.6 06:54:16 INFO - blobuploader == 1.2.4 06:54:16 INFO - docopt == 0.6.1 06:54:16 INFO - functools32 == 3.2.3-2 06:54:16 INFO - jsonschema == 2.5.1 06:54:16 INFO - manifestparser == 1.1 06:54:16 INFO - mozInstall == 1.12 06:54:16 INFO - mozcrash == 1.0 06:54:16 INFO - mozdebug == 0.1 06:54:16 INFO - mozdevice == 0.49 06:54:16 INFO - mozfile == 1.2 06:54:16 INFO - mozhttpd == 0.7 06:54:16 INFO - mozinfo == 0.9 06:54:16 INFO - mozleak == 0.1 06:54:16 INFO - mozlog == 3.4 06:54:16 INFO - moznetwork == 0.27 06:54:16 INFO - mozprocess == 0.24 06:54:16 INFO - mozprofile == 0.28 06:54:16 INFO - mozrunner == 6.13 06:54:16 INFO - mozscreenshot == 0.1 06:54:16 INFO - mozsystemmonitor == 0.3 06:54:16 INFO - moztest == 0.8 06:54:16 INFO - mozversion == 1.4 06:54:16 INFO - psutil == 3.1.1 06:54:16 INFO - requests == 1.2.3 06:54:16 INFO - wsgiref == 0.1.2 06:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:16 INFO - 'HOME': '/Users/cltbld', 06:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PAGER': '/bin/cat', 06:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test', 06:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:16 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - 'XPC_FLAGS': '0x0', 06:54:16 INFO - 'XPC_SERVICE_NAME': '0', 06:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:54:16 INFO - Cleaning up... 06:54:16 INFO - Return code: 0 06:54:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 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 0x106271b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106274768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b2c87100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, '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.xHuvQxY5dq/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.AEqkzfdME0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:16 INFO - 'HOME': '/Users/cltbld', 06:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PAGER': '/bin/cat', 06:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test', 06:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:16 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - 'XPC_FLAGS': '0x0', 06:54:16 INFO - 'XPC_SERVICE_NAME': '0', 06:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:54:16 INFO - Cleaning up... 06:54:16 INFO - Return code: 0 06:54:16 INFO - Running post-action listener: _resource_record_post_action 06:54:16 INFO - Running post-action listener: _start_resource_monitoring 06:54:16 INFO - Starting resource monitoring. 06:54:16 INFO - [mozharness: 2017-01-27 14:54:16.745910Z] Finished create-virtualenv step (success) 06:54:16 INFO - [mozharness: 2017-01-27 14:54:16.746992Z] Running install step. 06:54:16 INFO - Running pre-action listener: _resource_record_pre_action 06:54:16 INFO - Running main action method: install 06:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:17 INFO - Reading from file tmpfile_stdout 06:54:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:54:17 INFO - Reading from file tmpfile_stdout 06:54:17 INFO - Output received: 06:54:17 INFO - Usage: mozinstall [options] installer 06:54:17 INFO - Options: 06:54:17 INFO - -h, --help show this help message and exit 06:54:17 INFO - -d DEST, --destination=DEST 06:54:17 INFO - Directory to install application into. [default: 06:54:17 INFO - "/builds/slave/test"] 06:54:17 INFO - --app=APP Application being installed. [default: firefox] 06:54:17 INFO - mkdir: /builds/slave/test/build/application 06:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:54:36 INFO - Reading from file tmpfile_stdout 06:54:36 INFO - Output received: 06:54:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:54:36 INFO - Running post-action listener: _resource_record_post_action 06:54:36 INFO - [mozharness: 2017-01-27 14:54:36.948138Z] Finished install step (success) 06:54:36 INFO - [mozharness: 2017-01-27 14:54:36.948268Z] Running run-tests step. 06:54:36 INFO - Running pre-action listener: _resource_record_pre_action 06:54:36 INFO - Running main action method: run_tests 06:54:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:54:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:54:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:54:36 INFO - 2017-01-27 06:54:36.963 screenresolution[1893:14402] starting screenresolution argv=screenresolution get 06:54:36 INFO - 2017-01-27 06:54:36.966 screenresolution[1893:14402] Display 0: 1600x1200x32@60 06:54:36 INFO - 2017-01-27 06:54:36.971 screenresolution[1894:14405] starting screenresolution argv=screenresolution list 06:54:36 INFO - Available Modes on Display 0 06:54:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:54:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:54:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:54:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:54:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:54:37 INFO - Intel Iris: 06:54:37 INFO - Chipset Model: Intel Iris 06:54:37 INFO - Type: GPU 06:54:37 INFO - Bus: Built-In 06:54:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:54:37 INFO - Vendor: Intel (0x8086) 06:54:37 INFO - Device ID: 0x0a2e 06:54:37 INFO - Revision ID: 0x0009 06:54:37 INFO - Displays: 06:54:37 INFO - Display: 06:54:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:54:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:54:37 INFO - Display Serial Number: 1600x1200 60 06:54:37 INFO - Main Display: Yes 06:54:37 INFO - Mirror: Off 06:54:37 INFO - Online: Yes 06:54:37 INFO - Rotation: Supported 06:54:37 INFO - Return code: 0 06:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:54:37 INFO - Python 2.7.3 06:54:37 INFO - Return code: 0 06:54:37 INFO - grabbing minidump binary from tooltool 06:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:37 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 0x10604fd30>, '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 0x105f76db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106044be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:54:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:54:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:54:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:54:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:37 INFO - Return code: 0 06:54:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:54:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:54:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:54:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:54:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:54:37 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/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 06:54:37 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/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 06:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHuvQxY5dq/Render', 06:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:37 INFO - 'HOME': '/Users/cltbld', 06:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:37 INFO - 'LOGNAME': 'cltbld', 06:54:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:54:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:37 INFO - 'MOZ_NO_REMOTE': '1', 06:54:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:54:37 INFO - 'NO_EM_RESTART': '1', 06:54:37 INFO - 'PAGER': '/bin/cat', 06:54:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:37 INFO - 'PWD': '/builds/slave/test', 06:54:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:37 INFO - 'SHELL': '/bin/bash', 06:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AEqkzfdME0/Listeners', 06:54:37 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 06:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:37 INFO - 'USER': 'cltbld', 06:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:37 INFO - 'XPC_FLAGS': '0x0', 06:54:37 INFO - 'XPC_SERVICE_NAME': '0', 06:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:37 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/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 06:54:37 INFO - mozversion application_buildid: 20170127052320 06:54:37 INFO - mozversion application_changeset: bfd739f11ec69a228b01823577a6482a3ff9cc9a 06:54:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:54:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:37 INFO - mozversion application_name: Firefox 06:54:37 INFO - mozversion application_remotingname: firefox-dev 06:54:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:54:37 INFO - mozversion application_vendor: Mozilla 06:54:37 INFO - mozversion application_version: 53.0a2 06:54:37 INFO - mozversion platform_buildid: 20170127052320 06:54:37 INFO - mozversion platform_changeset: bfd739f11ec69a228b01823577a6482a3ff9cc9a 06:54:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:54:37 INFO - mozversion platform_version: 53.0a2 06:54:37 INFO - using testdate: 1485528877 06:54:37 INFO - actual date: 1485528877 06:54:37 INFO - starting webserver on 'localhost:52438' 06:54:37 INFO - SUITE-START | Running 2 tests 06:54:37 INFO - TEST-START | dromaeo_css 06:54:37 INFO - operating with platform_type : mac_ 06:54:37 INFO - Initialising browser for dromaeo_css test... 06:54:37 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpAiNx4t/profile http://localhost:52438/getInfo.html) 06:54:40 INFO - PROCESS | 1904 | 2017-01-27 06:54:40.357 plugin-container[1906:14575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c37, name = 'com.apple.tsm.portname' 06:54:40 INFO - PROCESS | 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:54:40 INFO - PROCESS | 1904 | 2017-01-27 06:54:40.360 plugin-container[1906:14575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 06:54:40 INFO - PROCESS | 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:54:40 INFO - PROCESS | 1904 | 2017-01-27 06:54:40.360 plugin-container[1906:14575] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:54:40 INFO - PROCESS | 1904 | __metrics Screen width/height:1600/1200 06:54:40 INFO - PROCESS | 1904 | colorDepth:24 06:54:40 INFO - PROCESS | 1904 | Browser inner width/height: 1024/689 06:54:40 INFO - PROCESS | 1904 | __metrics 06:54:40 ERROR - PROCESS | 1904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:54:41 INFO - TEST-INFO | 1904: exit 0 06:54:41 INFO - Browser initialized. 06:54:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:54:41 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpAiNx4t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:43 INFO - PROCESS | 1907 | 2017-01-27 06:54:43.918 plugin-container[1908:14701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 06:54:43 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:54:43 INFO - PROCESS | 1907 | 2017-01-27 06:54:43.918 plugin-container[1908:14701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:54:43 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:54:43 INFO - PROCESS | 1907 | 2017-01-27 06:54:43.918 plugin-container[1908:14701] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:54:53 INFO - PROCESS | 1907 | RSS: Main: 218398720 06:54:53 INFO - PROCESS | 1907 | 06:57:55 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52438/tests/dromaeo/cssquery-ext.html) 06:57:56 INFO - PROCESS | 1907 | RSS: Main: 236167168 06:57:56 INFO - PROCESS | 1907 | 06:59:41 INFO - PROCESS | 1907 | ************************* 06:59:41 INFO - PROCESS | 1907 | A coding exception was thrown and uncaught in a Task. 06:59:41 INFO - PROCESS | 1907 | 06:59:41 ERROR - PROCESS | 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:41 INFO - PROCESS | 1907 | Full stack: 06:59:41 INFO - PROCESS | 1907 | ************************* 07:00:59 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-ext.html (next: http://localhost:52438/tests/dromaeo/cssquery-jquery.html) 07:00:59 INFO - PROCESS | 1907 | RSS: Main: 243490816 07:00:59 INFO - PROCESS | 1907 | 07:04:01 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52438/tests/dromaeo/cssquery-mootools.html) 07:04:02 INFO - PROCESS | 1907 | RSS: Main: 253059072 07:04:02 INFO - PROCESS | 1907 | 07:07:04 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52438/tests/dromaeo/cssquery-prototype.html) 07:07:04 INFO - PROCESS | 1907 | RSS: Main: 250552320 07:07:04 INFO - PROCESS | 1907 | 07:10:07 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52438/tests/dromaeo/cssquery-yui.html) 07:10:08 INFO - PROCESS | 1907 | RSS: Main: 254603264 07:10:08 INFO - PROCESS | 1907 | 07:13:10 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-yui.html (next: http://localhost:52438/tests/dromaeo/cssquery-dojo.html) 07:13:11 INFO - PROCESS | 1907 | RSS: Main: 255930368 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | __start_tp_report 07:13:11 INFO - PROCESS | 1907 | _x_x_mozilla_page_load 07:13:11 INFO - PROCESS | 1907 | _x_x_mozilla_page_load_details 07:13:11 INFO - PROCESS | 1907 | |i|pagename|runs| 07:13:11 INFO - PROCESS | 1907 | |0;dojo.html;2588.6117082437645;2918.5913972043904;3356.546866173066;3384.949225761614;3387.7797943133687;5613.4386561343845;5643.746031428585;5680.375158732536;5732.0828667413225;5787.710614469281;5710.2862142232225;5741.909037282924;5776.566757493194;5780.5664575156825;5785.710714464281;5193;5194.896102077956;5225.921611175835;5276.208568714705;5296.126139187029;5216.139337009407;5264.289320941682;5300.496452836975;5304.416514183436;5360.785568577272;5050.7222102784335;5101.132807422747;5182.948170518303;5268.130758424855;5283.626257173143;4292.678049146295;5130;5192.8961420771375;5230.607704422146;5253.6322457428;3907.7459965102175;5149.639525233235;5164.2770012198325;5168.586513078944;5170.482951704837;5530.778768849241;5676.829695109153;5685.403032681592;5699.2306038684665;5713.800016999427;6118.345080237303;6153.200083989098;6176.7838125665385;6181.752729890799;6255.937440625581;4945.727984960826;5831.620944638585;6214.4407003369915;6240.095186197976;6251.093591429218;5198.376194856603;5874.73563689635;5882.411758824083;5910.468057874812;5912.935671579071;6148.9854174061675;6191.380861913773;6206.100115483229;6208.875822483525;6214.782482613087;4998.5751211146735;5409.594280428905;6139.2325959255095;6151.5386346024225;6186.628802271878;6119.663418512025;6241.407066328691;6289.937100628935;6295.779647712308;6302.243730752248;5045.722485263345;5153.330067091254;6110.358412366726;6131;6141.07883817422;6217.0052791554035;6218.471429928507;6227.377262273736;6240.937590624127;6265.310815810257;5022.397312322545;5025.221090730943;5025.723585202849;5061.746912654353;5063.898722025612;4448.998975230612;4481.215787237221;4485.170243504962;4548.7725613719185;4551.453825540956;5849.239598852122;5906.40935906406;5941.554383421174;5944.256967879015;5975.940240597625;6259.906101408483;6261.655608941461;6283.2460104787715;6286.18279623646;6296.370362963667;5587.245721827582;5764.510016648632;5769.163471296639;5843.386444423274;5858.94141058584;5549;5566.749496272678;5571.247881536022;5571.442855714477;5592.105263157875;6391.744330226832;6406.711697973602;6409.359064093554;6421.133147025092;6423.678816059179;6129.817282374624;6168.290646575701;6206.813795586139;6218.347073557392;6266.498680105489;4971.477994810492;5739.765950320701;6109.556177529024;6361.586496877688;6437.356264373525;5060.418051924076;6187.752489900354;6239.656818875005;6248.218972628421;6258.780942666985;4426.44669416323;6115.94015414234;6151.538634602333;6256;6274.968625156845;6062.575619706755;6118.082287656709;6136.243373036893;6139.4781443577795;6148.262208535004;6113.205283313141;6116.204893363834;6117.938820611737;6122.234720659918;6136.447719705069;5279.709615971158;5496.8731410060045;5938.495227905676;5997.100434934795;6003.0695242237525;5972.9701351494705;6115.113308570321;6119.167450728676;6144.15675297418;6197.225346831646;6031.155638210566;6078.014821020687;6095.2685677718955;6117.462039585462;6121.051237058263 07:13:11 INFO - PROCESS | 1907 | |1;ext.html;445.6657506869848;464.06259356100657;470.0387707138901;508.56517677385835;531.3544043986556;37910;40961.59038409623;41032;41107.383389249146;41146.7655970321;41688.791556042255;42332.36501452473;42335.36496952548;42418.57581424185;42533.36199957003;8502.234798868101;8744.956275218616;9277.443353398818;9488.430694158373;9516.381435206724;11226.550937962471;11552.768944621102;11566.421678916062;11718;11732.944035036844;11463.025642820328;11495.712607184803;11540;11548.191626586142;11550.249233799817;11324.263922845072;11474.827877581802;11524.711882202928;11535.596254131107;11543.653690389301;9458.527073646359;11412.600558980479;11472.94263528677;11477.540898364055;11489.942550287278;39382.606173938184;39519.40720889189;39719.8014009931;39903.201935961115;40055.19889602192;3981.7212795104356;4057.817398217058;4072.4705788247634;4128.896777580554;4229.196452674013;29075.56386654202;29565;30415.695843041507;30674.53988190179;30675.539866902014;3227.5158726191025;3288.5067239913965;3293.637699853014;3304.1409233599197;3360.092774950774;437180;439100;439254;439633;440541;60137;60378;60462;60611.787764244466;60679;58153.418465815645;58514.41485585175;58695.70652146712;58877;59330.40669593335;16433.589160271087;17012.234449449556;17022.063786491613;17045.31818727262;17049.31802727877;11871.525138994344;12149.392530373447;12829.679258018437;13076.346182690828;13228;15739.921300393426;15844.60388490297;15901.886867919135;15928.840711592737;15944.123073231083;7154.570725756367;7169.641517924083;7187.9281207188305;7215.170255420694;7252.419806415474;886.6497733395402;899.7525680437801;911.4030310146865;916.4776077635817;931.1107891963159;24922.626160607604;30054.603859738487;30263.848680756455;30452.781888724203;30826.69173308283;1033.8190816607064;1113.6826004588816;1120.2214460949563;1124.8875112488686;1156.9652910412701;15025.774613380809;15594.922025390028;15714.528564143095;15811.36754529829;16051.598710032342;517138;639397;642011;643766;645728;59792.40207597868;59919.70040149859;59978.40021599728;60128.39871601228;60197.699011504665;1440.0279811127448;1450.1444147952548;1464.743669857792;1467.8238611366705;1479.7706355514913;27859.145217143338;29942.80228790911;30177.698223017487;30212;30259.69740302657;49400.75299623479;49651.50348496469;49810;49841.750791247265;49864.75067624784;534361;543590;544423;544474;546123;33422.498662519596;34653.65346346605;38048.42927356037;39281;40426;46980.295295571275;46988.82527936829;47154;47614.76192619015;48418.757906210245;31327;38751.8374448767;39253.41119883261;39449;39492.60507395004;38015.04962375963;39289.607103928596;39409;40324.3951340736;40481.9879503003;37402.625973741;37990.620093799815;38023.42964855474;38055;38145;33578.83210583931;34144;34621.65378346285;35080.649193507736;35123.648763512036;20667.4833129173;25447.745522544537;25532.61701074448;25573.87213063997;25978.480430391664 07:13:11 INFO - PROCESS | 1907 | |2;jquery.html;392.27233481891074;393.6398195650979;402.24378169042194;403.6004355687869;421.6689898429733;20248.493787655298;20532.897335513302;21146.89426552869;21653.242136525223;21677.34967950962;11968.64094077177;12359;12367.62897113088;14300.284985750697;21572.460688482795;5425.511703946654;5469.179623056533;5539.972300138494;6079.908801367961;6206.162168107293;3989.820458079379;4182.97908510457;6066.6663333516635;6177.0734389841655;6179.443850053494;5918.4673379395845;6204.6587437690905;6222.128901953707;6251.843703907393;6274.278457977345;5903.616264942786;6190.442860142609;6231.906521402183;6236.407541283571;6246.094316324107;6156.907646385308;6161.4146656067605;6171.13604095427;6181.103739957681;6194.163787888622;13402.396892139877;13467.865321346759;13480;13651.38568764398;13711.588652340446;2603.960940585893;2631.736826317372;2683.8121331506804;2704.094128466966;2705.3853328611553;10165.644202452879;10179.491025448699;10281.742956426075;10600.204984626107;10686.305390149693;1843.8617103717274;1854.7681539807525;1876.1744832273755;1882.576420305434;1897.4402551247415;131338;132605;132731.6726832729;134889;136285.3185734065;10224.079832815083;10782.622608208674;10923.453827308604;11225.326480411039;11316.37759923212;13101.737965240833;13126;13164.868351316556;13192.406341714646;13201;6863.38229559342;8562.315014798802;8570.057293697688;8592.398532102692;8618.095100014534;8743;8839.29285657146;8846.11538846123;8969.955150224207;9024.548772561477;3512.3853325668415;4177.373393990925;4187.748735075906;4230.407742915994;4236.5128010278595;1374.0107122871516;2061.505238742721;2096.371088673392;2096.7798381170064;2103.6739305407687;971.9173870220969;1062.6493257225097;1066.6005208979288;1076.6931424543968;1080.2762149359949;20070.89964550168;21650.35048948534;21887.343379698315;21965.560688786136;22189.11243550272;1055.9524821383056;1058.9258751887448;1066.6053560182781;1091.5524634899652;1104.2932523185168;11372.658820235407;11441.37072461006;11587.768244635061;11598.710032249093;11613.6515904523;746941;750729;761612;764267;766150;151857;153063;156388.21805891124;158421.2078939598;159304;1012.5190534496055;1014.4420568687193;1034.1364960258118;1035.4305132177424;1038.9532471038822;18843.434696959113;19029.333973310866;19331.226750929804;19403.029848507802;19468.31860884862;48551.75724121498;58382.70808645929;59965.700171498866;61137.38862611317;61272.38727612667;84254;84399.5780021096;86937;88006.11993880235;88914.55542722245;8041.879371809545;8619.6983105591;8676.08901065379;8683.480390931436;8850.513221772864;9449.385789923634;13162;13274.601761947157;13282.86717132855;13581.660458488617;10344;10544.26190166681;10871.456427178768;11549.36478493691;11551.826722599335;10825.837612435662;10922.50848711794;11303.265287756269;11656.542114006663;11798;10035;10197.776266848026;11790.115741319263;11805.586804461802;11937.880621193677;8458.32333413313;8560.357973151915;8638.308935285288;8747.475151490931;8815.603297851483;8430.946131733534;10462.21533384984;11619.244749091282;11759.235649682743;11785.587504437304 07:13:11 INFO - PROCESS | 1907 | |3;mootools.html;1268.3341245845932;1344.1934839096543;1346.340293256304;1384.1764150330562;1447.8995963068064;7289.526180798258;7801.648925798346;7963.60181990901;8303.626336814843;8832.470051796896;8170;8406.369522285837;8484.618192181351;8588.184122508368;8610.095939926312;2295.942601434965;2336.100601268507;2338.5790557699606;2339.181286549711;2355.0226655937763;2106.115431518766;2188.157559339658;2332.54515369503;2370.7510711375317;2376.9049238030457;2268.4782500025003;2348.753380895007;2352.282553821084;2355.305184970438;2365.27859003004;2331.219041621059;2332.1720789119872;2351.2358483492762;2355.4817940053163;2359.304005318435;2341.7072865891764;2343.367290831466;2392.4736557957394;2421.2131057406236;2427.781499665021;8601.268892144175;8648.697295594624;8653.870191947126;8665.43674661145;8699.608517616722;5105.33630628016;5268.341457317835;5271.288376069258;5273.762680679379;5273.9736301318635;3289.1612638777196;3389.237421580149;3472.871316822018;3557.1640664443835;3595.5505561804775;1112.6884472347756;1191.6484637032097;1201.5974648492765;1248.219862585884;1281.3849352310942;11059.336439813556;11182.776344473146;11189.66431007063;11192;11205.663830085028;4052.675785937118;4684.672072954929;4725.9054818904115;4787.976060119747;4838.927416088762;8111.310538604167;8784.824303513893;8932.374733768575;8957.686480973134;8960;5166;5174.7153906535505;5177.844664660066;5179.352580927384;5189.610779191576;4723.645726570521;4777.4267087949665;4832.975835120802;4837.516248375135;4859.489753575895;3723.162288485069;3811.142492939122;3830;3857.479240302523;3926.5484469285825;1050.658535975811;1091.2688498705886;1121.4000509727257;1133.5069244878339;1139.8176291793272;802.0415603353936;869.387082107113;896.3008853094597;896.9820603587891;919.8298314811648;5810.1865738796605;5876.265466816648;5922.763089476459;6037.849053773603;6174.5060395168275;989.6433820072971;995.144176008632;1004.3070281505884;1014.6905193915926;1061.6443491430457;3244.967550324514;3501.9474707879403;3652.2330310635066;4057.9797101014306;4148.668106551469;10309.587616495257;10341;10486.423246721504;10486.685399438029;10487.842682359771;8807.647694092293;9211.447313161098;10082.546285417175;10305.175585953255;10358.741031474123;7019.4735394844565;7867.055953285528;8179.304759095425;8256.25693687583;8297.95851020753;5575.637583557056;5762.848887402889;5786.161006654096;5825.563082768894;5846.123081537803;9189.172974432333;9569.856452153363;9595.856062158933;9612.038796120332;9640.325177237526;9250.72247832566;9395.436273823592;9453.621855125994;9712.75718107053;9744.707658770249;7299.927000729925;7360.96319518399;7361.043064401593;7381.594012329373;7425.480216384801;7954.721584744506;7981.920180798118;8022.9598852005365;8033.35733141359;8043.396745244013;7100.9289907100265;7265.200827909031;7334.706611735684;7405.111386633638;7490.5880176588635;7123.180834204133;7162.820929476597;7172.211056783645;7194.89207661875;7316.341529262179;6497.642629655415;6580.5722628029025;6618.8345291368105;6620.040094186413;6629.635370054693;5051.8380772421815;5077.416097148875;5114.514121158484;5274.578033757213;5374.193870919394;5093.343146713382;5136.589072874086;5288.915772266753;5345.011172932865;5351.892962140813 07:13:11 INFO - PROCESS | 1907 | |4;prototype.html;330.2223264212779;371.53372517490544;371.7880807939474;372.59387267878043;377.5111230955912;4817.325574419579;5422.322209723785;5514.077538904377;5542.584306177043;5546.223528705985;4524.389207456992;5145.3568303962;5345.412004679482;5361.678299302044;5466.879289745602;3228.903132906011;4065.3292206785845;4129;4212.53662097169;4237.7669228192435;4203.096334288128;4203.516595591515;4205.705600607958;4224.070704445033;4276.914461710764;4227.281362168439;4228.243226370333;4235.555266696999;4254.468191476066;4270.444842170514;3435.5018522314376;4088.2028004539275;4137.97931010343;4209.726367786084;4237.194932962742;3110.891118810831;3232.208109013307;3727.1986522897437;3731.925361492782;3759.8872033838757;4820.493848145964;4995.500449955011;5207.583393328525;5264.552513036397;5279.973600132013;4744.742643199555;4915.787895447063;4940.382452193476;4948.628852836052;4980.87547811304;4821.373221481185;5423.806762512241;5538.723063846832;5737.741801618896;5762.654240745569;3968.583298753647;4112;4164.66682665386;4189.6438802701805;4204.810783514749;5205.817796377147;5310.62825602208;5424.31146820166;6067.18093057436;6114.724837382329;4037.394390841397;4184.748915065105;4195.370694395804;4224.76763777989;4254.510731265882;3665.6884164846288;3909.276783795007;3977.7414468059483;4312.288472402019;4317.697761156752;3853.2678791029616;4302.3546468030045;4675.976620116946;4899.6570240083565;4913.778879950411;5467.250479846491;5580.693061881636;5668.752874367632;5863;5863.003289440805;1159.4492616007328;1176.5117476247262;1267.797152455621;1298.7726598364643;1311.4819646239873;741.8516296740673;772.6252767407802;800.5390162952634;805.9476134051386;891.1667590802621;4451.488078870907;4769.070031343855;5120.694222973118;5345.679259244458;5378.623496355218;5434.809781657702;5982.231194347533;5985.371535988746;6018.3680713524445;6046.818595442144;5032.508908090519;5343.931213757264;5353.929214157184;5414.593905457106;5423.457654234545;2630.88161032754;2843.3033906692995;2946.848800375738;3001.3997200559975;3028.2732144285214;4923.581495572845;5896.793612223637;5911.733971971272;5928.762849486058;6005.789797357159;5443.374011988592;5504.559635229172;5697.03150464422;5738.713064346766;5883.529317654577;5070.569001634829;5315.760790764425;5859.384764599656;5870.530357571384;5977.834322307195;5356.380394293184;5391.514763671288;5432.891342173055;5556.722163891708;5774.39368866263;5255.9211611825085;5582;5607.635503692247;5702.344230413555;5744.4829965303325;4859.684120532154;5003.974185292079;5151.639385242997;5336.838580374954;5914.911276330772;3392.4556582563077;3657.1588534637713;3696.9815150924073;3754.1740817020213;3782.9432558512194;5171.844844654666;5326.893462130658;5689.6586204827845;5719.8856022880145;5744.133156723998;4697.8355757548325;5240.71176085319;5293.7353132344;5434;5568.916466252928;4552.840650577346;4705.647076469347;5501.642393244426;5525.475079867406;5550.55595552363;5044.041632089891;5211.661242019257;5244.632875698817;5252.395974462986;5259.4477579853565;4630.004549021976;4687.32033855096;5345.438728933406;5450.8909821802545;5502.5597952164535;5173.715445650525;5543.223948647274;5567.721613919369;5568.972155139199;5589.832305030855 07:13:11 INFO - PROCESS | 1907 | |5;yui.html;678.8744082344764;737.9335859772626;778.2645400096907;819.442778910341;819.8606236939721;14774.113553186817;15180.772288415656;15504.224788760544;15749.84250157498;15772.526824195278;14340.641483962907;14518;14530.418783248684;14531.709365812678;14538.836893048558;687.9140107486564;705.6648092156236;858.8110615664543;873.1661263493364;889.4440974391006;850.4897061762923;881.418263945796;884.8009197930446;890.7505898348472;891.0999890111002;947.5025611553921;948.8908775490803;949.2832911152105;951.0346997797242;953.3088510829627;845.7905195570332;876.4171825735909;936.5972631768337;942.9245660347156;944.9433034017981;694.9957311684618;708.0901042160799;708.2032713197652;709.7444919828857;710.4245561095529;14805.629859253497;15149;15237.314320855588;15557.29992150356;15791.447299344467;14343.856561434357;14520.782188267185;14663.63340916475;14845.777313340308;14903.180325082116;11647.242929209575;11873.52505899763;11903.702407439883;11950.103742219368;12154.635360939186;3713.554373475173;3765.7928813915496;3793.506844110276;3822.140018495844;3829.1193025604266;65007;98439;102536;102542.48728756382;103202.48398758033;10022.398656080659;10417.635382761568;10553.788924221626;10791.406472643923;11018.228723989405;21519;21563.568728625338;21994.670079948814;22016.669749953442;22156.446088847584;7534.660940257701;7632.542047477169;7657.770266891891;7662.195469475736;7807.765767026998;4117.1765646870745;4356.869293921188;4363.934540981888;4426.933595996063;4438.312061630452;3498.177928186874;3590.8563657453933;3591.8865151803025;3594.0655429587973;3630.8729194478065;649.3798422506495;659.6339031837281;671.2549070531705;672.9192496900305;680.4794332335767;546.9316335458068;608.3916083916084;618.703022549179;625.8529245627274;644.7098805537433;9317.673881414117;9462;9667.226621870233;10044.899551004542;10087.798244035079;607.4138456389605;668.7759600533778;678.0507289794228;682.3142741544716;690.7996680962565;4744.786484608201;4848.539388758062;4861.1979023460735;4861.246506791453;4875;108415.37376939353;108442;108514.45742771236;108879.91120088856;109412;85429.14570854336;92557;96112;97857;98264.52603210957;65842.67078664672;69007.65496172487;69055.65472172707;70494.64752676306;70617;9301.395409298373;9412.57643406062;9438.575264112995;9495.952520237355;9498.430094194371;54881.45118548763;55126.17310740262;55252.06617768359;55477.44522554723;55672;54961.450385495635;70021.29978700148;72400.63799681178;73566;74139;10757.085647720032;11013.504392302526;11032.724181895195;11119.666410007712;11431.942840285745;11867.643970680894;11994.880051199376;12016.098792590416;12106.576269830513;12450.630430652802;10595;11695.12286578493;11815.822762658396;11972.700682482659;12096.939515302367;11714.531418743154;11778;11851;11879.940600296943;11948.641540753792;11045.779084418105;11199.776004480027;11436.82844757346;11463.426828658701;11953.641390758292;8390.496570205563;8420.326373890197;8659.523726194868;9252.861207081765;10218.948905255425;7834.80412989657;8466.830663386821;9376.671816486663;9409.106134917172;9438.764030899283 07:13:11 INFO - PROCESS | 1907 | __end_tp_report 07:13:11 INFO - PROCESS | 1907 | __start_cc_report 07:13:11 INFO - PROCESS | 1907 | _x_x_mozilla_cycle_collect,378 07:13:11 INFO - PROCESS | 1907 | __end_cc_report 07:13:11 INFO - PROCESS | 1907 | __startTimestamp1485529991005__endTimestamp 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | ------- Summary: start ------- 07:13:11 INFO - PROCESS | 1907 | Number of tests: 6 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#0] dojo.html Cycles:165 Average:5682.24 Median:5910.47 stddev:693.75 (11.7%) stddev-sans-first:652.05 07:13:11 INFO - PROCESS | 1907 | Values: 2588.6 2918.6 3356.5 3384.9 3387.8 5613.4 5643.7 5680.4 5732.1 5787.7 5710.3 5741.9 5776.6 5780.6 5785.7 5193.0 5194.9 5225.9 5276.2 5296.1 5216.1 5264.3 5300.5 5304.4 5360.8 5050.7 5101.1 5182.9 5268.1 5283.6 4292.7 5130.0 5192.9 5230.6 5253.6 3907.7 5149.6 5164.3 5168.6 5170.5 5530.8 5676.8 5685.4 5699.2 5713.8 6118.3 6153.2 6176.8 6181.8 6255.9 4945.7 5831.6 6214.4 6240.1 6251.1 5198.4 5874.7 5882.4 5910.5 5912.9 6149.0 6191.4 6206.1 6208.9 6214.8 4998.6 5409.6 6139.2 6151.5 6186.6 6119.7 6241.4 6289.9 6295.8 6302.2 5045.7 5153.3 6110.4 6131.0 6141.1 6217.0 6218.5 6227.4 6240.9 6265.3 5022.4 5025.2 5025.7 5061.7 5063.9 4449.0 4481.2 4485.2 4548.8 4551.5 5849.2 5906.4 5941.6 5944.3 5975.9 6259.9 6261.7 6283.2 6286.2 6296.4 5587.2 5764.5 5769.2 5843.4 5858.9 5549.0 5566.7 5571.2 5571.4 5592.1 6391.7 6406.7 6409.4 6421.1 6423.7 6129.8 6168.3 6206.8 6218.3 6266.5 4971.5 5739.8 6109.6 6361.6 6437.4 5060.4 6187.8 6239.7 6248.2 6258.8 4426.4 6115.9 6151.5 6256.0 6275.0 6062.6 6118.1 6136.2 6139.5 6148.3 6113.2 6116.2 6117.9 6122.2 6136.4 5279.7 5496.9 5938.5 5997.1 6003.1 5973.0 6115.1 6119.2 6144.2 6197.2 6031.2 6078.0 6095.3 6117.5 6121.1 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#1] ext.html Cycles:180 Average:67579.83 Median:39002.62 stddev:143689.55 (368.4%) stddev-sans-first:144004.23 07:13:11 INFO - PROCESS | 1907 | Values: 445.7 464.1 470.0 508.6 531.4 37910.0 40961.6 41032.0 41107.4 41146.8 41688.8 42332.4 42335.4 42418.6 42533.4 8502.2 8745.0 9277.4 9488.4 9516.4 11226.6 11552.8 11566.4 11718.0 11732.9 11463.0 11495.7 11540.0 11548.2 11550.2 11324.3 11474.8 11524.7 11535.6 11543.7 9458.5 11412.6 11472.9 11477.5 11489.9 39382.6 39519.4 39719.8 39903.2 40055.2 3981.7 4057.8 4072.5 4128.9 4229.2 29075.6 29565.0 30415.7 30674.5 30675.5 3227.5 3288.5 3293.6 3304.1 3360.1 437180.0 439100.0 439254.0 439633.0 440541.0 60137.0 60378.0 60462.0 60611.8 60679.0 58153.4 58514.4 58695.7 58877.0 59330.4 16433.6 17012.2 17022.1 17045.3 17049.3 11871.5 12149.4 12829.7 13076.3 13228.0 15739.9 15844.6 15901.9 15928.8 15944.1 7154.6 7169.6 7187.9 7215.2 7252.4 886.6 899.8 911.4 916.5 931.1 24922.6 30054.6 30263.8 30452.8 30826.7 1033.8 1113.7 1120.2 1124.9 1157.0 15025.8 15594.9 15714.5 15811.4 16051.6 517138.0 639397.0 642011.0 643766.0 645728.0 59792.4 59919.7 59978.4 60128.4 60197.7 1440.0 1450.1 1464.7 1467.8 1479.8 27859.1 29942.8 30177.7 30212.0 30259.7 49400.8 49651.5 49810.0 49841.8 49864.8 534361.0 543590.0 544423.0 544474.0 546123.0 33422.5 34653.7 38048.4 39281.0 40426.0 46980.3 46988.8 47154.0 47614.8 48418.8 31327.0 38751.8 39253.4 39449.0 39492.6 38015.0 39289.6 39409.0 40324.4 40482.0 37402.6 37990.6 38023.4 38055.0 38145.0 33578.8 34144.0 34621.7 35080.6 35123.6 20667.5 25447.7 25532.6 25573.9 25978.5 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#2] jquery.html Cycles:180 Average:40620.19 Median:2078.94 stddev:126346.75 (6077.5%) stddev-sans-first:126665.08 07:13:11 INFO - PROCESS | 1907 | Values: 392.3 393.6 402.2 403.6 421.7 20248.5 20532.9 21146.9 21653.2 21677.3 11968.6 12359.0 12367.6 14300.3 21572.5 5425.5 5469.2 5540.0 6079.9 6206.2 3989.8 4183.0 6066.7 6177.1 6179.4 5918.5 6204.7 6222.1 6251.8 6274.3 5903.6 6190.4 6231.9 6236.4 6246.1 6156.9 6161.4 6171.1 6181.1 6194.2 13402.4 13467.9 13480.0 13651.4 13711.6 2604.0 2631.7 2683.8 2704.1 2705.4 10165.6 10179.5 10281.7 10600.2 10686.3 1843.9 1854.8 1876.2 1882.6 1897.4 131338.0 132605.0 132731.7 134889.0 136285.3 10224.1 10782.6 10923.5 11225.3 11316.4 13101.7 13126.0 13164.9 13192.4 13201.0 6863.4 8562.3 8570.1 8592.4 8618.1 8743.0 8839.3 8846.1 8970.0 9024.5 3512.4 4177.4 4187.7 4230.4 4236.5 1374.0 2061.5 2096.4 2096.8 2103.7 971.9 1062.6 1066.6 1076.7 1080.3 20070.9 21650.4 21887.3 21965.6 22189.1 1056.0 1058.9 1066.6 1091.6 1104.3 11372.7 11441.4 11587.8 11598.7 11613.7 746941.0 750729.0 761612.0 764267.0 766150.0 151857.0 153063.0 156388.2 158421.2 159304.0 1012.5 1014.4 1034.1 1035.4 1039.0 18843.4 19029.3 19331.2 19403.0 19468.3 48551.8 58382.7 59965.7 61137.4 61272.4 84254.0 84399.6 86937.0 88006.1 88914.6 8041.9 8619.7 8676.1 8683.5 8850.5 9449.4 13162.0 13274.6 13282.9 13581.7 10344.0 10544.3 10871.5 11549.4 11551.8 10825.8 10922.5 11303.3 11656.5 11798.0 10035.0 10197.8 11790.1 11805.6 11937.9 8458.3 8560.4 8638.3 8747.5 8815.6 8430.9 10462.2 11619.2 11759.2 11785.6 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#3] mootools.html Cycles:180 Average:5525.10 Median:5184.48 stddev:3013.97 (58.1%) stddev-sans-first:3005.44 07:13:11 INFO - PROCESS | 1907 | Values: 1268.3 1344.2 1346.3 1384.2 1447.9 7289.5 7801.6 7963.6 8303.6 8832.5 8170.0 8406.4 8484.6 8588.2 8610.1 2295.9 2336.1 2338.6 2339.2 2355.0 2106.1 2188.2 2332.5 2370.8 2376.9 2268.5 2348.8 2352.3 2355.3 2365.3 2331.2 2332.2 2351.2 2355.5 2359.3 2341.7 2343.4 2392.5 2421.2 2427.8 8601.3 8648.7 8653.9 8665.4 8699.6 5105.3 5268.3 5271.3 5273.8 5274.0 3289.2 3389.2 3472.9 3557.2 3595.6 1112.7 1191.6 1201.6 1248.2 1281.4 11059.3 11182.8 11189.7 11192.0 11205.7 4052.7 4684.7 4725.9 4788.0 4838.9 8111.3 8784.8 8932.4 8957.7 8960.0 5166.0 5174.7 5177.8 5179.4 5189.6 4723.6 4777.4 4833.0 4837.5 4859.5 3723.2 3811.1 3830.0 3857.5 3926.5 1050.7 1091.3 1121.4 1133.5 1139.8 802.0 869.4 896.3 897.0 919.8 5810.2 5876.3 5922.8 6037.8 6174.5 989.6 995.1 1004.3 1014.7 1061.6 3245.0 3501.9 3652.2 4058.0 4148.7 10309.6 10341.0 10486.4 10486.7 10487.8 8807.6 9211.4 10082.5 10305.2 10358.7 7019.5 7867.1 8179.3 8256.3 8298.0 5575.6 5762.8 5786.2 5825.6 5846.1 9189.2 9569.9 9595.9 9612.0 9640.3 9250.7 9395.4 9453.6 9712.8 9744.7 7299.9 7361.0 7361.0 7381.6 7425.5 7954.7 7981.9 8023.0 8033.4 8043.4 7100.9 7265.2 7334.7 7405.1 7490.6 7123.2 7162.8 7172.2 7194.9 7316.3 6497.6 6580.6 6618.8 6620.0 6629.6 5051.8 5077.4 5114.5 5274.6 5374.2 5093.3 5136.6 5288.9 5345.0 5351.9 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#4] prototype.html Cycles:180 Average:4568.07 Median:5161.74 stddev:1377.27 (26.7%) stddev-sans-first:1343.90 07:13:11 INFO - PROCESS | 1907 | Values: 330.2 371.5 371.8 372.6 377.5 4817.3 5422.3 5514.1 5542.6 5546.2 4524.4 5145.4 5345.4 5361.7 5466.9 3228.9 4065.3 4129.0 4212.5 4237.8 4203.1 4203.5 4205.7 4224.1 4276.9 4227.3 4228.2 4235.6 4254.5 4270.4 3435.5 4088.2 4138.0 4209.7 4237.2 3110.9 3232.2 3727.2 3731.9 3759.9 4820.5 4995.5 5207.6 5264.6 5280.0 4744.7 4915.8 4940.4 4948.6 4980.9 4821.4 5423.8 5538.7 5737.7 5762.7 3968.6 4112.0 4164.7 4189.6 4204.8 5205.8 5310.6 5424.3 6067.2 6114.7 4037.4 4184.7 4195.4 4224.8 4254.5 3665.7 3909.3 3977.7 4312.3 4317.7 3853.3 4302.4 4676.0 4899.7 4913.8 5467.3 5580.7 5668.8 5863.0 5863.0 1159.4 1176.5 1267.8 1298.8 1311.5 741.9 772.6 800.5 805.9 891.2 4451.5 4769.1 5120.7 5345.7 5378.6 5434.8 5982.2 5985.4 6018.4 6046.8 5032.5 5343.9 5353.9 5414.6 5423.5 2630.9 2843.3 2946.8 3001.4 3028.3 4923.6 5896.8 5911.7 5928.8 6005.8 5443.4 5504.6 5697.0 5738.7 5883.5 5070.6 5315.8 5859.4 5870.5 5977.8 5356.4 5391.5 5432.9 5556.7 5774.4 5255.9 5582.0 5607.6 5702.3 5744.5 4859.7 5004.0 5151.6 5336.8 5914.9 3392.5 3657.2 3697.0 3754.2 3782.9 5171.8 5326.9 5689.7 5719.9 5744.1 4697.8 5240.7 5293.7 5434.0 5568.9 4552.8 4705.6 5501.6 5525.5 5550.6 5044.0 5211.7 5244.6 5252.4 5259.4 4630.0 4687.3 5345.4 5450.9 5502.6 5173.7 5543.2 5567.7 5569.0 5589.8 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - PROCESS | 1907 | [#5] yui.html Cycles:180 Average:20023.34 Median:2710.97 stddev:29327.24 (1081.8%) stddev-sans-first:29373.54 07:13:11 INFO - PROCESS | 1907 | Values: 678.9 737.9 778.3 819.4 819.9 14774.1 15180.8 15504.2 15749.8 15772.5 14340.6 14518.0 14530.4 14531.7 14538.8 687.9 705.7 858.8 873.2 889.4 850.5 881.4 884.8 890.8 891.1 947.5 948.9 949.3 951.0 953.3 845.8 876.4 936.6 942.9 944.9 695.0 708.1 708.2 709.7 710.4 14805.6 15149.0 15237.3 15557.3 15791.4 14343.9 14520.8 14663.6 14845.8 14903.2 11647.2 11873.5 11903.7 11950.1 12154.6 3713.6 3765.8 3793.5 3822.1 3829.1 65007.0 98439.0 102536.0 102542.5 103202.5 10022.4 10417.6 10553.8 10791.4 11018.2 21519.0 21563.6 21994.7 22016.7 22156.4 7534.7 7632.5 7657.8 7662.2 7807.8 4117.2 4356.9 4363.9 4426.9 4438.3 3498.2 3590.9 3591.9 3594.1 3630.9 649.4 659.6 671.3 672.9 680.5 546.9 608.4 618.7 625.9 644.7 9317.7 9462.0 9667.2 10044.9 10087.8 607.4 668.8 678.1 682.3 690.8 4744.8 4848.5 4861.2 4861.2 4875.0 108415.4 108442.0 108514.5 108879.9 109412.0 85429.1 92557.0 96112.0 97857.0 98264.5 65842.7 69007.7 69055.7 70494.6 70617.0 9301.4 9412.6 9438.6 9496.0 9498.4 54881.5 55126.2 55252.1 55477.4 55672.0 54961.5 70021.3 72400.6 73566.0 74139.0 10757.1 11013.5 11032.7 11119.7 11431.9 11867.6 11994.9 12016.1 12106.6 12450.6 10595.0 11695.1 11815.8 11972.7 12096.9 11714.5 11778.0 11851.0 11879.9 11948.6 11045.8 11199.8 11436.8 11463.4 11953.6 8390.5 8420.3 8659.5 9252.9 10218.9 7834.8 8466.8 9376.7 9409.1 9438.8 07:13:11 INFO - PROCESS | 1907 | -------- Summary: end -------- 07:13:11 INFO - PROCESS | 1907 | 07:13:11 INFO - TEST-INFO | 1907: exit 0 07:13:11 INFO - TEST-OK | dromaeo_css | took 1114114ms 07:13:11 INFO - TEST-START | kraken 07:13:11 INFO - operating with platform_type : mac_ 07:13:11 INFO - Initialising browser for kraken test... 07:13:11 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpMn893u/profile http://localhost:52438/getInfo.html) 07:13:14 INFO - PROCESS | 1914 | 2017-01-27 07:13:14.339 plugin-container[1915:16718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 07:13:14 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:13:14 INFO - PROCESS | 1914 | 2017-01-27 07:13:14.342 plugin-container[1915:16718] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 07:13:14 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:13:14 INFO - PROCESS | 1914 | 2017-01-27 07:13:14.342 plugin-container[1915:16718] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:13:14 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 07:13:14 INFO - PROCESS | 1914 | colorDepth:24 07:13:14 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 07:13:14 INFO - PROCESS | 1914 | __metrics 07:13:14 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 07:13:15 INFO - TEST-INFO | 1914: exit 0 07:13:15 INFO - Browser initialized. 07:13:15 INFO - Running cycle 1/1 for kraken test... 07:13:15 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpMn893u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:17 INFO - PROCESS | 1916 | 2017-01-27 07:13:17.958 plugin-container[1917:16838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 07:13:17 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:13:17 INFO - PROCESS | 1916 | 2017-01-27 07:13:17.959 plugin-container[1917:16838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:13:17 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:13:17 INFO - PROCESS | 1916 | 2017-01-27 07:13:17.959 plugin-container[1917:16838] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:13:27 INFO - PROCESS | 1916 | RSS: Main: 218669056 07:13:27 INFO - PROCESS | 1916 | 07:13:30 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:31 INFO - PROCESS | 1916 | RSS: Main: 232894464 07:13:31 INFO - PROCESS | 1916 | 07:13:33 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-dft) 07:13:34 INFO - PROCESS | 1916 | RSS: Main: 241762304 07:13:34 INFO - PROCESS | 1916 | 07:13:37 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-fft) 07:13:38 INFO - PROCESS | 1916 | RSS: Main: 242745344 07:13:38 INFO - PROCESS | 1916 | 07:13:40 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-oscillator) 07:13:41 INFO - PROCESS | 1916 | RSS: Main: 244228096 07:13:41 INFO - PROCESS | 1916 | 07:13:43 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:43 INFO - PROCESS | 1916 | RSS: Main: 245903360 07:13:43 INFO - PROCESS | 1916 | 07:13:46 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:47 INFO - PROCESS | 1916 | RSS: Main: 249921536 07:13:47 INFO - PROCESS | 1916 | 07:13:50 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:51 INFO - PROCESS | 1916 | RSS: Main: 249233408 07:13:51 INFO - PROCESS | 1916 | 07:13:54 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52438/tests/kraken/driver.html?testName=json-parse-financial) 07:13:54 INFO - PROCESS | 1916 | RSS: Main: 249614336 07:13:54 INFO - PROCESS | 1916 | 07:13:56 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:13:56 INFO - PROCESS | 1916 | RSS: Main: 248381440 07:13:56 INFO - PROCESS | 1916 | 07:13:58 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:59 INFO - PROCESS | 1916 | RSS: Main: 248401920 07:13:59 INFO - PROCESS | 1916 | 07:14:01 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:02 INFO - PROCESS | 1916 | RSS: Main: 248373248 07:14:02 INFO - PROCESS | 1916 | 07:14:05 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:06 INFO - PROCESS | 1916 | RSS: Main: 248795136 07:14:06 INFO - PROCESS | 1916 | 07:14:09 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:09 INFO - PROCESS | 1916 | RSS: Main: 249274368 07:14:09 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52438/tests/kraken/driver.html?testName=ai-astar) 07:14:11 INFO - PROCESS | 1916 | RSS: Main: 250449920 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | __start_tp_report 07:14:11 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 07:14:11 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 07:14:11 INFO - PROCESS | 1916 | |i|pagename|runs| 07:14:11 INFO - PROCESS | 1916 | |0;ai-astar;114;119;113;113;115;172;167;115;117;133 07:14:11 INFO - PROCESS | 1916 | |1;audio-beat-detection;144;112;112;144;113;113;112;110;128;114 07:14:11 INFO - PROCESS | 1916 | |2;audio-dft;267;255;200;195;195;198;245;259;197;198 07:14:11 INFO - PROCESS | 1916 | |3;audio-fft;99;85;50;74;53;64;87;84;95;81 07:14:11 INFO - PROCESS | 1916 | |4;audio-oscillator;87;70;85;103;102;86;82;71;71;81 07:14:11 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;90;86;89;89;90;102;137;116;89;89 07:14:11 INFO - PROCESS | 1916 | |6;imaging-darkroom;96;99;121;154;94;95;95;95;95;115 07:14:11 INFO - PROCESS | 1916 | |7;imaging-desaturate;111;95;142;147;91;91;94;92;93;94 07:14:11 INFO - PROCESS | 1916 | |8;json-parse-financial;57;58;57;60;59;61;61;60;61;60 07:14:11 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;71;73;73;76;70;70;69;69;71;72 07:14:11 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;85;82;84;84;87;84;85;89;86;105 07:14:11 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;159;143;146;151;154;148;163;178;209;152 07:14:11 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;167;171;172;150;205;237;166;159;191;237 07:14:11 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;66;65;79;68;64;72;88;65;62;85 07:14:11 INFO - PROCESS | 1916 | __end_tp_report 07:14:11 INFO - PROCESS | 1916 | __start_cc_report 07:14:11 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,953 07:14:11 INFO - PROCESS | 1916 | __end_cc_report 07:14:11 INFO - PROCESS | 1916 | __startTimestamp1485530051868__endTimestamp 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | ------- Summary: start ------- 07:14:11 INFO - PROCESS | 1916 | Number of tests: 14 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:127.80 Median:118.00 stddev:22.77 (19.3%) stddev-sans-first:23.60 07:14:11 INFO - PROCESS | 1916 | Values: 114.0 119.0 113.0 113.0 115.0 172.0 167.0 115.0 117.0 133.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:113.50 stddev:13.51 (11.9%) stddev-sans-first:11.25 07:14:11 INFO - PROCESS | 1916 | Values: 144.0 112.0 112.0 144.0 113.0 113.0 112.0 110.0 128.0 114.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:220.90 Median:222.50 stddev:31.13 (14.0%) stddev-sans-first:28.19 07:14:11 INFO - PROCESS | 1916 | Values: 267.0 255.0 200.0 195.0 195.0 198.0 245.0 259.0 197.0 198.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:77.20 Median:84.50 stddev:16.73 (19.8%) stddev-sans-first:15.78 07:14:11 INFO - PROCESS | 1916 | Values: 99.0 85.0 50.0 74.0 53.0 64.0 87.0 84.0 95.0 81.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:81.50 stddev:11.76 (14.4%) stddev-sans-first:12.42 07:14:11 INFO - PROCESS | 1916 | Values: 87.0 70.0 85.0 103.0 102.0 86.0 82.0 71.0 71.0 81.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:89.00 stddev:16.52 (18.6%) stddev-sans-first:17.29 07:14:11 INFO - PROCESS | 1916 | Values: 90.0 86.0 89.0 89.0 90.0 102.0 137.0 116.0 89.0 89.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:95.00 stddev:19.40 (20.4%) stddev-sans-first:20.24 07:14:11 INFO - PROCESS | 1916 | Values: 96.0 99.0 121.0 154.0 94.0 95.0 95.0 95.0 95.0 115.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:105.00 Median:92.50 stddev:21.64 (23.4%) stddev-sans-first:22.85 07:14:11 INFO - PROCESS | 1916 | Values: 111.0 95.0 142.0 147.0 91.0 91.0 94.0 92.0 93.0 94.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:1.58 (2.6%) stddev-sans-first:1.41 07:14:11 INFO - PROCESS | 1916 | Values: 57.0 58.0 57.0 60.0 59.0 61.0 61.0 60.0 61.0 60.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:2.17 (3.0%) stddev-sans-first:2.30 07:14:11 INFO - PROCESS | 1916 | Values: 71.0 73.0 73.0 76.0 70.0 70.0 69.0 69.0 71.0 72.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:6.57 (7.7%) stddev-sans-first:6.93 07:14:11 INFO - PROCESS | 1916 | Values: 85.0 82.0 84.0 84.0 87.0 84.0 85.0 89.0 86.0 105.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:160.30 Median:156.50 stddev:19.84 (12.7%) stddev-sans-first:21.04 07:14:11 INFO - PROCESS | 1916 | Values: 159.0 143.0 146.0 151.0 154.0 148.0 163.0 178.0 209.0 152.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:181.50 stddev:31.26 (17.2%) stddev-sans-first:32.43 07:14:11 INFO - PROCESS | 1916 | Values: 167.0 171.0 172.0 150.0 205.0 237.0 166.0 159.0 191.0 237.0 07:14:11 INFO - PROCESS | 1916 | 07:14:11 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.00 stddev:9.34 (13.3%) stddev-sans-first:9.70 07:14:11 INFO - PROCESS | 1916 | Values: 66.0 65.0 79.0 68.0 64.0 72.0 88.0 65.0 62.0 85.0 07:14:11 INFO - PROCESS | 1916 | -------- Summary: end -------- 07:14:11 INFO - PROCESS | 1916 | 07:14:12 INFO - TEST-INFO | 1916: exit 0 07:14:12 INFO - TEST-OK | kraken | took 61103ms 07:14:12 INFO - SUITE-END | took 1175s 07:14:13 INFO - Completed test suite (00:19:35) 07:14:13 INFO - javascript benchmark 07:14:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7285.658542224986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.6117082437645, 2918.5913972043904, 3356.546866173066, 3384.949225761614, 3387.7797943133687, 5613.4386561343845, 5643.746031428585, 5680.375158732536, 5732.0828667413225, 5787.710614469281, 5710.2862142232225, 5741.909037282924, 5776.566757493194, 5780.5664575156825, 5785.710714464281, 5193.0, 5194.896102077956, 5225.921611175835, 5276.208568714705, 5296.126139187029, 5216.139337009407, 5264.289320941682, 5300.496452836975, 5304.416514183436, 5360.785568577272, 5050.7222102784335, 5101.132807422747, 5182.948170518303, 5268.130758424855, 5283.626257173143, 4292.678049146295, 5130.0, 5192.8961420771375, 5230.607704422146, 5253.6322457428, 3907.7459965102175, 5149.639525233235, 5164.2770012198325, 5168.586513078944, 5170.482951704837, 5530.778768849241, 5676.829695109153, 5685.403032681592, 5699.2306038684665, 5713.800016999427, 6118.345080237303, 6153.200083989098, 6176.7838125665385, 6181.752729890799, 6255.937440625581, 4945.727984960826, 5831.620944638585, 6214.4407003369915, 6240.095186197976, 6251.093591429218, 5198.376194856603, 5874.73563689635, 5882.411758824083, 5910.468057874812, 5912.935671579071, 6148.9854174061675, 6191.380861913773, 6206.100115483229, 6208.875822483525, 6214.782482613087, 4998.5751211146735, 5409.594280428905, 6139.2325959255095, 6151.5386346024225, 6186.628802271878, 6119.663418512025, 6241.407066328691, 6289.937100628935, 6295.779647712308, 6302.243730752248, 5045.722485263345, 5153.330067091254, 6110.358412366726, 6131.0, 6141.07883817422, 6217.0052791554035, 6218.471429928507, 6227.377262273736, 6240.937590624127, 6265.310815810257, 5022.397312322545, 5025.221090730943, 5025.723585202849, 5061.746912654353, 5063.898722025612, 4448.998975230612, 4481.215787237221, 4485.170243504962, 4548.7725613719185, 4551.453825540956, 5849.239598852122, 5906.40935906406, 5941.554383421174, 5944.256967879015, 5975.940240597625, 6259.906101408483, 6261.655608941461, 6283.2460104787715, 6286.18279623646, 6296.370362963667, 5587.245721827582, 5764.510016648632, 5769.163471296639, 5843.386444423274, 5858.94141058584, 5549.0, 5566.749496272678, 5571.247881536022, 5571.442855714477, 5592.105263157875, 6391.744330226832, 6406.711697973602, 6409.359064093554, 6421.133147025092, 6423.678816059179, 6129.817282374624, 6168.290646575701, 6206.813795586139, 6218.347073557392, 6266.498680105489, 4971.477994810492, 5739.765950320701, 6109.556177529024, 6361.586496877688, 6437.356264373525, 5060.418051924076, 6187.752489900354, 6239.656818875005, 6248.218972628421, 6258.780942666985, 4426.44669416323, 6115.94015414234, 6151.538634602333, 6256.0, 6274.968625156845, 6062.575619706755, 6118.082287656709, 6136.243373036893, 6139.4781443577795, 6148.262208535004, 6113.205283313141, 6116.204893363834, 6117.938820611737, 6122.234720659918, 6136.447719705069, 5279.709615971158, 5496.8731410060045, 5938.495227905676, 5997.100434934795, 6003.0695242237525, 5972.9701351494705, 6115.113308570321, 6119.167450728676, 6144.15675297418, 6197.225346831646, 6031.155638210566, 6078.014821020687, 6095.2685677718955, 6117.462039585462, 6121.051237058263], "value": 5638.357492119592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.6657506869848, 464.06259356100657, 470.0387707138901, 508.56517677385835, 531.3544043986556, 37910.0, 40961.59038409623, 41032.0, 41107.383389249146, 41146.7655970321, 41688.791556042255, 42332.36501452473, 42335.36496952548, 42418.57581424185, 42533.36199957003, 8502.234798868101, 8744.956275218616, 9277.443353398818, 9488.430694158373, 9516.381435206724, 11226.550937962471, 11552.768944621102, 11566.421678916062, 11718.0, 11732.944035036844, 11463.025642820328, 11495.712607184803, 11540.0, 11548.191626586142, 11550.249233799817, 11324.263922845072, 11474.827877581802, 11524.711882202928, 11535.596254131107, 11543.653690389301, 9458.527073646359, 11412.600558980479, 11472.94263528677, 11477.540898364055, 11489.942550287278, 39382.606173938184, 39519.40720889189, 39719.8014009931, 39903.201935961115, 40055.19889602192, 3981.7212795104356, 4057.817398217058, 4072.4705788247634, 4128.896777580554, 4229.196452674013, 29075.56386654202, 29565.0, 30415.695843041507, 30674.53988190179, 30675.539866902014, 3227.5158726191025, 3288.5067239913965, 3293.637699853014, 3304.1409233599197, 3360.092774950774, 437180.0, 439100.0, 439254.0, 439633.0, 440541.0, 60137.0, 60378.0, 60462.0, 60611.787764244466, 60679.0, 58153.418465815645, 58514.41485585175, 58695.70652146712, 58877.0, 59330.40669593335, 16433.589160271087, 17012.234449449556, 17022.063786491613, 17045.31818727262, 17049.31802727877, 11871.525138994344, 12149.392530373447, 12829.679258018437, 13076.346182690828, 13228.0, 15739.921300393426, 15844.60388490297, 15901.886867919135, 15928.840711592737, 15944.123073231083, 7154.570725756367, 7169.641517924083, 7187.9281207188305, 7215.170255420694, 7252.419806415474, 886.6497733395402, 899.7525680437801, 911.4030310146865, 916.4776077635817, 931.1107891963159, 24922.626160607604, 30054.603859738487, 30263.848680756455, 30452.781888724203, 30826.69173308283, 1033.8190816607064, 1113.6826004588816, 1120.2214460949563, 1124.8875112488686, 1156.9652910412701, 15025.774613380809, 15594.922025390028, 15714.528564143095, 15811.36754529829, 16051.598710032342, 517138.0, 639397.0, 642011.0, 643766.0, 645728.0, 59792.40207597868, 59919.70040149859, 59978.40021599728, 60128.39871601228, 60197.699011504665, 1440.0279811127448, 1450.1444147952548, 1464.743669857792, 1467.8238611366705, 1479.7706355514913, 27859.145217143338, 29942.80228790911, 30177.698223017487, 30212.0, 30259.69740302657, 49400.75299623479, 49651.50348496469, 49810.0, 49841.750791247265, 49864.75067624784, 534361.0, 543590.0, 544423.0, 544474.0, 546123.0, 33422.498662519596, 34653.65346346605, 38048.42927356037, 39281.0, 40426.0, 46980.295295571275, 46988.82527936829, 47154.0, 47614.76192619015, 48418.757906210245, 31327.0, 38751.8374448767, 39253.41119883261, 39449.0, 39492.60507395004, 38015.04962375963, 39289.607103928596, 39409.0, 40324.3951340736, 40481.9879503003, 37402.625973741, 37990.620093799815, 38023.42964855474, 38055.0, 38145.0, 33578.83210583931, 34144.0, 34621.65378346285, 35080.649193507736, 35123.648763512036, 20667.4833129173, 25447.745522544537, 25532.61701074448, 25573.87213063997, 25978.480430391664], "value": 20369.891482217994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.27233481891074, 393.6398195650979, 402.24378169042194, 403.6004355687869, 421.6689898429733, 20248.493787655298, 20532.897335513302, 21146.89426552869, 21653.242136525223, 21677.34967950962, 11968.64094077177, 12359.0, 12367.62897113088, 14300.284985750697, 21572.460688482795, 5425.511703946654, 5469.179623056533, 5539.972300138494, 6079.908801367961, 6206.162168107293, 3989.820458079379, 4182.97908510457, 6066.6663333516635, 6177.0734389841655, 6179.443850053494, 5918.4673379395845, 6204.6587437690905, 6222.128901953707, 6251.843703907393, 6274.278457977345, 5903.616264942786, 6190.442860142609, 6231.906521402183, 6236.407541283571, 6246.094316324107, 6156.907646385308, 6161.4146656067605, 6171.13604095427, 6181.103739957681, 6194.163787888622, 13402.396892139877, 13467.865321346759, 13480.0, 13651.38568764398, 13711.588652340446, 2603.960940585893, 2631.736826317372, 2683.8121331506804, 2704.094128466966, 2705.3853328611553, 10165.644202452879, 10179.491025448699, 10281.742956426075, 10600.204984626107, 10686.305390149693, 1843.8617103717274, 1854.7681539807525, 1876.1744832273755, 1882.576420305434, 1897.4402551247415, 131338.0, 132605.0, 132731.6726832729, 134889.0, 136285.3185734065, 10224.079832815083, 10782.622608208674, 10923.453827308604, 11225.326480411039, 11316.37759923212, 13101.737965240833, 13126.0, 13164.868351316556, 13192.406341714646, 13201.0, 6863.38229559342, 8562.315014798802, 8570.057293697688, 8592.398532102692, 8618.095100014534, 8743.0, 8839.29285657146, 8846.11538846123, 8969.955150224207, 9024.548772561477, 3512.3853325668415, 4177.373393990925, 4187.748735075906, 4230.407742915994, 4236.5128010278595, 1374.0107122871516, 2061.505238742721, 2096.371088673392, 2096.7798381170064, 2103.6739305407687, 971.9173870220969, 1062.6493257225097, 1066.6005208979288, 1076.6931424543968, 1080.2762149359949, 20070.89964550168, 21650.35048948534, 21887.343379698315, 21965.560688786136, 22189.11243550272, 1055.9524821383056, 1058.9258751887448, 1066.6053560182781, 1091.5524634899652, 1104.2932523185168, 11372.658820235407, 11441.37072461006, 11587.768244635061, 11598.710032249093, 11613.6515904523, 746941.0, 750729.0, 761612.0, 764267.0, 766150.0, 151857.0, 153063.0, 156388.21805891124, 158421.2078939598, 159304.0, 1012.5190534496055, 1014.4420568687193, 1034.1364960258118, 1035.4305132177424, 1038.9532471038822, 18843.434696959113, 19029.333973310866, 19331.226750929804, 19403.029848507802, 19468.31860884862, 48551.75724121498, 58382.70808645929, 59965.700171498866, 61137.38862611317, 61272.38727612667, 84254.0, 84399.5780021096, 86937.0, 88006.11993880235, 88914.55542722245, 8041.879371809545, 8619.6983105591, 8676.08901065379, 8683.480390931436, 8850.513221772864, 9449.385789923634, 13162.0, 13274.601761947157, 13282.86717132855, 13581.660458488617, 10344.0, 10544.26190166681, 10871.456427178768, 11549.36478493691, 11551.826722599335, 10825.837612435662, 10922.50848711794, 11303.265287756269, 11656.542114006663, 11798.0, 10035.0, 10197.776266848026, 11790.115741319263, 11805.586804461802, 11937.880621193677, 8458.32333413313, 8560.357973151915, 8638.308935285288, 8747.475151490931, 8815.603297851483, 8430.946131733534, 10462.21533384984, 11619.244749091282, 11759.235649682743, 11785.587504437304], "value": 9684.252129724855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.3341245845932, 1344.1934839096543, 1346.340293256304, 1384.1764150330562, 1447.8995963068064, 7289.526180798258, 7801.648925798346, 7963.60181990901, 8303.626336814843, 8832.470051796896, 8170.0, 8406.369522285837, 8484.618192181351, 8588.184122508368, 8610.095939926312, 2295.942601434965, 2336.100601268507, 2338.5790557699606, 2339.181286549711, 2355.0226655937763, 2106.115431518766, 2188.157559339658, 2332.54515369503, 2370.7510711375317, 2376.9049238030457, 2268.4782500025003, 2348.753380895007, 2352.282553821084, 2355.305184970438, 2365.27859003004, 2331.219041621059, 2332.1720789119872, 2351.2358483492762, 2355.4817940053163, 2359.304005318435, 2341.7072865891764, 2343.367290831466, 2392.4736557957394, 2421.2131057406236, 2427.781499665021, 8601.268892144175, 8648.697295594624, 8653.870191947126, 8665.43674661145, 8699.608517616722, 5105.33630628016, 5268.341457317835, 5271.288376069258, 5273.762680679379, 5273.9736301318635, 3289.1612638777196, 3389.237421580149, 3472.871316822018, 3557.1640664443835, 3595.5505561804775, 1112.6884472347756, 1191.6484637032097, 1201.5974648492765, 1248.219862585884, 1281.3849352310942, 11059.336439813556, 11182.776344473146, 11189.66431007063, 11192.0, 11205.663830085028, 4052.675785937118, 4684.672072954929, 4725.9054818904115, 4787.976060119747, 4838.927416088762, 8111.310538604167, 8784.824303513893, 8932.374733768575, 8957.686480973134, 8960.0, 5166.0, 5174.7153906535505, 5177.844664660066, 5179.352580927384, 5189.610779191576, 4723.645726570521, 4777.4267087949665, 4832.975835120802, 4837.516248375135, 4859.489753575895, 3723.162288485069, 3811.142492939122, 3830.0, 3857.479240302523, 3926.5484469285825, 1050.658535975811, 1091.2688498705886, 1121.4000509727257, 1133.5069244878339, 1139.8176291793272, 802.0415603353936, 869.387082107113, 896.3008853094597, 896.9820603587891, 919.8298314811648, 5810.1865738796605, 5876.265466816648, 5922.763089476459, 6037.849053773603, 6174.5060395168275, 989.6433820072971, 995.144176008632, 1004.3070281505884, 1014.6905193915926, 1061.6443491430457, 3244.967550324514, 3501.9474707879403, 3652.2330310635066, 4057.9797101014306, 4148.668106551469, 10309.587616495257, 10341.0, 10486.423246721504, 10486.685399438029, 10487.842682359771, 8807.647694092293, 9211.447313161098, 10082.546285417175, 10305.175585953255, 10358.741031474123, 7019.4735394844565, 7867.055953285528, 8179.304759095425, 8256.25693687583, 8297.95851020753, 5575.637583557056, 5762.848887402889, 5786.161006654096, 5825.563082768894, 5846.123081537803, 9189.172974432333, 9569.856452153363, 9595.856062158933, 9612.038796120332, 9640.325177237526, 9250.72247832566, 9395.436273823592, 9453.621855125994, 9712.75718107053, 9744.707658770249, 7299.927000729925, 7360.96319518399, 7361.043064401593, 7381.594012329373, 7425.480216384801, 7954.721584744506, 7981.920180798118, 8022.9598852005365, 8033.35733141359, 8043.396745244013, 7100.9289907100265, 7265.200827909031, 7334.706611735684, 7405.111386633638, 7490.5880176588635, 7123.180834204133, 7162.820929476597, 7172.211056783645, 7194.89207661875, 7316.341529262179, 6497.642629655415, 6580.5722628029025, 6618.8345291368105, 6620.040094186413, 6629.635370054693, 5051.8380772421815, 5077.416097148875, 5114.514121158484, 5274.578033757213, 5374.193870919394, 5093.343146713382, 5136.589072874086, 5288.915772266753, 5345.011172932865, 5351.892962140813], "value": 4474.2335248308445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2223264212779, 371.53372517490544, 371.7880807939474, 372.59387267878043, 377.5111230955912, 4817.325574419579, 5422.322209723785, 5514.077538904377, 5542.584306177043, 5546.223528705985, 4524.389207456992, 5145.3568303962, 5345.412004679482, 5361.678299302044, 5466.879289745602, 3228.903132906011, 4065.3292206785845, 4129.0, 4212.53662097169, 4237.7669228192435, 4203.096334288128, 4203.516595591515, 4205.705600607958, 4224.070704445033, 4276.914461710764, 4227.281362168439, 4228.243226370333, 4235.555266696999, 4254.468191476066, 4270.444842170514, 3435.5018522314376, 4088.2028004539275, 4137.97931010343, 4209.726367786084, 4237.194932962742, 3110.891118810831, 3232.208109013307, 3727.1986522897437, 3731.925361492782, 3759.8872033838757, 4820.493848145964, 4995.500449955011, 5207.583393328525, 5264.552513036397, 5279.973600132013, 4744.742643199555, 4915.787895447063, 4940.382452193476, 4948.628852836052, 4980.87547811304, 4821.373221481185, 5423.806762512241, 5538.723063846832, 5737.741801618896, 5762.654240745569, 3968.583298753647, 4112.0, 4164.66682665386, 4189.6438802701805, 4204.810783514749, 5205.817796377147, 5310.62825602208, 5424.31146820166, 6067.18093057436, 6114.724837382329, 4037.394390841397, 4184.748915065105, 4195.370694395804, 4224.76763777989, 4254.510731265882, 3665.6884164846288, 3909.276783795007, 3977.7414468059483, 4312.288472402019, 4317.697761156752, 3853.2678791029616, 4302.3546468030045, 4675.976620116946, 4899.6570240083565, 4913.778879950411, 5467.250479846491, 5580.693061881636, 5668.752874367632, 5863.0, 5863.003289440805, 1159.4492616007328, 1176.5117476247262, 1267.797152455621, 1298.7726598364643, 1311.4819646239873, 741.8516296740673, 772.6252767407802, 800.5390162952634, 805.9476134051386, 891.1667590802621, 4451.488078870907, 4769.070031343855, 5120.694222973118, 5345.679259244458, 5378.623496355218, 5434.809781657702, 5982.231194347533, 5985.371535988746, 6018.3680713524445, 6046.818595442144, 5032.508908090519, 5343.931213757264, 5353.929214157184, 5414.593905457106, 5423.457654234545, 2630.88161032754, 2843.3033906692995, 2946.848800375738, 3001.3997200559975, 3028.2732144285214, 4923.581495572845, 5896.793612223637, 5911.733971971272, 5928.762849486058, 6005.789797357159, 5443.374011988592, 5504.559635229172, 5697.03150464422, 5738.713064346766, 5883.529317654577, 5070.569001634829, 5315.760790764425, 5859.384764599656, 5870.530357571384, 5977.834322307195, 5356.380394293184, 5391.514763671288, 5432.891342173055, 5556.722163891708, 5774.39368866263, 5255.9211611825085, 5582.0, 5607.635503692247, 5702.344230413555, 5744.4829965303325, 4859.684120532154, 5003.974185292079, 5151.639385242997, 5336.838580374954, 5914.911276330772, 3392.4556582563077, 3657.1588534637713, 3696.9815150924073, 3754.1740817020213, 3782.9432558512194, 5171.844844654666, 5326.893462130658, 5689.6586204827845, 5719.8856022880145, 5744.133156723998, 4697.8355757548325, 5240.71176085319, 5293.7353132344, 5434.0, 5568.916466252928, 4552.840650577346, 4705.647076469347, 5501.642393244426, 5525.475079867406, 5550.55595552363, 5044.041632089891, 5211.661242019257, 5244.632875698817, 5252.395974462986, 5259.4477579853565, 4630.004549021976, 4687.32033855096, 5345.438728933406, 5450.8909821802545, 5502.5597952164535, 5173.715445650525, 5543.223948647274, 5567.721613919369, 5568.972155139199, 5589.832305030855], "value": 4130.788475869559, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8744082344764, 737.9335859772626, 778.2645400096907, 819.442778910341, 819.8606236939721, 14774.113553186817, 15180.772288415656, 15504.224788760544, 15749.84250157498, 15772.526824195278, 14340.641483962907, 14518.0, 14530.418783248684, 14531.709365812678, 14538.836893048558, 687.9140107486564, 705.6648092156236, 858.8110615664543, 873.1661263493364, 889.4440974391006, 850.4897061762923, 881.418263945796, 884.8009197930446, 890.7505898348472, 891.0999890111002, 947.5025611553921, 948.8908775490803, 949.2832911152105, 951.0346997797242, 953.3088510829627, 845.7905195570332, 876.4171825735909, 936.5972631768337, 942.9245660347156, 944.9433034017981, 694.9957311684618, 708.0901042160799, 708.2032713197652, 709.7444919828857, 710.4245561095529, 14805.629859253497, 15149.0, 15237.314320855588, 15557.29992150356, 15791.447299344467, 14343.856561434357, 14520.782188267185, 14663.63340916475, 14845.777313340308, 14903.180325082116, 11647.242929209575, 11873.52505899763, 11903.702407439883, 11950.103742219368, 12154.635360939186, 3713.554373475173, 3765.7928813915496, 3793.506844110276, 3822.140018495844, 3829.1193025604266, 65007.0, 98439.0, 102536.0, 102542.48728756382, 103202.48398758033, 10022.398656080659, 10417.635382761568, 10553.788924221626, 10791.406472643923, 11018.228723989405, 21519.0, 21563.568728625338, 21994.670079948814, 22016.669749953442, 22156.446088847584, 7534.660940257701, 7632.542047477169, 7657.770266891891, 7662.195469475736, 7807.765767026998, 4117.1765646870745, 4356.869293921188, 4363.934540981888, 4426.933595996063, 4438.312061630452, 3498.177928186874, 3590.8563657453933, 3591.8865151803025, 3594.0655429587973, 3630.8729194478065, 649.3798422506495, 659.6339031837281, 671.2549070531705, 672.9192496900305, 680.4794332335767, 546.9316335458068, 608.3916083916084, 618.703022549179, 625.8529245627274, 644.7098805537433, 9317.673881414117, 9462.0, 9667.226621870233, 10044.899551004542, 10087.798244035079, 607.4138456389605, 668.7759600533778, 678.0507289794228, 682.3142741544716, 690.7996680962565, 4744.786484608201, 4848.539388758062, 4861.1979023460735, 4861.246506791453, 4875.0, 108415.37376939353, 108442.0, 108514.45742771236, 108879.91120088856, 109412.0, 85429.14570854336, 92557.0, 96112.0, 97857.0, 98264.52603210957, 65842.67078664672, 69007.65496172487, 69055.65472172707, 70494.64752676306, 70617.0, 9301.395409298373, 9412.57643406062, 9438.575264112995, 9495.952520237355, 9498.430094194371, 54881.45118548763, 55126.17310740262, 55252.06617768359, 55477.44522554723, 55672.0, 54961.450385495635, 70021.29978700148, 72400.63799681178, 73566.0, 74139.0, 10757.085647720032, 11013.504392302526, 11032.724181895195, 11119.666410007712, 11431.942840285745, 11867.643970680894, 11994.880051199376, 12016.098792590416, 12106.576269830513, 12450.630430652802, 10595.0, 11695.12286578493, 11815.822762658396, 11972.700682482659, 12096.939515302367, 11714.531418743154, 11778.0, 11851.0, 11879.940600296943, 11948.641540753792, 11045.779084418105, 11199.776004480027, 11436.82844757346, 11463.426828658701, 11953.641390758292, 8390.496570205563, 8420.326373890197, 8659.523726194868, 9252.861207081765, 10218.948905255425, 7834.80412989657, 8466.830663386821, 9376.671816486663, 9409.106134917172, 9438.764030899283], "value": 7274.55514869093, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 113.0, 113.0, 115.0, 172.0, 167.0, 115.0, 117.0, 133.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 112.0, 144.0, 113.0, 113.0, 112.0, 110.0, 128.0, 114.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [267.0, 255.0, 200.0, 195.0, 195.0, 198.0, 245.0, 259.0, 197.0, 198.0], "value": 220.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 85.0, 50.0, 74.0, 53.0, 64.0, 87.0, 84.0, 95.0, 81.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 103.0, 102.0, 86.0, 82.0, 71.0, 71.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 89.0, 90.0, 102.0, 137.0, 116.0, 89.0, 89.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 121.0, 154.0, 94.0, 95.0, 95.0, 95.0, 95.0, 115.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 95.0, 142.0, 147.0, 91.0, 91.0, 94.0, 92.0, 93.0, 94.0], "value": 105.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 60.0, 59.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 76.0, 70.0, 70.0, 69.0, 69.0, 71.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 84.0, 87.0, 84.0, 85.0, 89.0, 86.0, 105.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 143.0, 146.0, 151.0, 154.0, 148.0, 163.0, 178.0, 209.0, 152.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 172.0, 150.0, 205.0, 237.0, 166.0, 159.0, 191.0, 237.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 79.0, 68.0, 64.0, 72.0, 88.0, 65.0, 62.0, 85.0], "value": 71.4, "unit": "score"}]}]} 07:14:13 INFO - Return code: 0 07:14:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:14:13 ERROR - # TBPL SUCCESS # 07:14:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:14:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:14:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:14:13 INFO - 2017-01-27 07:14:13.198 screenresolution[1921:17230] starting screenresolution argv=screenresolution get 07:14:13 INFO - 2017-01-27 07:14:13.201 screenresolution[1921:17230] Display 0: 1600x1200x32@60 07:14:13 INFO - 2017-01-27 07:14:13.207 screenresolution[1922:17233] starting screenresolution argv=screenresolution list 07:14:13 INFO - Available Modes on Display 0 07:14:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:14:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:14:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:14:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:14:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:14:13 INFO - Intel Iris: 07:14:13 INFO - Chipset Model: Intel Iris 07:14:13 INFO - Type: GPU 07:14:13 INFO - Bus: Built-In 07:14:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:14:13 INFO - Vendor: Intel (0x8086) 07:14:13 INFO - Device ID: 0x0a2e 07:14:13 INFO - Revision ID: 0x0009 07:14:13 INFO - Displays: 07:14:13 INFO - Display: 07:14:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:14:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:14:13 INFO - Display Serial Number: 1600x1200 60 07:14:13 INFO - Main Display: Yes 07:14:13 INFO - Mirror: Off 07:14:13 INFO - Online: Yes 07:14:13 INFO - Rotation: Supported 07:14:13 INFO - Return code: 0 07:14:13 INFO - Running post-action listener: _resource_record_post_action 07:14:13 INFO - [mozharness: 2017-01-27 15:14:13.441699Z] Finished run-tests step (success) 07:14:13 INFO - Running post-run listener: _resource_record_post_run 07:14:13 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 1110016; Write bytes: 511254016; Read time: 14; Write time: 1855 07:14:13 INFO - TinderboxPrint: CPU usage
54.3% 07:14:13 INFO - TinderboxPrint: I/O read bytes / time
1,110,016 / 14 07:14:13 INFO - TinderboxPrint: I/O write bytes / time
511,254,016 / 1,855 07:14:13 INFO - TinderboxPrint: CPU idle
2,184.8 (45.7%) 07:14:13 INFO - TinderboxPrint: CPU system
963.7 (20.1%) 07:14:13 INFO - TinderboxPrint: CPU user
1,637.3 (34.2%) 07:14:13 INFO - TinderboxPrint: Swap in / out
209,248,256 / 0 07:14:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207147520; Write bytes: 201627648; Read time: 15905; Write time: 401 07:14:13 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 933888; Write bytes: 299578880; Read time: 12; Write time: 1413 07:14:13 INFO - Running post-run listener: _upload_blobber_files 07:14:13 INFO - Blob upload gear active. 07:14:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:14:13 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 07:14:13 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'] 07:14:13 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 07:14:14 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:15 INFO - (blobuploader) - INFO - Done attempting. 07:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:16 INFO - (blobuploader) - INFO - Done attempting. 07:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:17 INFO - (blobuploader) - INFO - Done attempting. 07:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:19 INFO - (blobuploader) - INFO - Done attempting. 07:14:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:19 INFO - Return code: 0 07:14:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:14:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e16812705a47ebef30555270778a42f4890cd1470b5b195df5a3a9b0de0c9abafb035b303859b862663eb9691ce8bc3b2b9af961bb3806ad984e3993304ab1e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67371e2590517a0f0527a961d6f9942e27024d2d4ed42212f72b6f8768ea15ae5d819bfbf2745499471756138f6018598d8eda259acd3edc9a6612e3ed9ea9c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a55b38940ce8e46d625ce143d818f2d682a06a03e0c5ff7781e45b06d5fb20432ce4399bdc8b1f44442ceb43920ed63e2488a383fe1bdcccbf4b4ad1900a9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c630773b606784a2da9a676bf305513abebac0f19eb64c96d40819ce6fdc589776d0425cbc1594d2a0883e5d70b6f37e8c42fa7fd26d46529b2bda2c627301d2"} 07:14:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:14:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:14:19 INFO - Contents: 07:14:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e16812705a47ebef30555270778a42f4890cd1470b5b195df5a3a9b0de0c9abafb035b303859b862663eb9691ce8bc3b2b9af961bb3806ad984e3993304ab1e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67371e2590517a0f0527a961d6f9942e27024d2d4ed42212f72b6f8768ea15ae5d819bfbf2745499471756138f6018598d8eda259acd3edc9a6612e3ed9ea9c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a55b38940ce8e46d625ce143d818f2d682a06a03e0c5ff7781e45b06d5fb20432ce4399bdc8b1f44442ceb43920ed63e2488a383fe1bdcccbf4b4ad1900a9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c630773b606784a2da9a676bf305513abebac0f19eb64c96d40819ce6fdc589776d0425cbc1594d2a0883e5d70b6f37e8c42fa7fd26d46529b2bda2c627301d2"} 07:14:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:14:19 INFO - Copying logs to upload dir... 07:14:19 INFO - mkdir: /builds/slave/test/build/upload/logs 07:14:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.862514 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-27 07:14:19.292591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 07:14:19.296182) ========= 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.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/8e16812705a47ebef30555270778a42f4890cd1470b5b195df5a3a9b0de0c9abafb035b303859b862663eb9691ce8bc3b2b9af961bb3806ad984e3993304ab1e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67371e2590517a0f0527a961d6f9942e27024d2d4ed42212f72b6f8768ea15ae5d819bfbf2745499471756138f6018598d8eda259acd3edc9a6612e3ed9ea9c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a55b38940ce8e46d625ce143d818f2d682a06a03e0c5ff7781e45b06d5fb20432ce4399bdc8b1f44442ceb43920ed63e2488a383fe1bdcccbf4b4ad1900a9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c630773b606784a2da9a676bf305513abebac0f19eb64c96d40819ce6fdc589776d0425cbc1594d2a0883e5d70b6f37e8c42fa7fd26d46529b2bda2c627301d2"} build_url:https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/CgygbaNDRdOyOLcKXRblCA/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/8e16812705a47ebef30555270778a42f4890cd1470b5b195df5a3a9b0de0c9abafb035b303859b862663eb9691ce8bc3b2b9af961bb3806ad984e3993304ab1e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67371e2590517a0f0527a961d6f9942e27024d2d4ed42212f72b6f8768ea15ae5d819bfbf2745499471756138f6018598d8eda259acd3edc9a6612e3ed9ea9c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a55b38940ce8e46d625ce143d818f2d682a06a03e0c5ff7781e45b06d5fb20432ce4399bdc8b1f44442ceb43920ed63e2488a383fe1bdcccbf4b4ad1900a9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c630773b606784a2da9a676bf305513abebac0f19eb64c96d40819ce6fdc589776d0425cbc1594d2a0883e5d70b6f37e8c42fa7fd26d46529b2bda2c627301d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 07:14:19.330926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:14:19.331228) ========= 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.xHuvQxY5dq/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.AEqkzfdME0/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005385 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:14:19.379546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 07:14:19.379861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 07:14:19.380184) ========= ========= Total master_lag: 0.18 =========