builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0280 starttime: 1492654993.24 results: success (0) buildid: 20170419094244 builduid: 567cccf9d4c34dc6a925f540fd445396 revision: d1959e5a2236d5244af9ab715d2d9a82da6a9659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:13.241899) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:13.242329) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:13.242602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:13.267105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:23:13.267459) ========= 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.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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-04-19 19:23:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.9M=0.001s 2017-04-19 19:23:13 (22.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.393575 ========= master_lag: 1.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:23:14.795338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:14.795700) ========= 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.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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.021985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:14.844063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-19 19:23:14.844402) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev d1959e5a2236d5244af9ab715d2d9a82da6a9659 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev d1959e5a2236d5244af9ab715d2d9a82da6a9659 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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-04-19 19:23:14,980 truncating revision to first 12 chars 2017-04-19 19:23:14,980 Setting DEBUG logging. 2017-04-19 19:23:14,980 attempt 1/10 2017-04-19 19:23:14,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/d1959e5a2236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 19:23:15,935 unpacking tar archive at: pine-d1959e5a2236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.216490 ========= master_lag: 2.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-19 19:23:18.187109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:18.191513) ========= script_repo_revision: d1959e5a2236d5244af9ab715d2d9a82da6a9659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:18.191954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:18.192236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:23:18.727496) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-19 19:23:18.727899) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:23:18 INFO - MultiFileLogger online at 20170419 19:23:18 in /builds/slave/test 19:23:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 19:23:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:23:18 INFO - {'append_to_log': False, 19:23:18 INFO - 'base_work_dir': '/builds/slave/test', 19:23:18 INFO - 'blob_upload_branch': 'Pine', 19:23:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:23:18 INFO - 'branch': 'Pine', 19:23:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:23:18 INFO - 'config_files': ('talos/mac_config.py',), 19:23:18 INFO - 'default_actions': ('clobber', 19:23:18 INFO - 'read-buildbot-config', 19:23:18 INFO - 'download-and-extract', 19:23:18 INFO - 'populate-webroot', 19:23:18 INFO - 'create-virtualenv', 19:23:18 INFO - 'install', 19:23:18 INFO - 'run-tests'), 19:23:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:23:18 INFO - 'download_minidump_stackwalk': True, 19:23:18 INFO - 'download_symbols': 'ondemand', 19:23:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:23:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:23:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:23:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:23:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:23:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:23:18 INFO - 'gecko_profile': False, 19:23:18 INFO - 'gecko_profile_interval': 0, 19:23:18 INFO - 'installer_path': 'installer.exe', 19:23:18 INFO - 'log_level': 'info', 19:23:18 INFO - 'log_name': 'talos', 19:23:18 INFO - 'log_to_console': True, 19:23:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:23:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:23:18 INFO - 'opt_config_files': (), 19:23:18 INFO - 'pip_index': False, 19:23:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:23:18 INFO - 'cmd': ('bash', 19:23:18 INFO - '-c', 19:23:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:23:18 INFO - 'enabled': True, 19:23:18 INFO - 'halt_on_failure': False, 19:23:18 INFO - 'name': 'check_screen_resolution'},), 19:23:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:23:18 INFO - 'cmd': ('bash', 19:23:18 INFO - '-c', 19:23:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:23:18 INFO - 'enabled': True, 19:23:18 INFO - 'halt_on_failure': False, 19:23:18 INFO - 'name': 'check_screen_resolution'},), 19:23:18 INFO - 'run_cmd_checks_enabled': True, 19:23:18 INFO - 'suite': 'dromaeojs-e10s', 19:23:18 INFO - 'system_bits': '32', 19:23:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:23:18 INFO - 'title': 't-yosemite-r7-0280', 19:23:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:23:18 INFO - 'use_talos_json': True, 19:23:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:23:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:23:18 INFO - 'work_dir': 'build'} 19:23:18 INFO - [mozharness: 2017-04-20 02:23:18.983556Z] Running clobber step. 19:23:18 INFO - Running pre-action listener: _resource_record_pre_action 19:23:18 INFO - Running main action method: clobber 19:23:18 INFO - rmtree: /builds/slave/test/build 19:23:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:23:22 INFO - Running post-action listener: _resource_record_post_action 19:23:22 INFO - [mozharness: 2017-04-20 02:23:22.383350Z] Finished clobber step (success) 19:23:22 INFO - [mozharness: 2017-04-20 02:23:22.383523Z] Running read-buildbot-config step. 19:23:22 INFO - Running pre-action listener: _resource_record_pre_action 19:23:22 INFO - Running main action method: read_buildbot_config 19:23:22 INFO - Using buildbot properties: 19:23:22 INFO - { 19:23:22 INFO - "project": "", 19:23:22 INFO - "product": "firefox", 19:23:22 INFO - "script_repo_revision": "default", 19:23:22 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 19:23:22 INFO - "repository": "", 19:23:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 19:23:22 INFO - "buildid": "20170419094244", 19:23:22 INFO - "pgo_build": "False", 19:23:22 INFO - "basedir": "/builds/slave/test", 19:23:22 INFO - "buildnumber": 0, 19:23:22 INFO - "slavename": "t-yosemite-r7-0280", 19:23:22 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:23:22 INFO - "platform": "yosemite_r7", 19:23:22 INFO - "scheduler": "tests-pine-macosx64-talos", 19:23:22 INFO - "branch": "pine", 19:23:22 INFO - "repo_path": "projects/pine", 19:23:22 INFO - "revision": "d1959e5a2236d5244af9ab715d2d9a82da6a9659", 19:23:22 INFO - "stage_platform": "macosx64", 19:23:22 INFO - "builduid": "567cccf9d4c34dc6a925f540fd445396", 19:23:22 INFO - "slavebuilddir": "test" 19:23:22 INFO - } 19:23:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:23:22 INFO - Running post-action listener: _resource_record_post_action 19:23:22 INFO - [mozharness: 2017-04-20 02:23:22.386855Z] Finished read-buildbot-config step (success) 19:23:22 INFO - [mozharness: 2017-04-20 02:23:22.386999Z] Running download-and-extract step. 19:23:22 INFO - Running pre-action listener: _resource_record_pre_action 19:23:22 INFO - Running main action method: download_and_extract 19:23:22 INFO - mkdir: /builds/slave/test/build/tests 19:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:23:22 INFO - trying https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:23:22 INFO - Downloading https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 19:23:23 INFO - Downloaded 1325 bytes. 19:23:23 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:23:23 INFO - Using the following test package requirements: 19:23:23 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:23:23 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:23:23 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:23:23 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:23:23 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'jsshell-mac.zip'], 19:23:23 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:23:23 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:23:23 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:23:23 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:23:23 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:23:23 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:23:23 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:23:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:23:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:23:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:23:23 INFO - Fetch https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:23:25 INFO - Expected file size: 52614995 19:23:25 INFO - Obtained file size: 52614995 19:23:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:23:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:23:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:23:41 INFO - Fetch https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:23:42 INFO - Expected file size: 52614995 19:23:42 INFO - Obtained file size: 52614995 19:23:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:23:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:23:58 INFO - Fetch https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:23:59 INFO - Expected file size: 14408802 19:23:59 INFO - Obtained file size: 14408802 19:23:59 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')]} 19:23:59 INFO - trying https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:23:59 INFO - Downloading https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 19:24:01 INFO - Downloaded 71073136 bytes. 19:24:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:24:01 INFO - mkdir: /builds/slave/test/properties 19:24:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:01 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:01 INFO - Contents: 19:24:01 INFO - build_url:https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:24:02 INFO - Running post-action listener: _resource_record_post_action 19:24:02 INFO - Running post-action listener: set_extra_try_arguments 19:24:02 INFO - [mozharness: 2017-04-20 02:24:02.409508Z] Finished download-and-extract step (success) 19:24:02 INFO - [mozharness: 2017-04-20 02:24:02.409664Z] Running populate-webroot step. 19:24:02 INFO - Running pre-action listener: _resource_record_pre_action 19:24:02 INFO - Running main action method: populate_webroot 19:24:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:02 INFO - '--tppagecycles', 19:24:02 INFO - '7'], 19:24:02 INFO - 'tests': ['tsvgm']}}, 19:24:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['damp', 'tps']}, 19:24:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'tests': ['damp', 'tps']}, 19:24:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['dromaeo_dom']}, 19:24:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:24:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:24:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['a11yr', 19:24:02 INFO - 'ts_paint', 19:24:02 INFO - 'tpaint', 19:24:02 INFO - 'sessionrestore', 19:24:02 INFO - 'sessionrestore_no_auto_restore', 19:24:02 INFO - 'tabpaint']}, 19:24:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:24:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:24:02 INFO - 'bloom_basic_ref']}, 19:24:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['tsvgx', 19:24:02 INFO - 'tsvgr_opacity', 19:24:02 INFO - 'tart', 19:24:02 INFO - 'tscrollx', 19:24:02 INFO - 'cart', 19:24:02 INFO - 'tsvg_static']}, 19:24:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:02 INFO - 'tsvgr_opacity', 19:24:02 INFO - 'tart', 19:24:02 INFO - 'tscrollx', 19:24:02 INFO - 'cart', 19:24:02 INFO - 'tsvg_static']}, 19:24:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'talos_options': ['--disable-e10s'], 19:24:02 INFO - 'tests': ['tp5o']}, 19:24:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:24:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'talos_options': ['--disable-e10s', 19:24:02 INFO - '--xperf_path', 19:24:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:02 INFO - 'tests': ['tp5n']}, 19:24:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:24:02 INFO - 'talos_options': ['--xperf_path', 19:24:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:02 INFO - 'tests': ['tp5n']}}, 19:24:02 INFO - 'talos.zip': {'path': '', 19:24:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:02 INFO - Running post-action listener: _resource_record_post_action 19:24:02 INFO - [mozharness: 2017-04-20 02:24:02.428913Z] Finished populate-webroot step (success) 19:24:02 INFO - [mozharness: 2017-04-20 02:24:02.429047Z] Running create-virtualenv step. 19:24:02 INFO - Running pre-action listener: _resource_record_pre_action 19:24:02 INFO - Running main action method: create_virtualenv 19:24:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:02 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 19:24:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:02 INFO - Using real prefix '/tools/python27' 19:24:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:06 INFO - Installing pip.................done. 19:24:06 INFO - Return code: 0 19:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:24:06 INFO - Reading from file tmpfile_stdout 19:24:06 INFO - Output received: 19:24:06 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) 19:24:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:06 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:06 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 19:24:06 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 19:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:06 INFO - 'HOME': '/Users/cltbld', 19:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:06 INFO - 'LOGNAME': 'cltbld', 19:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:06 INFO - 'MOZ_NO_REMOTE': '1', 19:24:06 INFO - 'NO_EM_RESTART': '1', 19:24:06 INFO - 'PAGER': '/bin/cat', 19:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:06 INFO - 'PWD': '/builds/slave/test', 19:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:06 INFO - 'SHELL': '/bin/bash', 19:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:06 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:06 INFO - 'USER': 'cltbld', 19:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:06 INFO - 'XPC_FLAGS': '0x0', 19:24:06 INFO - 'XPC_SERVICE_NAME': '0', 19:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:06 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 19:24:06 INFO - Cleaning up... 19:24:06 INFO - Return code: 0 19:24:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:06 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:06 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 19:24:06 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 19:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:06 INFO - 'HOME': '/Users/cltbld', 19:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:06 INFO - 'LOGNAME': 'cltbld', 19:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:06 INFO - 'MOZ_NO_REMOTE': '1', 19:24:06 INFO - 'NO_EM_RESTART': '1', 19:24:06 INFO - 'PAGER': '/bin/cat', 19:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:06 INFO - 'PWD': '/builds/slave/test', 19:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:06 INFO - 'SHELL': '/bin/bash', 19:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:06 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:06 INFO - 'USER': 'cltbld', 19:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:06 INFO - 'XPC_FLAGS': '0x0', 19:24:06 INFO - 'XPC_SERVICE_NAME': '0', 19:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:06 INFO - Downloading/unpacking psutil>=3.1.1 19:24:06 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 19:24:06 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 19:24:06 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 19:24:06 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 19:24:06 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 19:24:06 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 19:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:10 INFO - Installing collected packages: psutil 19:24:10 INFO - Running setup.py install for psutil 19:24:10 INFO - building 'psutil._psutil_osx' extension 19:24:10 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 19:24:10 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 19:24:10 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 19:24:10 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 19:24:10 INFO - building 'psutil._psutil_posix' extension 19:24:10 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 19:24:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:24:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:24:10 INFO - ^ 19:24:11 INFO - 1 warning generated. 19:24:11 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 19:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:11 INFO - Successfully installed psutil 19:24:11 INFO - Cleaning up... 19:24:11 INFO - Return code: 0 19:24:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:11 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')]} 19:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:11 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')]} 19:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:12 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:12 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 19:24:12 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 19:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:12 INFO - 'HOME': '/Users/cltbld', 19:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:12 INFO - 'LOGNAME': 'cltbld', 19:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:12 INFO - 'MOZ_NO_REMOTE': '1', 19:24:12 INFO - 'NO_EM_RESTART': '1', 19:24:12 INFO - 'PAGER': '/bin/cat', 19:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:12 INFO - 'PWD': '/builds/slave/test', 19:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:12 INFO - 'SHELL': '/bin/bash', 19:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:12 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:12 INFO - 'USER': 'cltbld', 19:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:12 INFO - 'XPC_FLAGS': '0x0', 19:24:12 INFO - 'XPC_SERVICE_NAME': '0', 19:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24: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 19:24:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:15 INFO - Installing collected packages: mozsystemmonitor 19:24:15 INFO - Running setup.py install for mozsystemmonitor 19:24:15 INFO - Successfully installed mozsystemmonitor 19:24:15 INFO - Cleaning up... 19:24:15 INFO - Return code: 0 19:24:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:15 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:15 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 19:24:15 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 19:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:15 INFO - 'HOME': '/Users/cltbld', 19:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:15 INFO - 'LOGNAME': 'cltbld', 19:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:15 INFO - 'MOZ_NO_REMOTE': '1', 19:24:15 INFO - 'NO_EM_RESTART': '1', 19:24:15 INFO - 'PAGER': '/bin/cat', 19:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:15 INFO - 'PWD': '/builds/slave/test', 19:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:15 INFO - 'SHELL': '/bin/bash', 19:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:15 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:15 INFO - 'USER': 'cltbld', 19:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:15 INFO - 'XPC_FLAGS': '0x0', 19:24:15 INFO - 'XPC_SERVICE_NAME': '0', 19:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:15 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 19:24:15 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 19:24:15 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 19:24:15 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 19:24:15 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 19:24:15 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 19:24:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:18 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 19:24:18 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 19:24:18 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 19:24:18 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 19:24:18 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 19:24:18 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 19:24:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:19 INFO - warning: no files found matching '*.txt' 19:24:19 INFO - no previously-included directories found matching 'build' 19:24:19 INFO - no previously-included directories found matching 'dist' 19:24:19 INFO - no previously-included directories found matching '.git*' 19:24:19 INFO - Installing collected packages: jsonschema, functools32 19:24:19 INFO - Running setup.py install for functools32 19:24:19 INFO - warning: no files found matching '*.txt' 19:24:19 INFO - no previously-included directories found matching 'build' 19:24:19 INFO - no previously-included directories found matching 'dist' 19:24:19 INFO - no previously-included directories found matching '.git*' 19:24:19 INFO - Successfully installed jsonschema functools32 19:24:19 INFO - Cleaning up... 19:24:19 INFO - Return code: 0 19:24:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:19 INFO - 'HOME': '/Users/cltbld', 19:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:19 INFO - 'LOGNAME': 'cltbld', 19:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:19 INFO - 'MOZ_NO_REMOTE': '1', 19:24:19 INFO - 'NO_EM_RESTART': '1', 19:24:19 INFO - 'PAGER': '/bin/cat', 19:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:19 INFO - 'PWD': '/builds/slave/test', 19:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:19 INFO - 'SHELL': '/bin/bash', 19:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:19 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:19 INFO - 'USER': 'cltbld', 19:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:19 INFO - 'XPC_FLAGS': '0x0', 19:24:19 INFO - 'XPC_SERVICE_NAME': '0', 19:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:19 INFO - Cleaning up... 19:24:19 INFO - Return code: 0 19:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:19 INFO - 'HOME': '/Users/cltbld', 19:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:19 INFO - 'LOGNAME': 'cltbld', 19:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:19 INFO - 'MOZ_NO_REMOTE': '1', 19:24:19 INFO - 'NO_EM_RESTART': '1', 19:24:19 INFO - 'PAGER': '/bin/cat', 19:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:19 INFO - 'PWD': '/builds/slave/test', 19:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:19 INFO - 'SHELL': '/bin/bash', 19:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:19 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:19 INFO - 'USER': 'cltbld', 19:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:19 INFO - 'XPC_FLAGS': '0x0', 19:24:19 INFO - 'XPC_SERVICE_NAME': '0', 19:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24:23 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 19:24:23 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 19:24:23 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 19:24:23 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 19:24:23 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 19:24:23 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 19:24:23 INFO - Downloading docopt-0.6.1.tar.gz 19:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:23 INFO - Running setup.py install for blobuploader 19:24:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:23 INFO - Running setup.py install for requests 19:24:24 INFO - Running setup.py install for docopt 19:24:24 INFO - Successfully installed blobuploader requests docopt 19:24:24 INFO - Cleaning up... 19:24:24 INFO - Return code: 0 19:24:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24: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')]} 19:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:24 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:24 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 19:24:24 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 19:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:24 INFO - 'HOME': '/Users/cltbld', 19:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:24 INFO - 'LOGNAME': 'cltbld', 19:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:24 INFO - 'MOZ_NO_REMOTE': '1', 19:24:24 INFO - 'NO_EM_RESTART': '1', 19:24:24 INFO - 'PAGER': '/bin/cat', 19:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:24 INFO - 'PWD': '/builds/slave/test', 19:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:24 INFO - 'SHELL': '/bin/bash', 19:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:24 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:24 INFO - 'USER': 'cltbld', 19:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:24 INFO - 'XPC_FLAGS': '0x0', 19:24:24 INFO - 'XPC_SERVICE_NAME': '0', 19:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-C4EjaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-N7eFRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-d113Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-3GeStL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-YbniOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-h2nvRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-VQvoBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-LFnKRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-wEi0Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:25 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-DntIKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-KD1eLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-IKSICm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-iYKXp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5bS1WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-waybYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5pZ1qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:26 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-2kxxcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:26 INFO - Running setup.py install for manifestparser 19:24:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:26 INFO - Running setup.py install for mozcrash 19:24:27 INFO - Running setup.py install for mozdebug 19:24:27 INFO - Running setup.py install for mozdevice 19:24:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Running setup.py install for mozfile 19:24:27 INFO - Running setup.py install for mozhttpd 19:24:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Running setup.py install for mozinfo 19:24:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Running setup.py install for mozInstall 19:24:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:27 INFO - Running setup.py install for mozleak 19:24:28 INFO - Running setup.py install for mozlog 19:24:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Running setup.py install for moznetwork 19:24:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Running setup.py install for mozprocess 19:24:28 INFO - Running setup.py install for mozprofile 19:24:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Running setup.py install for mozrunner 19:24:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:28 INFO - Running setup.py install for mozscreenshot 19:24:29 INFO - Running setup.py install for moztest 19:24:29 INFO - Running setup.py install for mozversion 19:24:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:29 INFO - Cleaning up... 19:24:29 INFO - Return code: 0 19:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:29 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')]} 19:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:29 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')]} 19:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:29 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:29 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 19:24:29 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 19:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:29 INFO - 'HOME': '/Users/cltbld', 19:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:29 INFO - 'LOGNAME': 'cltbld', 19:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:29 INFO - 'MOZ_NO_REMOTE': '1', 19:24:29 INFO - 'NO_EM_RESTART': '1', 19:24:29 INFO - 'PAGER': '/bin/cat', 19:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:29 INFO - 'PWD': '/builds/slave/test', 19:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:29 INFO - 'SHELL': '/bin/bash', 19:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:29 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:29 INFO - 'USER': 'cltbld', 19:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:29 INFO - 'XPC_FLAGS': '0x0', 19:24:29 INFO - 'XPC_SERVICE_NAME': '0', 19:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:29 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-jZgubG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:29 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)) 19:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:29 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-ty6Bn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:29 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)) 19:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:29 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-u4ygIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:29 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)) 19:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:29 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-r8anMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-00a1u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5oxciS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-GSsLso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-rmMbJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Tkm0nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-0SRSbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-Ri1PKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:30 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-ONlVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 19:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:30 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-TgwTUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:31 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)) 19:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:31 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-b716I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:31 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)) 19:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:31 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5nrSBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:31 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)) 19:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:31 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-5n7JgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:31 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)) 19:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:31 INFO - Running setup.py (path:/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/pip-ULZfbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:31 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)) 19:24:31 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)) 19:24:31 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)) 19:24:31 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)) 19:24:31 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:31 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:34 INFO - Downloading blessings-1.6.tar.gz 19:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:24:34 INFO - Installing collected packages: blessings 19:24:34 INFO - Running setup.py install for blessings 19:24:34 INFO - Successfully installed blessings 19:24:34 INFO - Cleaning up... 19:24:34 INFO - Return code: 0 19:24:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:34 INFO - Reading from file tmpfile_stdout 19:24:34 INFO - Current package versions: 19:24:34 INFO - blessings == 1.6 19:24:34 INFO - blobuploader == 1.2.4 19:24:34 INFO - docopt == 0.6.1 19:24:34 INFO - functools32 == 3.2.3-2 19:24:34 INFO - jsonschema == 2.5.1 19:24:34 INFO - manifestparser == 1.1 19:24:34 INFO - mozInstall == 1.12 19:24:34 INFO - mozcrash == 1.0 19:24:34 INFO - mozdebug == 0.1 19:24:34 INFO - mozdevice == 0.50 19:24:34 INFO - mozfile == 1.2 19:24:34 INFO - mozhttpd == 0.7 19:24:34 INFO - mozinfo == 0.9 19:24:34 INFO - mozleak == 0.1 19:24:34 INFO - mozlog == 3.4 19:24:34 INFO - moznetwork == 0.27 19:24:34 INFO - mozprocess == 0.25 19:24:34 INFO - mozprofile == 0.28 19:24:34 INFO - mozrunner == 6.13 19:24:34 INFO - mozscreenshot == 0.1 19:24:34 INFO - mozsystemmonitor == 0.3 19:24:34 INFO - moztest == 0.8 19:24:34 INFO - mozversion == 1.4 19:24:34 INFO - psutil == 3.1.1 19:24:34 INFO - requests == 1.2.3 19:24:34 INFO - wsgiref == 0.1.2 19:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 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 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:34 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 19:24:34 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 19:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:34 INFO - 'HOME': '/Users/cltbld', 19:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:34 INFO - 'LOGNAME': 'cltbld', 19:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:34 INFO - 'MOZ_NO_REMOTE': '1', 19:24:34 INFO - 'NO_EM_RESTART': '1', 19:24:34 INFO - 'PAGER': '/bin/cat', 19:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:34 INFO - 'PWD': '/builds/slave/test', 19:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:34 INFO - 'SHELL': '/bin/bash', 19:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:34 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:34 INFO - 'USER': 'cltbld', 19:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:34 INFO - 'XPC_FLAGS': '0x0', 19:24:34 INFO - 'XPC_SERVICE_NAME': '0', 19:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 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)) 19:24:34 INFO - Cleaning up... 19:24:34 INFO - Return code: 0 19:24:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dceeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1b8c63400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, '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.HGXQrBsuds/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.oDtBJCm3X6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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 19:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:34 INFO - 'HOME': '/Users/cltbld', 19:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:34 INFO - 'LOGNAME': 'cltbld', 19:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:34 INFO - 'MOZ_NO_REMOTE': '1', 19:24:34 INFO - 'NO_EM_RESTART': '1', 19:24:34 INFO - 'PAGER': '/bin/cat', 19:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:34 INFO - 'PWD': '/builds/slave/test', 19:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:34 INFO - 'SHELL': '/bin/bash', 19:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:34 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:34 INFO - 'USER': 'cltbld', 19:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:34 INFO - 'XPC_FLAGS': '0x0', 19:24:34 INFO - 'XPC_SERVICE_NAME': '0', 19:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:24:35 INFO - Cleaning up... 19:24:35 INFO - Return code: 0 19:24:35 INFO - Running post-action listener: _resource_record_post_action 19:24:35 INFO - Running post-action listener: _start_resource_monitoring 19:24:35 INFO - Starting resource monitoring. 19:24:35 INFO - [mozharness: 2017-04-20 02:24:35.251340Z] Finished create-virtualenv step (success) 19:24:35 INFO - [mozharness: 2017-04-20 02:24:35.252335Z] Running install step. 19:24:35 INFO - Running pre-action listener: _resource_record_pre_action 19:24:35 INFO - Running main action method: install 19:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:24:35 INFO - Reading from file tmpfile_stdout 19:24:35 INFO - Detecting whether we're running mozinstall >=1.0... 19:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:24:35 INFO - Reading from file tmpfile_stdout 19:24:35 INFO - Output received: 19:24:35 INFO - Usage: mozinstall [options] installer 19:24:35 INFO - Options: 19:24:35 INFO - -h, --help show this help message and exit 19:24:35 INFO - -d DEST, --destination=DEST 19:24:35 INFO - Directory to install application into. [default: 19:24:35 INFO - "/builds/slave/test"] 19:24:35 INFO - --app=APP Application being installed. [default: firefox] 19:24:35 INFO - mkdir: /builds/slave/test/build/application 19:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:24:55 INFO - Reading from file tmpfile_stdout 19:24:55 INFO - Output received: 19:24:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:24:55 INFO - Running post-action listener: _resource_record_post_action 19:24:55 INFO - [mozharness: 2017-04-20 02:24:55.306486Z] Finished install step (success) 19:24:55 INFO - [mozharness: 2017-04-20 02:24:55.306614Z] Running run-tests step. 19:24:55 INFO - Running pre-action listener: _resource_record_pre_action 19:24:55 INFO - Running main action method: run_tests 19:24:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:24:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:24:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:24:55 INFO - 2017-04-19 19:24:55.321 screenresolution[1954:10069] starting screenresolution argv=screenresolution get 19:24:55 INFO - 2017-04-19 19:24:55.324 screenresolution[1954:10069] Display 0: 1600x1200x32@60 19:24:55 INFO - 2017-04-19 19:24:55.329 screenresolution[1955:10072] starting screenresolution argv=screenresolution list 19:24:55 INFO - Available Modes on Display 0 19:24:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:24:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:24:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:24:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:24:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:24:55 INFO - Intel Iris: 19:24:55 INFO - Chipset Model: Intel Iris 19:24:55 INFO - Type: GPU 19:24:55 INFO - Bus: Built-In 19:24:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:24:55 INFO - Vendor: Intel (0x8086) 19:24:55 INFO - Device ID: 0x0a2e 19:24:55 INFO - Revision ID: 0x0009 19:24:55 INFO - Displays: 19:24:55 INFO - Display: 19:24:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:24:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:24:55 INFO - Display Serial Number: 1600x1200 60 19:24:55 INFO - Main Display: Yes 19:24:55 INFO - Mirror: Off 19:24:55 INFO - Online: Yes 19:24:55 INFO - Rotation: Supported 19:24:55 INFO - Return code: 0 19:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:24:55 INFO - Python 2.7.3 19:24:55 INFO - Return code: 0 19:24:55 INFO - grabbing minidump binary from tooltool 19:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:55 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 0x10daccd30>, '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 0x10d9f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dac1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:24:55 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 19:24:55 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 19:24:55 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 19:24:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:24:55 INFO - Return code: 0 19:24:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:24:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:24:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:24:55 INFO - ENV: RUST_BACKTRACE is now 1 19:24:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:24:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0280', '--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 19:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0280 --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 19:24:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HGXQrBsuds/Render', 19:24:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:55 INFO - 'HOME': '/Users/cltbld', 19:24:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:55 INFO - 'LOGNAME': 'cltbld', 19:24:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:24:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:55 INFO - 'MOZ_NO_REMOTE': '1', 19:24:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:24:55 INFO - 'NO_EM_RESTART': '1', 19:24:55 INFO - 'PAGER': '/bin/cat', 19:24:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:55 INFO - 'PWD': '/builds/slave/test', 19:24:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:24:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:55 INFO - 'RUST_BACKTRACE': '1', 19:24:55 INFO - 'SHELL': '/bin/bash', 19:24:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oDtBJCm3X6/Listeners', 19:24:55 INFO - 'TMPDIR': '/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/', 19:24:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:55 INFO - 'USER': 'cltbld', 19:24:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:55 INFO - 'XPC_FLAGS': '0x0', 19:24:55 INFO - 'XPC_SERVICE_NAME': '0', 19:24:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0280', '--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 19:24:55 INFO - mozversion application_buildid: 20170419094244 19:24:55 INFO - mozversion application_changeset: d1959e5a2236d5244af9ab715d2d9a82da6a9659 19:24:55 INFO - mozversion application_display_name: Nightly 19:24:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:24:55 INFO - mozversion application_name: Firefox 19:24:55 INFO - mozversion application_remotingname: firefox 19:24:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 19:24:55 INFO - mozversion application_vendor: Mozilla 19:24:55 INFO - mozversion application_version: 55.0a1 19:24:55 INFO - mozversion platform_buildid: 20170419094244 19:24:55 INFO - mozversion platform_changeset: d1959e5a2236d5244af9ab715d2d9a82da6a9659 19:24:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 19:24:55 INFO - mozversion platform_version: 55.0a1 19:24:55 INFO - using testdate: 1492655095 19:24:55 INFO - actual date: 1492655095 19:24:55 INFO - starting webserver on 'localhost:49344' 19:24:55 INFO - SUITE-START | Running 2 tests 19:24:55 INFO - TEST-START | dromaeo_css 19:24:55 INFO - operating with platform_type : mac_ 19:24:55 INFO - Initialising browser for dromaeo_css test... 19:24:55 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmplv7PX9/profile http://localhost:49344/getInfo.html) 19:24:58 INFO - PID 1965 | 2017-04-19 19:24:58.628 plugin-container[1967:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.tsm.portname' 19:24:58 INFO - PID 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:24:58 INFO - PID 1965 | 2017-04-19 19:24:58.632 plugin-container[1967:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 19:24:58 INFO - PID 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:24:58 INFO - PID 1965 | 2017-04-19 19:24:58.632 plugin-container[1967:10257] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:24:58 INFO - PID 1965 | __metrics Screen width/height:1600/1200 19:24:58 INFO - PID 1965 | colorDepth:24 19:24:58 INFO - PID 1965 | Browser inner width/height: 1024/689 19:24:58 INFO - PID 1965 | __metrics 19:24:58 ERROR - PID 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 19:24:59 INFO - TEST-INFO | 1965: exit 0 19:24:59 INFO - Browser initialized. 19:24:59 INFO - Running cycle 1/1 for dromaeo_css test... 19:24:59 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmplv7PX9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:02 INFO - PID 1968 | 2017-04-19 19:25:02.073 plugin-container[1969:10391] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 19:25:02 INFO - PID 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:02 INFO - PID 1968 | 2017-04-19 19:25:02.074 plugin-container[1969:10391] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 19:25:02 INFO - PID 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:25:02 INFO - PID 1968 | 2017-04-19 19:25:02.074 plugin-container[1969:10391] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:25:11 INFO - PID 1968 | RSS: Main: 236421120 19:25:11 INFO - PID 1968 | 19:28:15 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49344/tests/dromaeo/cssquery-ext.html) 19:28:17 INFO - PID 1968 | RSS: Main: 255885312 19:28:17 INFO - PID 1968 | 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 19:30:00 INFO - PID 1968 | 19:30:00 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:30:00 INFO - PID 1968 | Full stack: 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 19:30:00 INFO - PID 1968 | 19:30:00 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:30:00 INFO - PID 1968 | Full stack: 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 19:30:00 INFO - PID 1968 | 19:30:00 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:30:00 INFO - PID 1968 | Full stack: 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | ************************* 19:30:00 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 19:30:00 INFO - PID 1968 | 19:30:00 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:30:00 INFO - PID 1968 | Full stack: 19:30:00 INFO - PID 1968 | ************************* 19:31:19 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-ext.html (next: http://localhost:49344/tests/dromaeo/cssquery-jquery.html) 19:31:20 INFO - PID 1968 | RSS: Main: 260284416 19:31:20 INFO - PID 1968 | 19:34:21 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49344/tests/dromaeo/cssquery-mootools.html) 19:34:22 INFO - PID 1968 | RSS: Main: 269545472 19:34:22 INFO - PID 1968 | 19:37:24 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49344/tests/dromaeo/cssquery-prototype.html) 19:37:24 INFO - PID 1968 | RSS: Main: 263028736 19:37:24 INFO - PID 1968 | 19:40:27 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49344/tests/dromaeo/cssquery-yui.html) 19:40:28 INFO - PID 1968 | RSS: Main: 272728064 19:40:28 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49344/tests/dromaeo/cssquery-yui.html (next: http://localhost:49344/tests/dromaeo/cssquery-dojo.html) 19:43:30 INFO - PID 1968 | RSS: Main: 267366400 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | __start_tp_report 19:43:30 INFO - PID 1968 | _x_x_mozilla_page_load 19:43:30 INFO - PID 1968 | _x_x_mozilla_page_load_details 19:43:30 INFO - PID 1968 | |i|pagename|runs| 19:43:30 INFO - PID 1968 | |0;dojo.html;2940.162053814663;3527.3298073366072;3553.9111522211956;3586.623404542523;3605.6574625410576;4630.444346678399;6028.125921741344;6176.876462470754;6219.844503887405;6221.657808820513;5438.972805135969;6111.834843226364;6131.621347939075;6192.597481163722;6226.159468471755;4395.538468460805;4936.555709986101;5017.19724844025;5369.382521010075;5384.91922621161;5374.247605335257;5415.079436495786;5460.808871689492;5476.069068258405;5486.177073438997;5209.348831396075;5304.071787437221;5429.348478182604;5447.536959358459;5474.124140137598;5312.548433383167;5331.946680533222;5334.786608535654;5371.838844834661;5439.728013599304;5327.041132596131;5364.570834333244;5374.6506477078865;5390.272313237702;5433.239346491494;5990.83178780138;6222.315545290015;6247.625142491465;6258.24901011877;6259.248890133168;6375.489960803125;6446.516511261627;6571.539992200548;6621.271660117383;6679.833004174886;6716.429103526206;6726.764563240263;6737.6968036438475;6746.831329216809;6752.729890804362;5927.347991720907;5947.464728174442;6152.230971128609;6295.370462953714;6308.526860485436;6553.344665533504;6643.933560664428;6797.626130562867;6901.137357830271;6935.583864968118;5386.407495175527;6297.307296197415;6438.356164383618;6452.290248072708;6570;5900.321463031721;6387.722455508917;6686.130802995676;6712.362325579063;6745.831354216086;6547.672616369163;6557.311482294386;6631.27056023837;6644.402003819583;6654.500912431587;6320.8419789504715;6418.454431373386;6544.70548825304;6660.400563949268;6664.133662623828;5326.97336513315;5333.946660533423;5348.277982472394;5360.276362691065;5385.38068122171;3986.681065514752;4756.143894099096;4764.094821983881;4765.0231702500905;4791.209450440639;6112.388761123941;6143.757528502065;6176.104464852571;6273.9372606273355;6299.1811064562235;6675.599464032077;6693.933060669428;6751.93248067513;6762.72949082041;6769.695363708645;6285.994240921431;6297.4332310091395;6301.149344838388;6303.905441418382;6305.243370795442;5771.94228057714;5955.255593050869;5955.821325360246;5964.1650168976375;5967.462928336384;6664.600123992479;6813.931860681329;6855.451563874978;6890.896636550356;6911.239763625897;6721.059051732664;6735.225449073223;6739.191297044386;6749.898751518829;6757.290484499057;6834.282400347892;6847.965760171366;6893.931060689329;6902;6935.549189302679;6378.712957916998;6421.743130274736;6521.380468855451;6564.212294524687;6601.240857301472;6645.1361323027695;6725.058491811248;6749.898751518829;6766.93233067663;6766.93233067663;6220.906686399617;6385.201849768779;6502.642354670538;6528.510361722985;6539.607623542603;5452.291202143696;6433.260175079926;6496;6506.73973041092;6516.73933042673;5338.572914166935;6270.122182894307;6358.809235722936;6363.1091647168505;6375.203099612549;6292.779752708633;6498.415142637185;6544.8363790905605;6547.508936829661;6548.214214294315;6231.096491008869;6296.496280297473;6304.306526282197;6348.428641422294;6361.14124593174 19:43:30 INFO - PID 1968 | |1;ext.html;721.2751185059014;724.5688815154982;824.4476200945368;1132.773445310938;1242.1180961517323;36334;37413.438798418014;37418;37435.06412339689;37568.43647345292;31691.841540792262;38054;38325.42511862324;38596.421053684215;38715.03212419684;7923.564203968779;8066.677332906676;8204.343652507785;8445.94425696788;8458.619362128718;7410.2219266977;8480.024797148315;8582.527960962145;8601.483910965331;8615.698450554231;8552.016518100405;8618.181272779077;8621.396502244845;8639.308855291561;8680.262177714902;6781.084553585301;8380.868582741343;8586.497362961456;8592.570371481432;8607.18231767981;8356.331493480568;8377.120402357787;8377.83244335116;8443.451175673561;8478.194571515696;36918.63081369179;36952.81523592392;36978;36988.44517332242;37125.25749484995;3642.3261696586214;3652.525171727685;3662.963370366289;3687.778733276012;3688.8340024698955;29941.700582994108;30096.84951575228;30292.54561181584;30351;30437.695623043706;3167.635721891989;3201.5837941067743;3206.7274281686086;3218.0667606394118;3233.094733474631;233828.83085584463;233994;274627.6268618664;290705;295004;40279.798601006805;46040.7697961508;47080.05839883183;47179;47405;48409;48916.26625600619;49142.01715965661;49168.26247606289;49211.50788492069;13758.862411375958;13806.516771912935;13926.651833704238;13969.441222350992;13985.930070349787;11376.260543064674;11407.144464165222;11408.372539510407;11410.429478526206;11439.771204575862;13364.19814811095;13373.732525349438;13392.66073392653;13433.261170635513;13553.186808791505;5796.478316951495;5801.332846722681;5808.912866307009;5860.560457965669;5894.67579283135;896.9819255145457;984.3601658921758;1005.8591797148405;1033.121846430543;1055.461714525582;21147.47131321729;22174.88912555427;24620.5075898481;30613.69386306153;31067.256909769156;1091.230682368928;1096.5580261955504;1110.6445937299986;1128.5260190719916;1136.6533207371665;12002.819957700642;12541.659182981006;12603.18079324841;12614.684632884067;12679.873201268054;300547;301961;302149;304222;304722;51923.48076519262;52074.739626302384;52132.17537386249;52435.73782131065;52736.47263527316;1323.153181963544;1434.870861622459;1464.967198125319;1494.9252537373088;1495.0581133885582;19431.902840485705;22704.43238918974;23685.763142368356;23943.16198933029;24051;36886.63113368832;37314.62685373111;37417.81291093636;37590.812045939594;37641;299963.5001825064;301472.4926375442;302552;302830;303569;32681.509777352883;35898;36498;36636;36815.63184368122;36159.63840361563;44407.77796110999;44648;45026.54973450355;45371.77314113409;30356.270865513623;30506.84746576253;30610;31459.213519662193;31667.52498712567;26049.479010420066;27568.862155689094;31047.68952310448;31198.688013120485;31206.843965780026;36799.816000919825;37433;37551.81224093862;37581;37586.81206593949;27137;30401;30960.916367927013;31336.686633133377;31559;22659.660105098767;24130.63804042976;24254.15110471125;24336.269911902673;24513.896874640326 19:43:30 INFO - PID 1968 | |2;jquery.html;422.2441829125865;422.4298517095209;431.52532214563985;443.8690586277048;445.944256967879;19128.33050843219;20612.072456739446;21451.034703438345;21460.356189314305;21523.784762152372;21850.453738656543;21950;22195.889020554914;22645.886770566165;22854.428639284026;6082.695865206744;6277.2467303923595;6279.9952007678785;6283.151774510428;6283.685815709219;5998.190244317027;6167.599106058092;6198.2252218472695;6232.937670623303;6233.096201050845;6118.204633397652;6151.415615516541;6171.228596425447;6172.814815555541;6220.066989951521;5984;6194.473469755031;6203.596766210205;6205.503559715212;6216;5353.866153346158;5505.476979686923;5548.833534993957;5561.110222364402;5574.358948720908;22612.88693556538;26743.063992760355;26977.73022269772;27373.863130684218;27699.723002769915;1911.9044047797554;2084.4997200671883;2222.14447437736;2307.63077907534;2312.352541288442;17682.469525914243;17699;17735.29058837645;17823.376181833704;18063.638727225512;2164.058634494;2165.6426689596196;2214.6124428225157;2218;2224.443889027743;132261;138904;150686;157682.99999999886;161110;12249.265044097205;12810.80783788244;12897.742045159044;12914.612561623166;12928.418221180069;16696.91651541759;16730.58173545671;16731.912425692535;16735.246913888903;16773.161341933097;8732.257758090633;8966.462012279284;9053.185213330831;9060.501672408082;9173.633054677872;6782.457403407716;8598.097199793932;8603.543456165105;8776.648934042694;8800.295976321879;7956.965594472682;8101.675932962733;8113.107558168715;8125.553094579736;8146.877796833052;2227.6658501224947;2230.14139556272;2232.3860938241787;2235.2511908510833;2384.9642255366184;834.870595057767;945.7493764152505;964.9421034737938;984.699666601679;1013.2451323763843;17823.643527129385;21645.35063948084;21756.56486870254;21764.802935838365;21951.780482194972;902.255639097747;952.5999080386255;962.8892677342055;996.3573495095623;1005.2510879394752;8743.300535957109;10674.679759607225;10891.67324980252;11093.889061109447;11206.719832004102;473127.71807048237;475102;481295;481982;486832;120983;124889;132558;132782.33608831893;133050;1133.4616057372682;1147.7819214349247;1179.280638810325;1184.1059999700344;1187.2164371514932;18636.34772782946;18920.810791891905;18978.52553686169;19167.90416047911;19334.903325483283;49858;53138;56672.43327566671;57428;57451.85096298134;73912.26087739269;75710;75838.62080689562;76124.61937690276;78156.2184378149;7437.479376443814;8149.755507334789;8187.385946053951;9152.176304132394;9340.019297973615;12362.876371236533;13239.80140297877;14247.28763561797;14561.563153105424;14717.484888028868;11903;11975.76048479043;12141;12305.200161989442;12355.93822030884;11533.769324613628;11677.532898683958;11679.240849344766;11680.532778689098;11946.104042196695;12300.753984920431;12503.312317822607;12526.248425094524;12618.305993170097;12676.542197647019;8856.11438856135;8946.68686595966;9097.454152750855;9179.632814687604;9418.858717119385;10093.940136285877;10184.745381365525;11947.984421324285;12217.328046957502;12289.87710122923 19:43:30 INFO - PID 1968 | |3;mootools.html;1385.473520062376;1423.508889433146;1439.0574173916089;1447.5440236325558;1457.4097490516342;9056.184943355105;11802.704932376695;11825;11862.703432414182;12207.877921220785;11785.587504437346;11902.7619447611;11995.98034167097;12026.759464810699;12090.455929483172;2290.8545727136434;2405.434722840131;2501.7373175816506;2546.528892154948;2552.5022620588993;2087.5094352827073;2423.53952748978;2513.861737604431;2518.7355327690602;2520.3699075231193;2440.6827112475353;2496.10140349474;2501.69979602448;2502.9374265643323;2517.5342561626157;2453.337598848319;2466.950660986788;2483.192962287255;2486.1422809130822;2513.3716570857287;2407.807375409963;2479.5536803375385;2485.465624890639;2487.2289590227088;2515.635232891239;11996.820047699292;12071.93964030183;12073.637790866289;12099.213551119237;12106.576269830513;6626.13860198176;6806.387425131712;6853.383195512378;6860.5197636165485;6867.931320686779;3649.6167902370134;3735.383661695817;4142.150859073913;4465.196264672358;4476.977615111904;1253.8808813162825;1256.4785613970191;1283.9807402888964;1296.002078399627;1298.2664794391233;14004.509842155578;16189.109598972169;16763.748543771853;16785.748213776802;16856.74714879278;5666.801661941812;5727.198192253088;5800.477956983807;5886.735096920564;5907.793227237026;12408.56570020045;12485.625431237077;12495.375231238402;12524.185927914656;12549.498020079278;6600.2409722882485;6647.401733843881;6654.567453115629;6671.299513551105;6675.833104172434;5946.197263369476;6154.076888466676;6204.069389591597;6206.689665516797;6222.502199824004;4275.700700950903;4452.643788496913;4496.955030449653;4500.144972455223;4525.321201819754;1308.2804457548311;1319.030512573258;1329.0630105775406;1334.4928927007675;1342.3087110138288;765.5598031132122;770.4144849914105;791.1574173505198;802.4703695560902;804.9235322644456;6673.432758215606;7025.417037311008;7029.402500787388;7100.2899710029615;7116.92883071173;892.8392889279862;915.3821170709745;919.5769945824861;921.1111277617132;930.3812964378612;4172.332426811757;4172.91654166921;4358.760268185217;4372.256716358227;4558;12346.444410001572;15238.619034524225;15476.922615386851;15478.690426191413;15480.612984675474;13774.724505509834;15278.38886444552;15326.693466130839;15351.616209594626;15367.538973830802;7339.412846972229;8537.487750734976;8758.255548278468;8784.297256219486;8806.691765788166;6236.781712640036;6924.6537673117155;7031.085958825524;7077.929220707727;7210.278972102958;12654.367281636065;12899.93550032244;12943.935280323914;13107.934460327637;13164.934175329445;12904.870951290366;13069.165125022213;13221.206727596375;13325.267110309027;13412.530561430303;9596.856047159159;9719.125278724949;9873;9876.950615246878;9891.307608467627;10834.837477438003;10835.970582794622;10857.402842843403;10939.617113401311;10953.068989136013;9170.082991701043;9283.675071372469;9310.581023854078;9372.250219982521;9378.155965963097;8966.596503157503;9095.953965294077;9151.679691210775;9157.633694652406;9278.675246366345;8175.264226219669;8207.71273005442;8311.25198732117;8312.293455056146;8319.833603328021;5590.664560126405;6083.452489275986;6124.724387402666;6219.502439804714;6226.470749986302;4545.954540454553;5742.368339482737;6006.708557660124;6155.35368786271;6250.124982502362 19:43:30 INFO - PID 1968 | |4;prototype.html;388.34951456310677;406.03971607149083;409.34012578992196;410.1468944595242;421.0463300624087;5337.89324213516;5500.42245564216;6386.64873431961;6414.647194404311;6424.61452312861;6000.75996960121;6095.817125486243;6192.225971753531;6252.812415627538;6280.874382512358;4718.9292160617615;4740.739259340735;4745.359376484183;4750.619950403968;4760.714357138583;4641.698289611181;4757.976210118944;4767.880802979918;4778.187708089633;4796;4691.788869500863;4692.343071969927;4719.882002949919;4723.527647235266;4746.620270378361;4096.344584866422;4489.910201795962;4711.104890070876;4721.811127554894;4726.4328280606205;4182.351735481006;4205.684573656988;4209.494860616715;4209.5790420957965;4233.555476674936;4849.757512124415;5283.815066472694;6048.429417497546;6125.418085281891;6130.754769809202;4756.381670382828;4986.800527978877;5116.746397132689;5646;5649.661020338793;6319.5260355473065;6488.545801793876;6776.627285499296;6791.524593278473;6792.252852186256;4486.7083639563325;4490.708103973264;4502.009557897258;4508.143452744001;4518.796654150571;5782.392848750863;6868.793936181923;7035.432067295452;7151.177614574286;7200.495965282433;3629.564452265692;4351.282038463682;4483.215437298525;4539.341795439643;4544.227481328182;4057.6753859691153;4060.837566497307;4607.493175750665;4616.446026476844;4632.72203667781;5178.663386879841;5389.892202155935;5453.400125986138;5476.835694929158;5488.670679759227;5471.4831177657925;6274.592151510137;6680.565763225472;6699.43054840344;6740.561863478858;1455.2869094143794;1516.7194069097252;1548.3806477409125;1580.9960674971246;1596.361455417842;979.8677178580942;1000.1298869983161;1038.0916697889347;1056.234230183111;1062.5749700120014;5269.762860671279;5288.492779557808;5510.311211098613;6292.905606415908;6303.3066362700065;5716.342620598602;5826.009183709088;6936.7572134975035;6942.757003504853;6960.79117626472;5258.790478190038;6216.875662486725;6275.121482992385;6297.842553936097;6307.905381419282;3066.831324277186;3438.3639026780124;3625.746197766131;3630.074331045619;3633.6729694327637;5748.885022299531;6234.688265586702;6837.726490940406;7105.431565474853;7172.21105678375;7015.298470153046;7085.89371159433;7089.503734738519;7106.253843346478;7142.500024998304;6378.143495742096;6669.4997875160525;7145.571265724073;7151.392131668762;7214.603196824225;6198.411150940653;6336.366363363627;6998.930010699828;7002.684879180551;7066.505344626033;6132.63204207749;6333.588316759396;6872.140982377203;6908.965455172692;6954.47841411886;6248.781292654735;6748.6963086660235;6975.895361569682;7179.820504487429;7205.675744591611;3746.5129533161603;4513.1650644630845;4549.886252843706;4550.0899820035465;4563.361129441947;5628.493435590816;6146.907796383147;6427.710753016032;6853.760118396031;6951.7914462566205;6726.730930762715;6737.730490780314;6739.123913891162;6743.258241593323;6745.730170793309;5015.548600625962;5977.970110149421;6533.509986750918;6626.337366263335;6722.9663851680425;6044.576879618385;6579.302485980725;6591.176102987127;6592.077109204811;6602.966985165043;5322.494363035506;6300.716467759054;6737.326267373223;6751;6758.391744742997;6509.479241660751;6553.180852393451;6563.409293163638;6570;6607 19:43:30 INFO - PID 1968 | |5;yui.html;767.8848172774084;820.5733018830213;830.6760363458252;855.8758979947905;856.8072183758655;16055;16413.097279649628;16436.506904792845;17825.465236042906;18513.90743046283;17014.48956531306;17083.974961502317;17273;17369.73945390817;17816.752827302094;710.158462222267;725.6734469488724;725.9128904531464;727.8362368467106;728.5483000539647;945.7541039329755;951.4624237305935;952.2144231009411;955.4267439536258;956.3783540698566;996.8006398720248;1006.2805094357533;1006.5168719014878;1007.2043085962081;1011.1506334678868;993.4039576254262;1003.5433877585681;1004.221728160674;1005.0753306957616;1010.0808264479289;626.6208943589154;740.8481261341412;743.7396911081132;746.06369006896;747.9902132121647;16057.759133613004;16468;16676.499705008868;16678.749818752727;16692.83307166937;16344.18279086041;16570.171491425503;16785.07682077485;16854.325826966906;17092.290770922933;13555.932220338835;13805.861941380557;13897.652558686113;13903.09629874055;13934.163950163023;2961.970380296191;3087.7529797616135;3445.207602251496;3499.142710036032;3502.247016891355;98085;103181.42046448824;115646.84353156445;116023.83976160215;118115.81884181134;12650.936745316398;12773.936130319475;12968.546100886424;13021.674458138623;13059.608211753663;24716.2585122443;24883.004679812966;24896.751032489807;24969;25090.99636014539;6600.372964568358;7392.223816499298;7495.587742674096;7497.400207983457;7497.775066748006;3828.0812604974603;3856.73002889795;3899.3371126907928;3939.369700847908;3941.5467221269346;4283.850065247701;4333.133373325348;4374.343848422762;4376.321670141133;4382.824687012484;781.1563511407666;926.2173463423396;967.1005964453126;977.779999500121;979.1187930862138;545.4381986553856;652.9281779004306;653.2096163642046;661.4675186474934;680.873154928594;10315.329503582394;11003.954624310678;11607.883921160848;11648;11863.11026673003;627.6014730645982;644.7614382678439;645.5384400153913;653.1150291355241;672.5829985409077;4898.853034408973;5378.300820893259;5533.418991005967;5536.169574563848;5585.636933599303;87963;90174.54912725526;90811;90879.54560227157;100928.49535752274;66783;83092;84227;85750.14249857422;86796;57539.71230143906;76068.85896711554;76213.6189319061;76507.85238221432;77578;10610.681679549625;11652.41737913084;12411.875881241072;12417.937910310391;12430.37848107573;37335;37590.62409375871;38014.80992595019;38685.64600238978;39775.60224397835;53932.460675394315;63221.206727596495;63277.41806454876;63920.680396597716;65622.67188664027;15883.725928258504;16036.839631603534;16120.27458764335;16359.18204089767;16429.34282628729;17859.28562857523;18042.2783088675;18231.45305640833;18316.633667326845;18351.724724129417;15281.235938203268;15536.844631553991;16269.837301627305;16929.91535042317;17187.31250749956;16391.45932380483;16527.421540246032;16901.830981690517;16922.576935576708;17108;16100.838991609933;16310.918445407697;16552.66894662124;16577.41979030728;16604.58488537796;11744.236624619714;11853.466594003117;11857.051435884936;11926.344051077274;12125.939370303093;12063.21589096706;12853.742925141258;13361.550766540468;13454;13867.583972480841 19:43:30 INFO - PID 1968 | __end_tp_report 19:43:30 INFO - PID 1968 | __start_cc_report 19:43:30 INFO - PID 1968 | _x_x_mozilla_cycle_collect,425 19:43:30 INFO - PID 1968 | __end_cc_report 19:43:30 INFO - PID 1968 | __startTimestamp1492656210277__endTimestamp 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | ------- Summary: start ------- 19:43:30 INFO - PID 1968 | Number of tests: 6 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#0] dojo.html Cycles:165 Average:6077.15 Median:6303.91 stddev:765.19 (12.1%) stddev-sans-first:726.89 19:43:30 INFO - PID 1968 | Values: 2940.2 3527.3 3553.9 3586.6 3605.7 4630.4 6028.1 6176.9 6219.8 6221.7 5439.0 6111.8 6131.6 6192.6 6226.2 4395.5 4936.6 5017.2 5369.4 5384.9 5374.2 5415.1 5460.8 5476.1 5486.2 5209.3 5304.1 5429.3 5447.5 5474.1 5312.5 5331.9 5334.8 5371.8 5439.7 5327.0 5364.6 5374.7 5390.3 5433.2 5990.8 6222.3 6247.6 6258.2 6259.2 6375.5 6446.5 6571.5 6621.3 6679.8 6716.4 6726.8 6737.7 6746.8 6752.7 5927.3 5947.5 6152.2 6295.4 6308.5 6553.3 6643.9 6797.6 6901.1 6935.6 5386.4 6297.3 6438.4 6452.3 6570.0 5900.3 6387.7 6686.1 6712.4 6745.8 6547.7 6557.3 6631.3 6644.4 6654.5 6320.8 6418.5 6544.7 6660.4 6664.1 5327.0 5333.9 5348.3 5360.3 5385.4 3986.7 4756.1 4764.1 4765.0 4791.2 6112.4 6143.8 6176.1 6273.9 6299.2 6675.6 6693.9 6751.9 6762.7 6769.7 6286.0 6297.4 6301.1 6303.9 6305.2 5771.9 5955.3 5955.8 5964.2 5967.5 6664.6 6813.9 6855.5 6890.9 6911.2 6721.1 6735.2 6739.2 6749.9 6757.3 6834.3 6848.0 6893.9 6902.0 6935.5 6378.7 6421.7 6521.4 6564.2 6601.2 6645.1 6725.1 6749.9 6766.9 6766.9 6220.9 6385.2 6502.6 6528.5 6539.6 5452.3 6433.3 6496.0 6506.7 6516.7 5338.6 6270.1 6358.8 6363.1 6375.2 6292.8 6498.4 6544.8 6547.5 6548.2 6231.1 6296.5 6304.3 6348.4 6361.1 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#1] ext.html Cycles:180 Average:44050.64 Median:17957.30 stddev:76247.36 (424.6%) stddev-sans-first:76391.85 19:43:30 INFO - PID 1968 | Values: 721.3 724.6 824.4 1132.8 1242.1 36334.0 37413.4 37418.0 37435.1 37568.4 31691.8 38054.0 38325.4 38596.4 38715.0 7923.6 8066.7 8204.3 8445.9 8458.6 7410.2 8480.0 8582.5 8601.5 8615.7 8552.0 8618.2 8621.4 8639.3 8680.3 6781.1 8380.9 8586.5 8592.6 8607.2 8356.3 8377.1 8377.8 8443.5 8478.2 36918.6 36952.8 36978.0 36988.4 37125.3 3642.3 3652.5 3663.0 3687.8 3688.8 29941.7 30096.8 30292.5 30351.0 30437.7 3167.6 3201.6 3206.7 3218.1 3233.1 233828.8 233994.0 274627.6 290705.0 295004.0 40279.8 46040.8 47080.1 47179.0 47405.0 48409.0 48916.3 49142.0 49168.3 49211.5 13758.9 13806.5 13926.7 13969.4 13985.9 11376.3 11407.1 11408.4 11410.4 11439.8 13364.2 13373.7 13392.7 13433.3 13553.2 5796.5 5801.3 5808.9 5860.6 5894.7 897.0 984.4 1005.9 1033.1 1055.5 21147.5 22174.9 24620.5 30613.7 31067.3 1091.2 1096.6 1110.6 1128.5 1136.7 12002.8 12541.7 12603.2 12614.7 12679.9 300547.0 301961.0 302149.0 304222.0 304722.0 51923.5 52074.7 52132.2 52435.7 52736.5 1323.2 1434.9 1465.0 1494.9 1495.1 19431.9 22704.4 23685.8 23943.2 24051.0 36886.6 37314.6 37417.8 37590.8 37641.0 299963.5 301472.5 302552.0 302830.0 303569.0 32681.5 35898.0 36498.0 36636.0 36815.6 36159.6 44407.8 44648.0 45026.5 45371.8 30356.3 30506.8 30610.0 31459.2 31667.5 26049.5 27568.9 31047.7 31198.7 31206.8 36799.8 37433.0 37551.8 37581.0 37586.8 27137.0 30401.0 30960.9 31336.7 31559.0 22659.7 24130.6 24254.2 24336.3 24513.9 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#2] jquery.html Cycles:180 Average:33322.42 Median:12424.07 stddev:82260.98 (662.1%) stddev-sans-first:82454.66 19:43:30 INFO - PID 1968 | Values: 422.2 422.4 431.5 443.9 445.9 19128.3 20612.1 21451.0 21460.4 21523.8 21850.5 21950.0 22195.9 22645.9 22854.4 6082.7 6277.2 6280.0 6283.2 6283.7 5998.2 6167.6 6198.2 6232.9 6233.1 6118.2 6151.4 6171.2 6172.8 6220.1 5984.0 6194.5 6203.6 6205.5 6216.0 5353.9 5505.5 5548.8 5561.1 5574.4 22612.9 26743.1 26977.7 27373.9 27699.7 1911.9 2084.5 2222.1 2307.6 2312.4 17682.5 17699.0 17735.3 17823.4 18063.6 2164.1 2165.6 2214.6 2218.0 2224.4 132261.0 138904.0 150686.0 157683.0 161110.0 12249.3 12810.8 12897.7 12914.6 12928.4 16696.9 16730.6 16731.9 16735.2 16773.2 8732.3 8966.5 9053.2 9060.5 9173.6 6782.5 8598.1 8603.5 8776.6 8800.3 7957.0 8101.7 8113.1 8125.6 8146.9 2227.7 2230.1 2232.4 2235.3 2385.0 834.9 945.7 964.9 984.7 1013.2 17823.6 21645.4 21756.6 21764.8 21951.8 902.3 952.6 962.9 996.4 1005.3 8743.3 10674.7 10891.7 11093.9 11206.7 473127.7 475102.0 481295.0 481982.0 486832.0 120983.0 124889.0 132558.0 132782.3 133050.0 1133.5 1147.8 1179.3 1184.1 1187.2 18636.3 18920.8 18978.5 19167.9 19334.9 49858.0 53138.0 56672.4 57428.0 57451.9 73912.3 75710.0 75838.6 76124.6 78156.2 7437.5 8149.8 8187.4 9152.2 9340.0 12362.9 13239.8 14247.3 14561.6 14717.5 11903.0 11975.8 12141.0 12305.2 12355.9 11533.8 11677.5 11679.2 11680.5 11946.1 12300.8 12503.3 12526.2 12618.3 12676.5 8856.1 8946.7 9097.5 9179.6 9418.9 10093.9 10184.7 11948.0 12217.3 12289.9 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#3] mootools.html Cycles:180 Average:7160.48 Median:3938.77 stddev:4497.21 (114.2%) stddev-sans-first:4488.89 19:43:30 INFO - PID 1968 | Values: 1385.5 1423.5 1439.1 1447.5 1457.4 9056.2 11802.7 11825.0 11862.7 12207.9 11785.6 11902.8 11996.0 12026.8 12090.5 2290.9 2405.4 2501.7 2546.5 2552.5 2087.5 2423.5 2513.9 2518.7 2520.4 2440.7 2496.1 2501.7 2502.9 2517.5 2453.3 2467.0 2483.2 2486.1 2513.4 2407.8 2479.6 2485.5 2487.2 2515.6 11996.8 12071.9 12073.6 12099.2 12106.6 6626.1 6806.4 6853.4 6860.5 6867.9 3649.6 3735.4 4142.2 4465.2 4477.0 1253.9 1256.5 1284.0 1296.0 1298.3 14004.5 16189.1 16763.7 16785.7 16856.7 5666.8 5727.2 5800.5 5886.7 5907.8 12408.6 12485.6 12495.4 12524.2 12549.5 6600.2 6647.4 6654.6 6671.3 6675.8 5946.2 6154.1 6204.1 6206.7 6222.5 4275.7 4452.6 4497.0 4500.1 4525.3 1308.3 1319.0 1329.1 1334.5 1342.3 765.6 770.4 791.2 802.5 804.9 6673.4 7025.4 7029.4 7100.3 7116.9 892.8 915.4 919.6 921.1 930.4 4172.3 4172.9 4358.8 4372.3 4558.0 12346.4 15238.6 15476.9 15478.7 15480.6 13774.7 15278.4 15326.7 15351.6 15367.5 7339.4 8537.5 8758.3 8784.3 8806.7 6236.8 6924.7 7031.1 7077.9 7210.3 12654.4 12899.9 12943.9 13107.9 13164.9 12904.9 13069.2 13221.2 13325.3 13412.5 9596.9 9719.1 9873.0 9877.0 9891.3 10834.8 10836.0 10857.4 10939.6 10953.1 9170.1 9283.7 9310.6 9372.3 9378.2 8966.6 9096.0 9151.7 9157.6 9278.7 8175.3 8207.7 8311.3 8312.3 8319.8 5590.7 6083.5 6124.7 6219.5 6226.5 4546.0 5742.4 6006.7 6155.4 6250.1 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#4] prototype.html Cycles:180 Average:5366.12 Median:5989.37 stddev:1674.76 (28.0%) stddev-sans-first:1637.25 19:43:30 INFO - PID 1968 | Values: 388.3 406.0 409.3 410.1 421.0 5337.9 5500.4 6386.6 6414.6 6424.6 6000.8 6095.8 6192.2 6252.8 6280.9 4718.9 4740.7 4745.4 4750.6 4760.7 4641.7 4758.0 4767.9 4778.2 4796.0 4691.8 4692.3 4719.9 4723.5 4746.6 4096.3 4489.9 4711.1 4721.8 4726.4 4182.4 4205.7 4209.5 4209.6 4233.6 4849.8 5283.8 6048.4 6125.4 6130.8 4756.4 4986.8 5116.7 5646.0 5649.7 6319.5 6488.5 6776.6 6791.5 6792.3 4486.7 4490.7 4502.0 4508.1 4518.8 5782.4 6868.8 7035.4 7151.2 7200.5 3629.6 4351.3 4483.2 4539.3 4544.2 4057.7 4060.8 4607.5 4616.4 4632.7 5178.7 5389.9 5453.4 5476.8 5488.7 5471.5 6274.6 6680.6 6699.4 6740.6 1455.3 1516.7 1548.4 1581.0 1596.4 979.9 1000.1 1038.1 1056.2 1062.6 5269.8 5288.5 5510.3 6292.9 6303.3 5716.3 5826.0 6936.8 6942.8 6960.8 5258.8 6216.9 6275.1 6297.8 6307.9 3066.8 3438.4 3625.7 3630.1 3633.7 5748.9 6234.7 6837.7 7105.4 7172.2 7015.3 7085.9 7089.5 7106.3 7142.5 6378.1 6669.5 7145.6 7151.4 7214.6 6198.4 6336.4 6998.9 7002.7 7066.5 6132.6 6333.6 6872.1 6909.0 6954.5 6248.8 6748.7 6975.9 7179.8 7205.7 3746.5 4513.2 4549.9 4550.1 4563.4 5628.5 6146.9 6427.7 6853.8 6951.8 6726.7 6737.7 6739.1 6743.3 6745.7 5015.5 5978.0 6533.5 6626.3 6723.0 6044.6 6579.3 6591.2 6592.1 6603.0 5322.5 6300.7 6737.3 6751.0 6758.4 6509.5 6553.2 6563.4 6570.0 6607.0 19:43:30 INFO - PID 1968 | 19:43:30 INFO - PID 1968 | [#5] yui.html Cycles:180 Average:20545.28 Median:24932.88 stddev:27525.98 (110.4%) stddev-sans-first:27563.13 19:43:30 INFO - PID 1968 | Values: 767.9 820.6 830.7 855.9 856.8 16055.0 16413.1 16436.5 17825.5 18513.9 17014.5 17084.0 17273.0 17369.7 17816.8 710.2 725.7 725.9 727.8 728.5 945.8 951.5 952.2 955.4 956.4 996.8 1006.3 1006.5 1007.2 1011.2 993.4 1003.5 1004.2 1005.1 1010.1 626.6 740.8 743.7 746.1 748.0 16057.8 16468.0 16676.5 16678.7 16692.8 16344.2 16570.2 16785.1 16854.3 17092.3 13555.9 13805.9 13897.7 13903.1 13934.2 2962.0 3087.8 3445.2 3499.1 3502.2 98085.0 103181.4 115646.8 116023.8 118115.8 12650.9 12773.9 12968.5 13021.7 13059.6 24716.3 24883.0 24896.8 24969.0 25091.0 6600.4 7392.2 7495.6 7497.4 7497.8 3828.1 3856.7 3899.3 3939.4 3941.5 4283.9 4333.1 4374.3 4376.3 4382.8 781.2 926.2 967.1 977.8 979.1 545.4 652.9 653.2 661.5 680.9 10315.3 11004.0 11607.9 11648.0 11863.1 627.6 644.8 645.5 653.1 672.6 4898.9 5378.3 5533.4 5536.2 5585.6 87963.0 90174.5 90811.0 90879.5 100928.5 66783.0 83092.0 84227.0 85750.1 86796.0 57539.7 76068.9 76213.6 76507.9 77578.0 10610.7 11652.4 12411.9 12417.9 12430.4 37335.0 37590.6 38014.8 38685.6 39775.6 53932.5 63221.2 63277.4 63920.7 65622.7 15883.7 16036.8 16120.3 16359.2 16429.3 17859.3 18042.3 18231.5 18316.6 18351.7 15281.2 15536.8 16269.8 16929.9 17187.3 16391.5 16527.4 16901.8 16922.6 17108.0 16100.8 16310.9 16552.7 16577.4 16604.6 11744.2 11853.5 11857.1 11926.3 12125.9 12063.2 12853.7 13361.6 13454.0 13867.6 19:43:30 INFO - PID 1968 | -------- Summary: end -------- 19:43:30 INFO - PID 1968 | 19:43:30 INFO - TEST-INFO | 1968: exit 0 19:43:30 INFO - TEST-OK | dromaeo_css | took 1115070ms 19:43:30 INFO - TEST-START | kraken 19:43:30 INFO - operating with platform_type : mac_ 19:43:30 INFO - Initialising browser for kraken test... 19:43:30 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmpXb6o9l/profile http://localhost:49344/getInfo.html) 19:43:34 INFO - PID 1975 | 2017-04-19 19:43:34.021 plugin-container[1976:12468] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 19:43:34 INFO - PID 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:43:34 INFO - PID 1975 | 2017-04-19 19:43:34.023 plugin-container[1976:12468] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 19:43:34 INFO - PID 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:43:34 INFO - PID 1975 | 2017-04-19 19:43:34.023 plugin-container[1976:12468] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:43:34 INFO - PID 1975 | __metrics Screen width/height:1600/1200 19:43:34 INFO - PID 1975 | colorDepth:24 19:43:34 INFO - PID 1975 | Browser inner width/height: 1024/689 19:43:34 INFO - PID 1975 | __metrics 19:43:34 ERROR - PID 1975 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 19:43:35 INFO - TEST-INFO | 1975: exit 0 19:43:35 INFO - Browser initialized. 19:43:35 INFO - Running cycle 1/1 for kraken test... 19:43:35 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/T/tmpXb6o9l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:37 INFO - PID 1977 | 2017-04-19 19:43:37.541 plugin-container[1978:12589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 19:43:37 INFO - PID 1977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:43:37 INFO - PID 1977 | 2017-04-19 19:43:37.542 plugin-container[1978:12589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 19:43:37 INFO - PID 1977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:43:37 INFO - PID 1977 | 2017-04-19 19:43:37.542 plugin-container[1978:12589] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:43:47 INFO - PID 1977 | RSS: Main: 235577344 19:43:47 INFO - PID 1977 | 19:43:50 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49344/tests/kraken/driver.html?testName=audio-beat-detection) 19:43:51 INFO - PID 1977 | RSS: Main: 248745984 19:43:51 INFO - PID 1977 | 19:43:53 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49344/tests/kraken/driver.html?testName=audio-dft) 19:43:54 INFO - PID 1977 | RSS: Main: 257200128 19:43:54 INFO - PID 1977 | 19:43:57 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49344/tests/kraken/driver.html?testName=audio-fft) 19:43:58 INFO - PID 1977 | RSS: Main: 259903488 19:43:58 INFO - PID 1977 | 19:44:00 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49344/tests/kraken/driver.html?testName=audio-oscillator) 19:44:01 INFO - PID 1977 | RSS: Main: 260788224 19:44:01 INFO - PID 1977 | 19:44:02 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:03 INFO - PID 1977 | RSS: Main: 262602752 19:44:03 INFO - PID 1977 | 19:44:06 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49344/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:07 INFO - PID 1977 | RSS: Main: 268009472 19:44:07 INFO - PID 1977 | 19:44:10 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49344/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:10 INFO - PID 1977 | RSS: Main: 269172736 19:44:10 INFO - PID 1977 | 19:44:13 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49344/tests/kraken/driver.html?testName=json-parse-financial) 19:44:14 INFO - PID 1977 | RSS: Main: 269193216 19:44:14 INFO - PID 1977 | 19:44:15 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:16 INFO - PID 1977 | RSS: Main: 268709888 19:44:16 INFO - PID 1977 | 19:44:18 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:19 INFO - PID 1977 | RSS: Main: 268869632 19:44:19 INFO - PID 1977 | 19:44:21 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:21 INFO - PID 1977 | RSS: Main: 268439552 19:44:21 INFO - PID 1977 | 19:44:24 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:25 INFO - PID 1977 | RSS: Main: 268730368 19:44:25 INFO - PID 1977 | 19:44:28 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:29 INFO - PID 1977 | RSS: Main: 269049856 19:44:29 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | Cycle 1(1): loaded http://localhost:49344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49344/tests/kraken/driver.html?testName=ai-astar) 19:44:31 INFO - PID 1977 | RSS: Main: 270852096 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | __start_tp_report 19:44:31 INFO - PID 1977 | _x_x_mozilla_page_load 19:44:31 INFO - PID 1977 | _x_x_mozilla_page_load_details 19:44:31 INFO - PID 1977 | |i|pagename|runs| 19:44:31 INFO - PID 1977 | |0;ai-astar;104;115;118;107;137;166;167;115;116;118 19:44:31 INFO - PID 1977 | |1;audio-beat-detection;129;119;147;183;105;148;145;112;143;109 19:44:31 INFO - PID 1977 | |2;audio-dft;194;202;207;210;213;205;251;249;201;195 19:44:31 INFO - PID 1977 | |3;audio-fft;79;59;59;106;85;89;51;76;98;85 19:44:31 INFO - PID 1977 | |4;audio-oscillator;90;69;85;72;72;71;94;69;69;89 19:44:31 INFO - PID 1977 | |5;imaging-gaussian-blur;89;89;89;88;91;88;100;136;90;89 19:44:31 INFO - PID 1977 | |6;imaging-darkroom;97;97;96;104;97;96;100;96;96;114 19:44:31 INFO - PID 1977 | |7;imaging-desaturate;90;94;90;92;140;130;96;92;92;92 19:44:31 INFO - PID 1977 | |8;json-parse-financial;50;50;49;51;50;52;51;52;50;51 19:44:31 INFO - PID 1977 | |9;json-stringify-tinderbox;60;81;96;57;76;89;81;79;57;58 19:44:31 INFO - PID 1977 | |10;stanford-crypto-aes;86;82;83;83;84;84;82;85;86;84 19:44:31 INFO - PID 1977 | |11;stanford-crypto-ccm;147;155;138;145;154;151;149;151;199;167 19:44:31 INFO - PID 1977 | |12;stanford-crypto-pbkdf2;186;190;186;182;195;226;235;185;187;187 19:44:31 INFO - PID 1977 | |13;stanford-crypto-sha256-iterative;68;69;71;68;68;70;67;69;68;67 19:44:31 INFO - PID 1977 | __end_tp_report 19:44:31 INFO - PID 1977 | __start_cc_report 19:44:31 INFO - PID 1977 | _x_x_mozilla_cycle_collect,1009 19:44:31 INFO - PID 1977 | __end_cc_report 19:44:31 INFO - PID 1977 | __startTimestamp1492656271430__endTimestamp 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | ------- Summary: start ------- 19:44:31 INFO - PID 1977 | Number of tests: 14 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#0] ai-astar Cycles:10 Average:126.30 Median:118.00 stddev:22.89 (19.4%) stddev-sans-first:22.81 19:44:31 INFO - PID 1977 | Values: 104.0 115.0 118.0 107.0 137.0 166.0 167.0 115.0 116.0 118.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:144.00 stddev:23.96 (16.6%) stddev-sans-first:25.35 19:44:31 INFO - PID 1977 | Values: 129.0 119.0 147.0 183.0 105.0 148.0 145.0 112.0 143.0 109.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#2] audio-dft Cycles:10 Average:212.70 Median:208.50 stddev:20.54 (9.9%) stddev-sans-first:20.64 19:44:31 INFO - PID 1977 | Values: 194.0 202.0 207.0 210.0 213.0 205.0 251.0 249.0 201.0 195.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#3] audio-fft Cycles:10 Average:78.70 Median:82.00 stddev:17.81 (21.7%) stddev-sans-first:18.89 19:44:31 INFO - PID 1977 | Values: 79.0 59.0 59.0 106.0 85.0 89.0 51.0 76.0 98.0 85.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.50 stddev:10.19 (13.0%) stddev-sans-first:9.84 19:44:31 INFO - PID 1977 | Values: 90.0 69.0 85.0 72.0 72.0 71.0 94.0 69.0 69.0 89.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:89.00 stddev:14.87 (16.7%) stddev-sans-first:15.61 19:44:31 INFO - PID 1977 | Values: 89.0 89.0 89.0 88.0 91.0 88.0 100.0 136.0 90.0 89.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:96.00 stddev:5.76 (6.0%) stddev-sans-first:6.04 19:44:31 INFO - PID 1977 | Values: 97.0 97.0 96.0 104.0 97.0 96.0 100.0 96.0 96.0 114.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#7] imaging-desaturate Cycles:10 Average:100.80 Median:92.00 stddev:18.26 (19.9%) stddev-sans-first:18.95 19:44:31 INFO - PID 1977 | Values: 90.0 94.0 90.0 92.0 140.0 130.0 96.0 92.0 92.0 92.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.00 19:44:31 INFO - PID 1977 | Values: 50.0 50.0 49.0 51.0 50.0 52.0 51.0 52.0 50.0 51.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:80.00 stddev:14.39 (18.0%) stddev-sans-first:14.42 19:44:31 INFO - PID 1977 | Values: 60.0 81.0 96.0 57.0 76.0 89.0 81.0 79.0 57.0 58.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.32 19:44:31 INFO - PID 1977 | Values: 86.0 82.0 83.0 83.0 84.0 84.0 82.0 85.0 86.0 84.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:152.50 stddev:16.99 (11.1%) stddev-sans-first:17.73 19:44:31 INFO - PID 1977 | Values: 147.0 155.0 138.0 145.0 154.0 151.0 149.0 151.0 199.0 167.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:188.50 stddev:18.67 (9.9%) stddev-sans-first:19.46 19:44:31 INFO - PID 1977 | Values: 186.0 190.0 186.0 182.0 195.0 226.0 235.0 185.0 187.0 187.0 19:44:31 INFO - PID 1977 | 19:44:31 INFO - PID 1977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 19:44:31 INFO - PID 1977 | Values: 68.0 69.0 71.0 68.0 68.0 70.0 67.0 69.0 68.0 67.0 19:44:31 INFO - PID 1977 | -------- Summary: end -------- 19:44:31 INFO - PID 1977 | 19:44:32 INFO - TEST-INFO | 1977: exit 0 19:44:32 INFO - TEST-OK | kraken | took 61552ms 19:44:32 INFO - SUITE-END | took 1176s 19:44:32 INFO - Completed test suite (00:19:36) 19:44:32 INFO - javascript benchmark 19:44:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7832.29885563238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2940.162053814663, 3527.3298073366072, 3553.9111522211956, 3586.623404542523, 3605.6574625410576, 4630.444346678399, 6028.125921741344, 6176.876462470754, 6219.844503887405, 6221.657808820513, 5438.972805135969, 6111.834843226364, 6131.621347939075, 6192.597481163722, 6226.159468471755, 4395.538468460805, 4936.555709986101, 5017.19724844025, 5369.382521010075, 5384.91922621161, 5374.247605335257, 5415.079436495786, 5460.808871689492, 5476.069068258405, 5486.177073438997, 5209.348831396075, 5304.071787437221, 5429.348478182604, 5447.536959358459, 5474.124140137598, 5312.548433383167, 5331.946680533222, 5334.786608535654, 5371.838844834661, 5439.728013599304, 5327.041132596131, 5364.570834333244, 5374.6506477078865, 5390.272313237702, 5433.239346491494, 5990.83178780138, 6222.315545290015, 6247.625142491465, 6258.24901011877, 6259.248890133168, 6375.489960803125, 6446.516511261627, 6571.539992200548, 6621.271660117383, 6679.833004174886, 6716.429103526206, 6726.764563240263, 6737.6968036438475, 6746.831329216809, 6752.729890804362, 5927.347991720907, 5947.464728174442, 6152.230971128609, 6295.370462953714, 6308.526860485436, 6553.344665533504, 6643.933560664428, 6797.626130562867, 6901.137357830271, 6935.583864968118, 5386.407495175527, 6297.307296197415, 6438.356164383618, 6452.290248072708, 6570.0, 5900.321463031721, 6387.722455508917, 6686.130802995676, 6712.362325579063, 6745.831354216086, 6547.672616369163, 6557.311482294386, 6631.27056023837, 6644.402003819583, 6654.500912431587, 6320.8419789504715, 6418.454431373386, 6544.70548825304, 6660.400563949268, 6664.133662623828, 5326.97336513315, 5333.946660533423, 5348.277982472394, 5360.276362691065, 5385.38068122171, 3986.681065514752, 4756.143894099096, 4764.094821983881, 4765.0231702500905, 4791.209450440639, 6112.388761123941, 6143.757528502065, 6176.104464852571, 6273.9372606273355, 6299.1811064562235, 6675.599464032077, 6693.933060669428, 6751.93248067513, 6762.72949082041, 6769.695363708645, 6285.994240921431, 6297.4332310091395, 6301.149344838388, 6303.905441418382, 6305.243370795442, 5771.94228057714, 5955.255593050869, 5955.821325360246, 5964.1650168976375, 5967.462928336384, 6664.600123992479, 6813.931860681329, 6855.451563874978, 6890.896636550356, 6911.239763625897, 6721.059051732664, 6735.225449073223, 6739.191297044386, 6749.898751518829, 6757.290484499057, 6834.282400347892, 6847.965760171366, 6893.931060689329, 6902.0, 6935.549189302679, 6378.712957916998, 6421.743130274736, 6521.380468855451, 6564.212294524687, 6601.240857301472, 6645.1361323027695, 6725.058491811248, 6749.898751518829, 6766.93233067663, 6766.93233067663, 6220.906686399617, 6385.201849768779, 6502.642354670538, 6528.510361722985, 6539.607623542603, 5452.291202143696, 6433.260175079926, 6496.0, 6506.73973041092, 6516.73933042673, 5338.572914166935, 6270.122182894307, 6358.809235722936, 6363.1091647168505, 6375.203099612549, 6292.779752708633, 6498.415142637185, 6544.8363790905605, 6547.508936829661, 6548.214214294315, 6231.096491008869, 6296.496280297473, 6304.306526282197, 6348.428641422294, 6361.14124593174], "value": 6024.676351258583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.2751185059014, 724.5688815154982, 824.4476200945368, 1132.773445310938, 1242.1180961517323, 36334.0, 37413.438798418014, 37418.0, 37435.06412339689, 37568.43647345292, 31691.841540792262, 38054.0, 38325.42511862324, 38596.421053684215, 38715.03212419684, 7923.564203968779, 8066.677332906676, 8204.343652507785, 8445.94425696788, 8458.619362128718, 7410.2219266977, 8480.024797148315, 8582.527960962145, 8601.483910965331, 8615.698450554231, 8552.016518100405, 8618.181272779077, 8621.396502244845, 8639.308855291561, 8680.262177714902, 6781.084553585301, 8380.868582741343, 8586.497362961456, 8592.570371481432, 8607.18231767981, 8356.331493480568, 8377.120402357787, 8377.83244335116, 8443.451175673561, 8478.194571515696, 36918.63081369179, 36952.81523592392, 36978.0, 36988.44517332242, 37125.25749484995, 3642.3261696586214, 3652.525171727685, 3662.963370366289, 3687.778733276012, 3688.8340024698955, 29941.700582994108, 30096.84951575228, 30292.54561181584, 30351.0, 30437.695623043706, 3167.635721891989, 3201.5837941067743, 3206.7274281686086, 3218.0667606394118, 3233.094733474631, 233828.83085584463, 233994.0, 274627.6268618664, 290705.0, 295004.0, 40279.798601006805, 46040.7697961508, 47080.05839883183, 47179.0, 47405.0, 48409.0, 48916.26625600619, 49142.01715965661, 49168.26247606289, 49211.50788492069, 13758.862411375958, 13806.516771912935, 13926.651833704238, 13969.441222350992, 13985.930070349787, 11376.260543064674, 11407.144464165222, 11408.372539510407, 11410.429478526206, 11439.771204575862, 13364.19814811095, 13373.732525349438, 13392.66073392653, 13433.261170635513, 13553.186808791505, 5796.478316951495, 5801.332846722681, 5808.912866307009, 5860.560457965669, 5894.67579283135, 896.9819255145457, 984.3601658921758, 1005.8591797148405, 1033.121846430543, 1055.461714525582, 21147.47131321729, 22174.88912555427, 24620.5075898481, 30613.69386306153, 31067.256909769156, 1091.230682368928, 1096.5580261955504, 1110.6445937299986, 1128.5260190719916, 1136.6533207371665, 12002.819957700642, 12541.659182981006, 12603.18079324841, 12614.684632884067, 12679.873201268054, 300547.0, 301961.0, 302149.0, 304222.0, 304722.0, 51923.48076519262, 52074.739626302384, 52132.17537386249, 52435.73782131065, 52736.47263527316, 1323.153181963544, 1434.870861622459, 1464.967198125319, 1494.9252537373088, 1495.0581133885582, 19431.902840485705, 22704.43238918974, 23685.763142368356, 23943.16198933029, 24051.0, 36886.63113368832, 37314.62685373111, 37417.81291093636, 37590.812045939594, 37641.0, 299963.5001825064, 301472.4926375442, 302552.0, 302830.0, 303569.0, 32681.509777352883, 35898.0, 36498.0, 36636.0, 36815.63184368122, 36159.63840361563, 44407.77796110999, 44648.0, 45026.54973450355, 45371.77314113409, 30356.270865513623, 30506.84746576253, 30610.0, 31459.213519662193, 31667.52498712567, 26049.479010420066, 27568.862155689094, 31047.68952310448, 31198.688013120485, 31206.843965780026, 36799.816000919825, 37433.0, 37551.81224093862, 37581.0, 37586.81206593949, 27137.0, 30401.0, 30960.916367927013, 31336.686633133377, 31559.0, 22659.660105098767, 24130.63804042976, 24254.15110471125, 24336.269911902673, 24513.896874640326], "value": 17341.657689406467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.2441829125865, 422.4298517095209, 431.52532214563985, 443.8690586277048, 445.944256967879, 19128.33050843219, 20612.072456739446, 21451.034703438345, 21460.356189314305, 21523.784762152372, 21850.453738656543, 21950.0, 22195.889020554914, 22645.886770566165, 22854.428639284026, 6082.695865206744, 6277.2467303923595, 6279.9952007678785, 6283.151774510428, 6283.685815709219, 5998.190244317027, 6167.599106058092, 6198.2252218472695, 6232.937670623303, 6233.096201050845, 6118.204633397652, 6151.415615516541, 6171.228596425447, 6172.814815555541, 6220.066989951521, 5984.0, 6194.473469755031, 6203.596766210205, 6205.503559715212, 6216.0, 5353.866153346158, 5505.476979686923, 5548.833534993957, 5561.110222364402, 5574.358948720908, 22612.88693556538, 26743.063992760355, 26977.73022269772, 27373.863130684218, 27699.723002769915, 1911.9044047797554, 2084.4997200671883, 2222.14447437736, 2307.63077907534, 2312.352541288442, 17682.469525914243, 17699.0, 17735.29058837645, 17823.376181833704, 18063.638727225512, 2164.058634494, 2165.6426689596196, 2214.6124428225157, 2218.0, 2224.443889027743, 132261.0, 138904.0, 150686.0, 157682.99999999886, 161110.0, 12249.265044097205, 12810.80783788244, 12897.742045159044, 12914.612561623166, 12928.418221180069, 16696.91651541759, 16730.58173545671, 16731.912425692535, 16735.246913888903, 16773.161341933097, 8732.257758090633, 8966.462012279284, 9053.185213330831, 9060.501672408082, 9173.633054677872, 6782.457403407716, 8598.097199793932, 8603.543456165105, 8776.648934042694, 8800.295976321879, 7956.965594472682, 8101.675932962733, 8113.107558168715, 8125.553094579736, 8146.877796833052, 2227.6658501224947, 2230.14139556272, 2232.3860938241787, 2235.2511908510833, 2384.9642255366184, 834.870595057767, 945.7493764152505, 964.9421034737938, 984.699666601679, 1013.2451323763843, 17823.643527129385, 21645.35063948084, 21756.56486870254, 21764.802935838365, 21951.780482194972, 902.255639097747, 952.5999080386255, 962.8892677342055, 996.3573495095623, 1005.2510879394752, 8743.300535957109, 10674.679759607225, 10891.67324980252, 11093.889061109447, 11206.719832004102, 473127.71807048237, 475102.0, 481295.0, 481982.0, 486832.0, 120983.0, 124889.0, 132558.0, 132782.33608831893, 133050.0, 1133.4616057372682, 1147.7819214349247, 1179.280638810325, 1184.1059999700344, 1187.2164371514932, 18636.34772782946, 18920.810791891905, 18978.52553686169, 19167.90416047911, 19334.903325483283, 49858.0, 53138.0, 56672.43327566671, 57428.0, 57451.85096298134, 73912.26087739269, 75710.0, 75838.62080689562, 76124.61937690276, 78156.2184378149, 7437.479376443814, 8149.755507334789, 8187.385946053951, 9152.176304132394, 9340.019297973615, 12362.876371236533, 13239.80140297877, 14247.28763561797, 14561.563153105424, 14717.484888028868, 11903.0, 11975.76048479043, 12141.0, 12305.200161989442, 12355.93822030884, 11533.769324613628, 11677.532898683958, 11679.240849344766, 11680.532778689098, 11946.104042196695, 12300.753984920431, 12503.312317822607, 12526.248425094524, 12618.305993170097, 12676.542197647019, 8856.11438856135, 8946.68686595966, 9097.454152750855, 9179.632814687604, 9418.858717119385, 10093.940136285877, 10184.745381365525, 11947.984421324285, 12217.328046957502, 12289.87710122923], "value": 10384.900825924215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.473520062376, 1423.508889433146, 1439.0574173916089, 1447.5440236325558, 1457.4097490516342, 9056.184943355105, 11802.704932376695, 11825.0, 11862.703432414182, 12207.877921220785, 11785.587504437346, 11902.7619447611, 11995.98034167097, 12026.759464810699, 12090.455929483172, 2290.8545727136434, 2405.434722840131, 2501.7373175816506, 2546.528892154948, 2552.5022620588993, 2087.5094352827073, 2423.53952748978, 2513.861737604431, 2518.7355327690602, 2520.3699075231193, 2440.6827112475353, 2496.10140349474, 2501.69979602448, 2502.9374265643323, 2517.5342561626157, 2453.337598848319, 2466.950660986788, 2483.192962287255, 2486.1422809130822, 2513.3716570857287, 2407.807375409963, 2479.5536803375385, 2485.465624890639, 2487.2289590227088, 2515.635232891239, 11996.820047699292, 12071.93964030183, 12073.637790866289, 12099.213551119237, 12106.576269830513, 6626.13860198176, 6806.387425131712, 6853.383195512378, 6860.5197636165485, 6867.931320686779, 3649.6167902370134, 3735.383661695817, 4142.150859073913, 4465.196264672358, 4476.977615111904, 1253.8808813162825, 1256.4785613970191, 1283.9807402888964, 1296.002078399627, 1298.2664794391233, 14004.509842155578, 16189.109598972169, 16763.748543771853, 16785.748213776802, 16856.74714879278, 5666.801661941812, 5727.198192253088, 5800.477956983807, 5886.735096920564, 5907.793227237026, 12408.56570020045, 12485.625431237077, 12495.375231238402, 12524.185927914656, 12549.498020079278, 6600.2409722882485, 6647.401733843881, 6654.567453115629, 6671.299513551105, 6675.833104172434, 5946.197263369476, 6154.076888466676, 6204.069389591597, 6206.689665516797, 6222.502199824004, 4275.700700950903, 4452.643788496913, 4496.955030449653, 4500.144972455223, 4525.321201819754, 1308.2804457548311, 1319.030512573258, 1329.0630105775406, 1334.4928927007675, 1342.3087110138288, 765.5598031132122, 770.4144849914105, 791.1574173505198, 802.4703695560902, 804.9235322644456, 6673.432758215606, 7025.417037311008, 7029.402500787388, 7100.2899710029615, 7116.92883071173, 892.8392889279862, 915.3821170709745, 919.5769945824861, 921.1111277617132, 930.3812964378612, 4172.332426811757, 4172.91654166921, 4358.760268185217, 4372.256716358227, 4558.0, 12346.444410001572, 15238.619034524225, 15476.922615386851, 15478.690426191413, 15480.612984675474, 13774.724505509834, 15278.38886444552, 15326.693466130839, 15351.616209594626, 15367.538973830802, 7339.412846972229, 8537.487750734976, 8758.255548278468, 8784.297256219486, 8806.691765788166, 6236.781712640036, 6924.6537673117155, 7031.085958825524, 7077.929220707727, 7210.278972102958, 12654.367281636065, 12899.93550032244, 12943.935280323914, 13107.934460327637, 13164.934175329445, 12904.870951290366, 13069.165125022213, 13221.206727596375, 13325.267110309027, 13412.530561430303, 9596.856047159159, 9719.125278724949, 9873.0, 9876.950615246878, 9891.307608467627, 10834.837477438003, 10835.970582794622, 10857.402842843403, 10939.617113401311, 10953.068989136013, 9170.082991701043, 9283.675071372469, 9310.581023854078, 9372.250219982521, 9378.155965963097, 8966.596503157503, 9095.953965294077, 9151.679691210775, 9157.633694652406, 9278.675246366345, 8175.264226219669, 8207.71273005442, 8311.25198732117, 8312.293455056146, 8319.833603328021, 5590.664560126405, 6083.452489275986, 6124.724387402666, 6219.502439804714, 6226.470749986302, 4545.954540454553, 5742.368339482737, 6006.708557660124, 6155.35368786271, 6250.124982502362], "value": 5421.5029903044015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.34951456310677, 406.03971607149083, 409.34012578992196, 410.1468944595242, 421.0463300624087, 5337.89324213516, 5500.42245564216, 6386.64873431961, 6414.647194404311, 6424.61452312861, 6000.75996960121, 6095.817125486243, 6192.225971753531, 6252.812415627538, 6280.874382512358, 4718.9292160617615, 4740.739259340735, 4745.359376484183, 4750.619950403968, 4760.714357138583, 4641.698289611181, 4757.976210118944, 4767.880802979918, 4778.187708089633, 4796.0, 4691.788869500863, 4692.343071969927, 4719.882002949919, 4723.527647235266, 4746.620270378361, 4096.344584866422, 4489.910201795962, 4711.104890070876, 4721.811127554894, 4726.4328280606205, 4182.351735481006, 4205.684573656988, 4209.494860616715, 4209.5790420957965, 4233.555476674936, 4849.757512124415, 5283.815066472694, 6048.429417497546, 6125.418085281891, 6130.754769809202, 4756.381670382828, 4986.800527978877, 5116.746397132689, 5646.0, 5649.661020338793, 6319.5260355473065, 6488.545801793876, 6776.627285499296, 6791.524593278473, 6792.252852186256, 4486.7083639563325, 4490.708103973264, 4502.009557897258, 4508.143452744001, 4518.796654150571, 5782.392848750863, 6868.793936181923, 7035.432067295452, 7151.177614574286, 7200.495965282433, 3629.564452265692, 4351.282038463682, 4483.215437298525, 4539.341795439643, 4544.227481328182, 4057.6753859691153, 4060.837566497307, 4607.493175750665, 4616.446026476844, 4632.72203667781, 5178.663386879841, 5389.892202155935, 5453.400125986138, 5476.835694929158, 5488.670679759227, 5471.4831177657925, 6274.592151510137, 6680.565763225472, 6699.43054840344, 6740.561863478858, 1455.2869094143794, 1516.7194069097252, 1548.3806477409125, 1580.9960674971246, 1596.361455417842, 979.8677178580942, 1000.1298869983161, 1038.0916697889347, 1056.234230183111, 1062.5749700120014, 5269.762860671279, 5288.492779557808, 5510.311211098613, 6292.905606415908, 6303.3066362700065, 5716.342620598602, 5826.009183709088, 6936.7572134975035, 6942.757003504853, 6960.79117626472, 5258.790478190038, 6216.875662486725, 6275.121482992385, 6297.842553936097, 6307.905381419282, 3066.831324277186, 3438.3639026780124, 3625.746197766131, 3630.074331045619, 3633.6729694327637, 5748.885022299531, 6234.688265586702, 6837.726490940406, 7105.431565474853, 7172.21105678375, 7015.298470153046, 7085.89371159433, 7089.503734738519, 7106.253843346478, 7142.500024998304, 6378.143495742096, 6669.4997875160525, 7145.571265724073, 7151.392131668762, 7214.603196824225, 6198.411150940653, 6336.366363363627, 6998.930010699828, 7002.684879180551, 7066.505344626033, 6132.63204207749, 6333.588316759396, 6872.140982377203, 6908.965455172692, 6954.47841411886, 6248.781292654735, 6748.6963086660235, 6975.895361569682, 7179.820504487429, 7205.675744591611, 3746.5129533161603, 4513.1650644630845, 4549.886252843706, 4550.0899820035465, 4563.361129441947, 5628.493435590816, 6146.907796383147, 6427.710753016032, 6853.760118396031, 6951.7914462566205, 6726.730930762715, 6737.730490780314, 6739.123913891162, 6743.258241593323, 6745.730170793309, 5015.548600625962, 5977.970110149421, 6533.509986750918, 6626.337366263335, 6722.9663851680425, 6044.576879618385, 6579.302485980725, 6591.176102987127, 6592.077109204811, 6602.966985165043, 5322.494363035506, 6300.716467759054, 6737.326267373223, 6751.0, 6758.391744742997, 6509.479241660751, 6553.180852393451, 6563.409293163638, 6570.0, 6607.0], "value": 4846.387818076744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.8848172774084, 820.5733018830213, 830.6760363458252, 855.8758979947905, 856.8072183758655, 16055.0, 16413.097279649628, 16436.506904792845, 17825.465236042906, 18513.90743046283, 17014.48956531306, 17083.974961502317, 17273.0, 17369.73945390817, 17816.752827302094, 710.158462222267, 725.6734469488724, 725.9128904531464, 727.8362368467106, 728.5483000539647, 945.7541039329755, 951.4624237305935, 952.2144231009411, 955.4267439536258, 956.3783540698566, 996.8006398720248, 1006.2805094357533, 1006.5168719014878, 1007.2043085962081, 1011.1506334678868, 993.4039576254262, 1003.5433877585681, 1004.221728160674, 1005.0753306957616, 1010.0808264479289, 626.6208943589154, 740.8481261341412, 743.7396911081132, 746.06369006896, 747.9902132121647, 16057.759133613004, 16468.0, 16676.499705008868, 16678.749818752727, 16692.83307166937, 16344.18279086041, 16570.171491425503, 16785.07682077485, 16854.325826966906, 17092.290770922933, 13555.932220338835, 13805.861941380557, 13897.652558686113, 13903.09629874055, 13934.163950163023, 2961.970380296191, 3087.7529797616135, 3445.207602251496, 3499.142710036032, 3502.247016891355, 98085.0, 103181.42046448824, 115646.84353156445, 116023.83976160215, 118115.81884181134, 12650.936745316398, 12773.936130319475, 12968.546100886424, 13021.674458138623, 13059.608211753663, 24716.2585122443, 24883.004679812966, 24896.751032489807, 24969.0, 25090.99636014539, 6600.372964568358, 7392.223816499298, 7495.587742674096, 7497.400207983457, 7497.775066748006, 3828.0812604974603, 3856.73002889795, 3899.3371126907928, 3939.369700847908, 3941.5467221269346, 4283.850065247701, 4333.133373325348, 4374.343848422762, 4376.321670141133, 4382.824687012484, 781.1563511407666, 926.2173463423396, 967.1005964453126, 977.779999500121, 979.1187930862138, 545.4381986553856, 652.9281779004306, 653.2096163642046, 661.4675186474934, 680.873154928594, 10315.329503582394, 11003.954624310678, 11607.883921160848, 11648.0, 11863.11026673003, 627.6014730645982, 644.7614382678439, 645.5384400153913, 653.1150291355241, 672.5829985409077, 4898.853034408973, 5378.300820893259, 5533.418991005967, 5536.169574563848, 5585.636933599303, 87963.0, 90174.54912725526, 90811.0, 90879.54560227157, 100928.49535752274, 66783.0, 83092.0, 84227.0, 85750.14249857422, 86796.0, 57539.71230143906, 76068.85896711554, 76213.6189319061, 76507.85238221432, 77578.0, 10610.681679549625, 11652.41737913084, 12411.875881241072, 12417.937910310391, 12430.37848107573, 37335.0, 37590.62409375871, 38014.80992595019, 38685.64600238978, 39775.60224397835, 53932.460675394315, 63221.206727596495, 63277.41806454876, 63920.680396597716, 65622.67188664027, 15883.725928258504, 16036.839631603534, 16120.27458764335, 16359.18204089767, 16429.34282628729, 17859.28562857523, 18042.2783088675, 18231.45305640833, 18316.633667326845, 18351.724724129417, 15281.235938203268, 15536.844631553991, 16269.837301627305, 16929.91535042317, 17187.31250749956, 16391.45932380483, 16527.421540246032, 16901.830981690517, 16922.576935576708, 17108.0, 16100.838991609933, 16310.918445407697, 16552.66894662124, 16577.41979030728, 16604.58488537796, 11744.236624619714, 11853.466594003117, 11857.051435884936, 11926.344051077274, 12125.939370303093, 12063.21589096706, 12853.742925141258, 13361.550766540468, 13454.0, 13867.583972480841], "value": 8097.320945918178, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 118.0, 107.0, 137.0, 166.0, 167.0, 115.0, 116.0, 118.0], "value": 126.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 119.0, 147.0, 183.0, 105.0, 148.0, 145.0, 112.0, 143.0, 109.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 202.0, 207.0, 210.0, 213.0, 205.0, 251.0, 249.0, 201.0, 195.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 106.0, 85.0, 89.0, 51.0, 76.0, 98.0, 85.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 72.0, 72.0, 71.0, 94.0, 69.0, 69.0, 89.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 88.0, 91.0, 88.0, 100.0, 136.0, 90.0, 89.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 104.0, 97.0, 96.0, 100.0, 96.0, 96.0, 114.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 90.0, 92.0, 140.0, 130.0, 96.0, 92.0, 92.0, 92.0], "value": 100.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 51.0, 50.0, 52.0, 51.0, 52.0, 50.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 81.0, 96.0, 57.0, 76.0, 89.0, 81.0, 79.0, 57.0, 58.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 83.0, 84.0, 84.0, 82.0, 85.0, 86.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 155.0, 138.0, 145.0, 154.0, 151.0, 149.0, 151.0, 199.0, 167.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 190.0, 186.0, 182.0, 195.0, 226.0, 235.0, 185.0, 187.0, 187.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 68.0, 68.0, 70.0, 67.0, 69.0, 68.0, 67.0], "value": 68.5, "unit": "score"}]}]} 19:44:32 INFO - Return code: 0 19:44:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:32 ERROR - # TBPL SUCCESS # 19:44:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:44:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:44:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:44:32 INFO - 2017-04-19 19:44:32.766 screenresolution[1983:12974] starting screenresolution argv=screenresolution get 19:44:32 INFO - 2017-04-19 19:44:32.769 screenresolution[1983:12974] Display 0: 1600x1200x32@60 19:44:32 INFO - 2017-04-19 19:44:32.776 screenresolution[1984:12977] starting screenresolution argv=screenresolution list 19:44:32 INFO - Available Modes on Display 0 19:44:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:44:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:44:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:44:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:44:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:44:33 INFO - Intel Iris: 19:44:33 INFO - Chipset Model: Intel Iris 19:44:33 INFO - Type: GPU 19:44:33 INFO - Bus: Built-In 19:44:33 INFO - VRAM (Dynamic, Max): 1536 MB 19:44:33 INFO - Vendor: Intel (0x8086) 19:44:33 INFO - Device ID: 0x0a2e 19:44:33 INFO - Revision ID: 0x0009 19:44:33 INFO - Displays: 19:44:33 INFO - Display: 19:44:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:44:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:44:33 INFO - Display Serial Number: 1600x1200 60 19:44:33 INFO - Main Display: Yes 19:44:33 INFO - Mirror: Off 19:44:33 INFO - Online: Yes 19:44:33 INFO - Rotation: Supported 19:44:33 INFO - Return code: 0 19:44:33 INFO - Running post-action listener: _resource_record_post_action 19:44:33 INFO - [mozharness: 2017-04-20 02:44:33.020520Z] Finished run-tests step (success) 19:44:33 INFO - Running post-run listener: _resource_record_post_run 19:44:33 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 3008512; Write bytes: 519945216; Read time: 17; Write time: 1618 19:44:33 INFO - TinderboxPrint: CPU usage
54.2% 19:44:33 INFO - TinderboxPrint: I/O read bytes / time
3,008,512 / 17 19:44:33 INFO - TinderboxPrint: I/O write bytes / time
519,945,216 / 1,618 19:44:33 INFO - TinderboxPrint: CPU idle
2,192.9 (45.8%) 19:44:33 INFO - TinderboxPrint: CPU system
967.1 (20.2%) 19:44:33 INFO - TinderboxPrint: CPU user
1,629.7 (34.0%) 19:44:33 INFO - TinderboxPrint: Swap in / out
211,050,496 / 0 19:44:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209011200; Write bytes: 213714944; Read time: 15988; Write time: 459 19:44:33 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1202176; Write bytes: 304894976; Read time: 11; Write time: 1150 19:44:33 INFO - Running post-run listener: _upload_blobber_files 19:44:33 INFO - Blob upload gear active. 19:44:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:33 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 19:44:33 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:44:33 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:44:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:44:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:44:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:35 INFO - (blobuploader) - INFO - Done attempting. 19:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:36 INFO - (blobuploader) - INFO - Done attempting. 19:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:38 INFO - (blobuploader) - INFO - Done attempting. 19:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:40 INFO - (blobuploader) - INFO - Done attempting. 19:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:44:40 INFO - Return code: 0 19:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6038283bfb2c01742b6140d560d36cf8e05233da741f0990373a21adb7d16c34e8448dc8fba59b62ba55fda89f6d391fe1d56cca6c1818ca5a5caf76c885934d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/23c3b29bb17ba2f58548d38423dd3890037b11282902f66a355e62c1cc5e83659eda4950e107182a126c965f6a72d724553bb0db8dde9f7fb7a51b776c85c570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7026550bcca43d8a3829f5d0c77ed8f351682e16c20fd9a3710a7dafe0071d5fe6d7ee7c72a786ca83573553fb383094999eea31410b10001df7c053adad0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c1be9a79a5b5d75eb79efa6da47613c411355404b59627082e8b13216d8f7c9d010ea43c5ec065e5b5be5f50c89ebcdea89a221f83762547c3aeee3f6312c5ab"} 19:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:44:40 INFO - Contents: 19:44:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6038283bfb2c01742b6140d560d36cf8e05233da741f0990373a21adb7d16c34e8448dc8fba59b62ba55fda89f6d391fe1d56cca6c1818ca5a5caf76c885934d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/23c3b29bb17ba2f58548d38423dd3890037b11282902f66a355e62c1cc5e83659eda4950e107182a126c965f6a72d724553bb0db8dde9f7fb7a51b776c85c570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7026550bcca43d8a3829f5d0c77ed8f351682e16c20fd9a3710a7dafe0071d5fe6d7ee7c72a786ca83573553fb383094999eea31410b10001df7c053adad0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c1be9a79a5b5d75eb79efa6da47613c411355404b59627082e8b13216d8f7c9d010ea43c5ec065e5b5be5f50c89ebcdea89a221f83762547c3aeee3f6312c5ab"} 19:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:44:40 INFO - Copying logs to upload dir... 19:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.123877 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-19 19:44:40.924035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:44:40.927867) ========= 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.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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/Pine/sha512/6038283bfb2c01742b6140d560d36cf8e05233da741f0990373a21adb7d16c34e8448dc8fba59b62ba55fda89f6d391fe1d56cca6c1818ca5a5caf76c885934d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/23c3b29bb17ba2f58548d38423dd3890037b11282902f66a355e62c1cc5e83659eda4950e107182a126c965f6a72d724553bb0db8dde9f7fb7a51b776c85c570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7026550bcca43d8a3829f5d0c77ed8f351682e16c20fd9a3710a7dafe0071d5fe6d7ee7c72a786ca83573553fb383094999eea31410b10001df7c053adad0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c1be9a79a5b5d75eb79efa6da47613c411355404b59627082e8b13216d8f7c9d010ea43c5ec065e5b5be5f50c89ebcdea89a221f83762547c3aeee3f6312c5ab"} build_url:https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/G7LrXZTBQCuPsKU-JBwdgQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6038283bfb2c01742b6140d560d36cf8e05233da741f0990373a21adb7d16c34e8448dc8fba59b62ba55fda89f6d391fe1d56cca6c1818ca5a5caf76c885934d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/23c3b29bb17ba2f58548d38423dd3890037b11282902f66a355e62c1cc5e83659eda4950e107182a126c965f6a72d724553bb0db8dde9f7fb7a51b776c85c570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7026550bcca43d8a3829f5d0c77ed8f351682e16c20fd9a3710a7dafe0071d5fe6d7ee7c72a786ca83573553fb383094999eea31410b10001df7c053adad0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c1be9a79a5b5d75eb79efa6da47613c411355404b59627082e8b13216d8f7c9d010ea43c5ec065e5b5be5f50c89ebcdea89a221f83762547c3aeee3f6312c5ab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:44:40.969827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:44:40.970209) ========= 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.HGXQrBsuds/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.oDtBJCm3X6/Listeners TMPDIR=/var/folders/r5/r29qydxj0vb5gs1yvh8jslnm00000w/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.005442 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:44:41.019278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:44:41.019629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:44:41.020010) ========= ========= Total master_lag: 3.43 =========