builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0268 starttime: 1475007341.68 results: success (0) buildid: 20160927101220 builduid: b343ad0e539c44bfbb74fe9e92756500 revision: f148d84038400a368315d1d0391ed0ea498ca676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:41.683143) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:41.683593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:41.683872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:41.811153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:41.811424) ========= 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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 13:15:41-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.2M=0.001s 2016-09-27 13:15:42 (22.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.600685 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:42.437419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:42.437765) ========= 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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.026427 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:42.487426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 13:15:42.487797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f148d84038400a368315d1d0391ed0ea498ca676 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f148d84038400a368315d1d0391ed0ea498ca676 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 13:15:42,568 truncating revision to first 12 chars 2016-09-27 13:15:42,569 Setting DEBUG logging. 2016-09-27 13:15:42,569 attempt 1/10 2016-09-27 13:15:42,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f148d8403840?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 13:15:43,345 unpacking tar archive at: fx-team-f148d8403840/testing/mozharness/ program finished with exit code 0 elapsedTime=1.048970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 13:15:43.558997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:43.559339) ========= script_repo_revision: f148d84038400a368315d1d0391ed0ea498ca676 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:43.559804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:43.560081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 13:15:43.578032) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-27 13:15:43.578354) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:15:43 INFO - MultiFileLogger online at 20160927 13:15:43 in /builds/slave/test 13:15:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:15:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:15:43 INFO - {'append_to_log': False, 13:15:43 INFO - 'base_work_dir': '/builds/slave/test', 13:15:43 INFO - 'blob_upload_branch': 'Fx-Team', 13:15:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:15:43 INFO - 'branch': 'Fx-Team', 13:15:43 INFO - 'buildbot_json_path': 'buildprops.json', 13:15:43 INFO - 'config_files': ('talos/mac_config.py',), 13:15:43 INFO - 'default_actions': ('clobber', 13:15:43 INFO - 'read-buildbot-config', 13:15:43 INFO - 'download-and-extract', 13:15:43 INFO - 'populate-webroot', 13:15:43 INFO - 'create-virtualenv', 13:15:43 INFO - 'install', 13:15:43 INFO - 'run-tests'), 13:15:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:15:43 INFO - 'download_minidump_stackwalk': True, 13:15:43 INFO - 'download_symbols': 'ondemand', 13:15:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:15:43 INFO - 'tooltool.py': '/tools/tooltool.py', 13:15:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:15:43 INFO - '/tools/misc-python/virtualenv.py')}, 13:15:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:15:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:15:43 INFO - 'installer_path': 'installer.exe', 13:15:43 INFO - 'log_level': 'info', 13:15:43 INFO - 'log_name': 'talos', 13:15:43 INFO - 'log_to_console': True, 13:15:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:15:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:15:43 INFO - 'opt_config_files': (), 13:15:43 INFO - 'pip_index': False, 13:15:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:15:43 INFO - 'cmd': ('bash', 13:15:43 INFO - '-c', 13:15:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:15:43 INFO - 'enabled': True, 13:15:43 INFO - 'halt_on_failure': False, 13:15:43 INFO - 'name': 'check_screen_resolution'},), 13:15:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:15:43 INFO - 'cmd': ('bash', 13:15:43 INFO - '-c', 13:15:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:15:43 INFO - 'enabled': True, 13:15:43 INFO - 'halt_on_failure': False, 13:15:43 INFO - 'name': 'check_screen_resolution'},), 13:15:43 INFO - 'run_cmd_checks_enabled': True, 13:15:43 INFO - 'sps_profile': False, 13:15:43 INFO - 'sps_profile_interval': 0, 13:15:43 INFO - 'suite': 'dromaeojs-e10s', 13:15:43 INFO - 'system_bits': '32', 13:15:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:15:43 INFO - 'title': 't-yosemite-r7-0268', 13:15:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:15:43 INFO - 'use_talos_json': True, 13:15:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:15:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:15:43 INFO - 'work_dir': 'build'} 13:15:43 INFO - [mozharness: 2016-09-27 20:15:43.774563Z] Running clobber step. 13:15:43 INFO - Running pre-action listener: _resource_record_pre_action 13:15:43 INFO - Running main action method: clobber 13:15:43 INFO - rmtree: /builds/slave/test/build 13:15:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:15:45 INFO - Running post-action listener: _resource_record_post_action 13:15:45 INFO - [mozharness: 2016-09-27 20:15:45.926199Z] Finished clobber step (success) 13:15:45 INFO - [mozharness: 2016-09-27 20:15:45.926392Z] Running read-buildbot-config step. 13:15:45 INFO - Running pre-action listener: _resource_record_pre_action 13:15:45 INFO - Running main action method: read_buildbot_config 13:15:45 INFO - Using buildbot properties: 13:15:45 INFO - { 13:15:45 INFO - "project": "", 13:15:45 INFO - "product": "firefox", 13:15:45 INFO - "script_repo_revision": "production", 13:15:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:15:45 INFO - "repository": "", 13:15:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:15:45 INFO - "buildid": "20160927101220", 13:15:45 INFO - "pgo_build": "False", 13:15:45 INFO - "basedir": "/builds/slave/test", 13:15:45 INFO - "buildnumber": 790, 13:15:45 INFO - "slavename": "t-yosemite-r7-0268", 13:15:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:15:45 INFO - "platform": "yosemite_r7", 13:15:45 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 13:15:45 INFO - "branch": "fx-team", 13:15:45 INFO - "repo_path": "integration/fx-team", 13:15:45 INFO - "revision": "f148d84038400a368315d1d0391ed0ea498ca676", 13:15:45 INFO - "stage_platform": "macosx64", 13:15:45 INFO - "builduid": "b343ad0e539c44bfbb74fe9e92756500", 13:15:45 INFO - "slavebuilddir": "test" 13:15:45 INFO - } 13:15:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:15:45 INFO - Running post-action listener: _resource_record_post_action 13:15:45 INFO - [mozharness: 2016-09-27 20:15:45.931874Z] Finished read-buildbot-config step (success) 13:15:45 INFO - [mozharness: 2016-09-27 20:15:45.932060Z] Running download-and-extract step. 13:15:45 INFO - Running pre-action listener: _resource_record_pre_action 13:15:45 INFO - Running main action method: download_and_extract 13:15:45 INFO - mkdir: /builds/slave/test/build/tests 13:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:45 INFO - trying https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:15:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:15:47 INFO - Downloaded 1199 bytes. 13:15:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:15:47 INFO - Using the following test package requirements: 13:15:47 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:15:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:15:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:15:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'jsshell-mac.zip'], 13:15:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:15:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:15:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:15:47 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:15:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:15:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:47 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:15:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:15:47 INFO - Expected file size: 16470435 13:15:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:15:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:15:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:15:54 INFO - Fetch https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:15:55 INFO - Expected file size: 16470435 13:16:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:16:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:16:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:16:02 INFO - Expected file size: 14414062 13:16:03 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')]} 13:16:03 INFO - trying https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:16:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:16:06 INFO - Downloaded 111549701 bytes. 13:16:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:16:06 INFO - mkdir: /builds/slave/test/properties 13:16:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:06 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:06 INFO - Contents: 13:16:06 INFO - build_url:https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:16:07 INFO - Running post-action listener: _resource_record_post_action 13:16:07 INFO - Running post-action listener: set_extra_try_arguments 13:16:07 INFO - [mozharness: 2016-09-27 20:16:07.343968Z] Finished download-and-extract step (success) 13:16:07 INFO - [mozharness: 2016-09-27 20:16:07.344102Z] Running populate-webroot step. 13:16:07 INFO - Running pre-action listener: _resource_record_pre_action 13:16:07 INFO - Running main action method: populate_webroot 13:16:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:16:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:16:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:16:07 INFO - '--tppagecycles', 13:16:07 INFO - '7'], 13:16:07 INFO - 'tests': ['tsvgm']}}, 13:16:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:16:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:16:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['damp', 'tps']}, 13:16:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'tests': ['damp', 'tps']}, 13:16:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['dromaeo_dom']}, 13:16:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['basic_compositor_video']}, 13:16:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:16:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['a11yr', 13:16:07 INFO - 'ts_paint', 13:16:07 INFO - 'tpaint', 13:16:07 INFO - 'sessionrestore', 13:16:07 INFO - 'sessionrestore_no_auto_restore', 13:16:07 INFO - 'tabpaint']}, 13:16:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['tsvgx', 13:16:07 INFO - 'tsvgr_opacity', 13:16:07 INFO - 'tart', 13:16:07 INFO - 'tscrollx', 13:16:07 INFO - 'cart']}, 13:16:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:07 INFO - 'tsvgr_opacity', 13:16:07 INFO - 'tart', 13:16:07 INFO - 'tscrollx', 13:16:07 INFO - 'cart']}, 13:16:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'talos_options': ['--disable-e10s'], 13:16:07 INFO - 'tests': ['tp5o']}, 13:16:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'tests': ['tp5o']}, 13:16:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'talos_options': ['--disable-e10s', 13:16:07 INFO - '--xperf_path', 13:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:07 INFO - 'tests': ['tp5n']}, 13:16:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:07 INFO - 'talos_options': ['--xperf_path', 13:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:07 INFO - 'tests': ['tp5n']}}, 13:16:07 INFO - 'talos.zip': {'path': '', 13:16:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:16:07 INFO - Running post-action listener: _resource_record_post_action 13:16:07 INFO - [mozharness: 2016-09-27 20:16:07.362629Z] Finished populate-webroot step (success) 13:16:07 INFO - [mozharness: 2016-09-27 20:16:07.362758Z] Running create-virtualenv step. 13:16:07 INFO - Running pre-action listener: _resource_record_pre_action 13:16:07 INFO - Running main action method: create_virtualenv 13:16:07 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:07 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 13:16:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:16:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:07 INFO - Using real prefix '/tools/python27' 13:16:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:11 INFO - Installing pip.................done. 13:16:11 INFO - Return code: 0 13:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:16:11 INFO - Reading from file tmpfile_stdout 13:16:11 INFO - Output received: 13:16:11 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) 13:16:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:11 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:11 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 13:16:11 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 13:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:11 INFO - 'HOME': '/Users/cltbld', 13:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:11 INFO - 'LOGNAME': 'cltbld', 13:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:11 INFO - 'MOZ_NO_REMOTE': '1', 13:16:11 INFO - 'NO_EM_RESTART': '1', 13:16:11 INFO - 'PAGER': '/bin/cat', 13:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:11 INFO - 'PWD': '/builds/slave/test', 13:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:11 INFO - 'SHELL': '/bin/bash', 13:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:11 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:11 INFO - 'USER': 'cltbld', 13:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:11 INFO - 'XPC_FLAGS': '0x0', 13:16:11 INFO - 'XPC_SERVICE_NAME': '0', 13:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:11 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 13:16:11 INFO - Cleaning up... 13:16:11 INFO - Return code: 0 13:16:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:11 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:11 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 13:16:11 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 13:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:11 INFO - 'HOME': '/Users/cltbld', 13:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:11 INFO - 'LOGNAME': 'cltbld', 13:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:11 INFO - 'MOZ_NO_REMOTE': '1', 13:16:11 INFO - 'NO_EM_RESTART': '1', 13:16:11 INFO - 'PAGER': '/bin/cat', 13:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:11 INFO - 'PWD': '/builds/slave/test', 13:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:11 INFO - 'SHELL': '/bin/bash', 13:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:11 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:11 INFO - 'USER': 'cltbld', 13:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:11 INFO - 'XPC_FLAGS': '0x0', 13:16:11 INFO - 'XPC_SERVICE_NAME': '0', 13:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:11 INFO - Downloading/unpacking psutil>=3.1.1 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:15 INFO - Installing collected packages: psutil 13:16:15 INFO - Running setup.py install for psutil 13:16:15 INFO - building 'psutil._psutil_osx' extension 13:16:15 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 13:16:16 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 13:16:16 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 13:16:16 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 13:16:16 INFO - building 'psutil._psutil_posix' extension 13:16:16 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 13:16:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:16:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:16:16 INFO - ^ 13:16:16 INFO - 1 warning generated. 13:16:16 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 13:16:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:16 INFO - Successfully installed psutil 13:16:16 INFO - Cleaning up... 13:16:17 INFO - Return code: 0 13:16:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:17 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:17 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 13:16:17 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 13:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:17 INFO - 'HOME': '/Users/cltbld', 13:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:17 INFO - 'LOGNAME': 'cltbld', 13:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:17 INFO - 'MOZ_NO_REMOTE': '1', 13:16:17 INFO - 'NO_EM_RESTART': '1', 13:16:17 INFO - 'PAGER': '/bin/cat', 13:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:17 INFO - 'PWD': '/builds/slave/test', 13:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:17 INFO - 'SHELL': '/bin/bash', 13:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:17 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:17 INFO - 'USER': 'cltbld', 13:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:17 INFO - 'XPC_FLAGS': '0x0', 13:16:17 INFO - 'XPC_SERVICE_NAME': '0', 13:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:16:17 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 13:16:17 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 13:16:17 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 13:16:17 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 13:16:17 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 13:16:17 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 13:16:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:16:19 INFO - Installing collected packages: mozsystemmonitor 13:16:19 INFO - Running setup.py install for mozsystemmonitor 13:16:20 INFO - Successfully installed mozsystemmonitor 13:16:20 INFO - Cleaning up... 13:16:20 INFO - Return code: 0 13:16:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:16:20 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')]} 13:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:20 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')]} 13:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:20 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:20 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 13:16:20 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 13:16:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:20 INFO - 'HOME': '/Users/cltbld', 13:16:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:20 INFO - 'LOGNAME': 'cltbld', 13:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:20 INFO - 'MOZ_NO_REMOTE': '1', 13:16:20 INFO - 'NO_EM_RESTART': '1', 13:16:20 INFO - 'PAGER': '/bin/cat', 13:16:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:20 INFO - 'PWD': '/builds/slave/test', 13:16:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:20 INFO - 'SHELL': '/bin/bash', 13:16:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:20 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:20 INFO - 'USER': 'cltbld', 13:16:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:20 INFO - 'XPC_FLAGS': '0x0', 13:16:20 INFO - 'XPC_SERVICE_NAME': '0', 13:16:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:20 INFO - Downloading/unpacking jsonschema==2.5.1 13:16:20 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 13:16:20 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 13:16:20 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 13:16:20 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 13:16:20 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 13:16:20 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 13:16:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:16:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:23 INFO - Downloading functools32-3.2.3-2.tar.gz 13:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:16:23 INFO - warning: no files found matching '*.txt' 13:16:23 INFO - no previously-included directories found matching 'build' 13:16:23 INFO - no previously-included directories found matching 'dist' 13:16:23 INFO - no previously-included directories found matching '.git*' 13:16:23 INFO - Installing collected packages: jsonschema, functools32 13:16:23 INFO - Running setup.py install for functools32 13:16:23 INFO - warning: no files found matching '*.txt' 13:16:23 INFO - no previously-included directories found matching 'build' 13:16:23 INFO - no previously-included directories found matching 'dist' 13:16:23 INFO - no previously-included directories found matching '.git*' 13:16:23 INFO - Successfully installed jsonschema functools32 13:16:23 INFO - Cleaning up... 13:16:23 INFO - Return code: 0 13:16:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:16:23 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')]} 13:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:23 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')]} 13:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:23 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:23 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 13:16:23 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 13:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:23 INFO - 'HOME': '/Users/cltbld', 13:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:23 INFO - 'LOGNAME': 'cltbld', 13:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:23 INFO - 'MOZ_NO_REMOTE': '1', 13:16:23 INFO - 'NO_EM_RESTART': '1', 13:16:23 INFO - 'PAGER': '/bin/cat', 13:16:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:23 INFO - 'PWD': '/builds/slave/test', 13:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:23 INFO - 'SHELL': '/bin/bash', 13:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:23 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:23 INFO - 'USER': 'cltbld', 13:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:23 INFO - 'XPC_FLAGS': '0x0', 13:16:23 INFO - 'XPC_SERVICE_NAME': '0', 13:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:16:23 INFO - Cleaning up... 13:16:23 INFO - Return code: 0 13:16:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:16:23 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')]} 13:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:23 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')]} 13:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:23 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:23 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 13:16:23 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 13:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:23 INFO - 'HOME': '/Users/cltbld', 13:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:23 INFO - 'LOGNAME': 'cltbld', 13:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:23 INFO - 'MOZ_NO_REMOTE': '1', 13:16:23 INFO - 'NO_EM_RESTART': '1', 13:16:23 INFO - 'PAGER': '/bin/cat', 13:16:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:23 INFO - 'PWD': '/builds/slave/test', 13:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:23 INFO - 'SHELL': '/bin/bash', 13:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:23 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:23 INFO - 'USER': 'cltbld', 13:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:23 INFO - 'XPC_FLAGS': '0x0', 13:16:23 INFO - 'XPC_SERVICE_NAME': '0', 13:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:16:24 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 13:16:24 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 13:16:24 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 13:16:24 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 13:16:24 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 13:16:24 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 13:16:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:16:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:16:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:27 INFO - Downloading docopt-0.6.1.tar.gz 13:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:16:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:16:27 INFO - Running setup.py install for blobuploader 13:16:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:16:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:16:28 INFO - Running setup.py install for requests 13:16:28 INFO - Running setup.py install for docopt 13:16:28 INFO - Successfully installed blobuploader requests docopt 13:16:28 INFO - Cleaning up... 13:16:28 INFO - Return code: 0 13:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:28 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')]} 13:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:28 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')]} 13:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:28 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:28 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 13:16:28 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 13:16:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:28 INFO - 'HOME': '/Users/cltbld', 13:16:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:28 INFO - 'LOGNAME': 'cltbld', 13:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:28 INFO - 'MOZ_NO_REMOTE': '1', 13:16:28 INFO - 'NO_EM_RESTART': '1', 13:16:28 INFO - 'PAGER': '/bin/cat', 13:16:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:28 INFO - 'PWD': '/builds/slave/test', 13:16:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:28 INFO - 'SHELL': '/bin/bash', 13:16:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:28 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:28 INFO - 'USER': 'cltbld', 13:16:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:28 INFO - 'XPC_FLAGS': '0x0', 13:16:28 INFO - 'XPC_SERVICE_NAME': '0', 13:16:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-f_Sm8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-BgxSD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ybqv_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-OLtySa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-OFdhBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jqNqVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CWSzYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-nJA7Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:29 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-dDtH6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-4lJf9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-3zyOHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-YYqhOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Q4vMBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-YEzFX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-t6hoZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-iuwIPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:30 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-oVz4nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:16:30 INFO - Running setup.py install for manifestparser 13:16:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:16:30 INFO - Running setup.py install for mozcrash 13:16:31 INFO - Running setup.py install for mozdebug 13:16:31 INFO - Running setup.py install for mozdevice 13:16:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Running setup.py install for mozfile 13:16:31 INFO - Running setup.py install for mozhttpd 13:16:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Running setup.py install for mozinfo 13:16:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Running setup.py install for mozInstall 13:16:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:16:31 INFO - Running setup.py install for mozleak 13:16:32 INFO - Running setup.py install for mozlog 13:16:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Running setup.py install for moznetwork 13:16:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Running setup.py install for mozprocess 13:16:32 INFO - Running setup.py install for mozprofile 13:16:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Running setup.py install for mozrunner 13:16:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:16:32 INFO - Running setup.py install for mozscreenshot 13:16:33 INFO - Running setup.py install for moztest 13:16:33 INFO - Running setup.py install for mozversion 13:16:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:16:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:16:33 INFO - Cleaning up... 13:16:33 INFO - Return code: 0 13:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:33 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')]} 13:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:33 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')]} 13:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:33 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:33 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 13:16:33 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 13:16:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:33 INFO - 'HOME': '/Users/cltbld', 13:16:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:33 INFO - 'LOGNAME': 'cltbld', 13:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:33 INFO - 'MOZ_NO_REMOTE': '1', 13:16:33 INFO - 'NO_EM_RESTART': '1', 13:16:33 INFO - 'PAGER': '/bin/cat', 13:16:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:33 INFO - 'PWD': '/builds/slave/test', 13:16:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:33 INFO - 'SHELL': '/bin/bash', 13:16:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:33 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:33 INFO - 'USER': 'cltbld', 13:16:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:33 INFO - 'XPC_FLAGS': '0x0', 13:16:33 INFO - 'XPC_SERVICE_NAME': '0', 13:16:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:33 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-P_bCEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:33 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)) 13:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:33 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-lhWUvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:33 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_55U9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:33 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)) 13:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:33 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-E3LJWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-LGA7O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-DNc5Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-3kj2vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-U6QJds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-VcYrzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-4xOJdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Bu23dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:34 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)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-2PC893-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:34 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-SeKMvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:35 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)) 13:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-XPvc0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-K0C9zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:35 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)) 13:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jMtjx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:35 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-jL4Sj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:35 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)) 13:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:16:35 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)) 13:16:35 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:16:35 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:16:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:37 INFO - Downloading blessings-1.6.tar.gz 13:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:16:38 INFO - Installing collected packages: blessings 13:16:38 INFO - Running setup.py install for blessings 13:16:38 INFO - Successfully installed blessings 13:16:38 INFO - Cleaning up... 13:16:38 INFO - Return code: 0 13:16:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:38 INFO - Reading from file tmpfile_stdout 13:16:38 INFO - Current package versions: 13:16:38 INFO - blessings == 1.6 13:16:38 INFO - blobuploader == 1.2.4 13:16:38 INFO - docopt == 0.6.1 13:16:38 INFO - functools32 == 3.2.3-2 13:16:38 INFO - jsonschema == 2.5.1 13:16:38 INFO - manifestparser == 1.1 13:16:38 INFO - mozInstall == 1.12 13:16:38 INFO - mozcrash == 0.17 13:16:38 INFO - mozdebug == 0.1 13:16:38 INFO - mozdevice == 0.48 13:16:38 INFO - mozfile == 1.2 13:16:38 INFO - mozhttpd == 0.7 13:16:38 INFO - mozinfo == 0.9 13:16:38 INFO - mozleak == 0.1 13:16:38 INFO - mozlog == 3.4 13:16:38 INFO - moznetwork == 0.27 13:16:38 INFO - mozprocess == 0.23 13:16:38 INFO - mozprofile == 0.28 13:16:38 INFO - mozrunner == 6.12 13:16:38 INFO - mozscreenshot == 0.1 13:16:38 INFO - mozsystemmonitor == 0.3 13:16:38 INFO - moztest == 0.7 13:16:38 INFO - mozversion == 1.4 13:16:38 INFO - psutil == 3.1.1 13:16:38 INFO - requests == 1.2.3 13:16:38 INFO - wsgiref == 0.1.2 13:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:38 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')]} 13:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 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')]} 13:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:38 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 13:16:38 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 13:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:38 INFO - 'HOME': '/Users/cltbld', 13:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:38 INFO - 'LOGNAME': 'cltbld', 13:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:38 INFO - 'MOZ_NO_REMOTE': '1', 13:16:38 INFO - 'NO_EM_RESTART': '1', 13:16:38 INFO - 'PAGER': '/bin/cat', 13:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:38 INFO - 'PWD': '/builds/slave/test', 13:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:38 INFO - 'SHELL': '/bin/bash', 13:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:38 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:38 INFO - 'USER': 'cltbld', 13:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:38 INFO - 'XPC_FLAGS': '0x0', 13:16:38 INFO - 'XPC_SERVICE_NAME': '0', 13:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 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)) 13:16:38 INFO - Cleaning up... 13:16:38 INFO - Return code: 0 13:16:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:16:38 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')]} 13:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 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')]} 13:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:38 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 0x103556490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa703cbc470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, '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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 13:16:38 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 13:16:38 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 13:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:38 INFO - 'HOME': '/Users/cltbld', 13:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:38 INFO - 'LOGNAME': 'cltbld', 13:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:38 INFO - 'MOZ_NO_REMOTE': '1', 13:16:38 INFO - 'NO_EM_RESTART': '1', 13:16:38 INFO - 'PAGER': '/bin/cat', 13:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:38 INFO - 'PWD': '/builds/slave/test', 13:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:38 INFO - 'SHELL': '/bin/bash', 13:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:16:38 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:38 INFO - 'USER': 'cltbld', 13:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:38 INFO - 'XPC_FLAGS': '0x0', 13:16:38 INFO - 'XPC_SERVICE_NAME': '0', 13:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:16:39 INFO - Cleaning up... 13:16:39 INFO - Return code: 0 13:16:39 INFO - Running post-action listener: _resource_record_post_action 13:16:39 INFO - Running post-action listener: _start_resource_monitoring 13:16:39 INFO - Starting resource monitoring. 13:16:39 INFO - [mozharness: 2016-09-27 20:16:39.146338Z] Finished create-virtualenv step (success) 13:16:39 INFO - [mozharness: 2016-09-27 20:16:39.147348Z] Running install step. 13:16:39 INFO - Running pre-action listener: _resource_record_pre_action 13:16:39 INFO - Running main action method: install 13:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:39 INFO - Reading from file tmpfile_stdout 13:16:39 INFO - Detecting whether we're running mozinstall >=1.0... 13:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:16:39 INFO - Reading from file tmpfile_stdout 13:16:39 INFO - Output received: 13:16:39 INFO - Usage: mozinstall [options] installer 13:16:39 INFO - Options: 13:16:39 INFO - -h, --help show this help message and exit 13:16:39 INFO - -d DEST, --destination=DEST 13:16:39 INFO - Directory to install application into. [default: 13:16:39 INFO - "/builds/slave/test"] 13:16:39 INFO - --app=APP Application being installed. [default: firefox] 13:16:39 INFO - mkdir: /builds/slave/test/build/application 13:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:17:13 INFO - Reading from file tmpfile_stdout 13:17:13 INFO - Output received: 13:17:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:17:13 INFO - Running post-action listener: _resource_record_post_action 13:17:13 INFO - [mozharness: 2016-09-27 20:17:13.461908Z] Finished install step (success) 13:17:13 INFO - [mozharness: 2016-09-27 20:17:13.462042Z] Running run-tests step. 13:17:13 INFO - Running pre-action listener: _resource_record_pre_action 13:17:13 INFO - Running main action method: run_tests 13:17:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:17:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:17:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:17:13 INFO - 2016-09-27 13:17:13.476 screenresolution[1644:8405] starting screenresolution argv=screenresolution get 13:17:13 INFO - 2016-09-27 13:17:13.479 screenresolution[1644:8405] Display 0: 1600x1200x32@60 13:17:13 INFO - 2016-09-27 13:17:13.484 screenresolution[1645:8407] starting screenresolution argv=screenresolution list 13:17:13 INFO - Available Modes on Display 0 13:17:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:17:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:17:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:17:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:17:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:17:13 INFO - Intel Iris: 13:17:13 INFO - Chipset Model: Intel Iris 13:17:13 INFO - Type: GPU 13:17:13 INFO - Bus: Built-In 13:17:13 INFO - VRAM (Dynamic, Max): 1536 MB 13:17:13 INFO - Vendor: Intel (0x8086) 13:17:13 INFO - Device ID: 0x0a2e 13:17:13 INFO - Revision ID: 0x0009 13:17:13 INFO - Displays: 13:17:13 INFO - Display: 13:17:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:17:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:17:13 INFO - Display Serial Number: 1600x1200 60 13:17:13 INFO - Main Display: Yes 13:17:13 INFO - Mirror: Off 13:17:13 INFO - Online: Yes 13:17:13 INFO - Rotation: Supported 13:17:13 INFO - Return code: 0 13:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:13 INFO - Python 2.7.3 13:17:13 INFO - Return code: 0 13:17:13 INFO - grabbing minidump binary from tooltool 13:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10336ad30>, '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 0x103190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103362b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:17:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:17:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:17:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:13 INFO - Return code: 0 13:17:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:17:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:17:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 13:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --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 13:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r8Av59Bl3i/Render', 13:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:13 INFO - 'HOME': '/Users/cltbld', 13:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:13 INFO - 'LOGNAME': 'cltbld', 13:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:13 INFO - 'MOZ_NO_REMOTE': '1', 13:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:13 INFO - 'NO_EM_RESTART': '1', 13:17:13 INFO - 'PAGER': '/bin/cat', 13:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:13 INFO - 'PWD': '/builds/slave/test', 13:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:13 INFO - 'SHELL': '/bin/bash', 13:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qSxyUmcMf5/Listeners', 13:17:13 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 13:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:13 INFO - 'USER': 'cltbld', 13:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:13 INFO - 'XPC_FLAGS': '0x0', 13:17:13 INFO - 'XPC_SERVICE_NAME': '0', 13:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 13:17:14 INFO - mozversion application_buildid: 20160927101220 13:17:14 INFO - mozversion application_changeset: f148d84038400a368315d1d0391ed0ea498ca676 13:17:14 INFO - mozversion application_display_name: Nightly 13:17:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:14 INFO - mozversion application_name: Firefox 13:17:14 INFO - mozversion application_remotingname: firefox 13:17:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:17:14 INFO - mozversion application_vendor: Mozilla 13:17:14 INFO - mozversion application_version: 52.0a1 13:17:14 INFO - mozversion platform_buildid: 20160927101220 13:17:14 INFO - mozversion platform_changeset: f148d84038400a368315d1d0391ed0ea498ca676 13:17:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:17:14 INFO - mozversion platform_version: 52.0a1 13:17:14 INFO - using testdate: 1475007434 13:17:14 INFO - actual date: 1475007434 13:17:14 INFO - starting webserver on 'localhost:49274' 13:17:14 INFO - SUITE-START | Running 2 tests 13:17:14 INFO - TEST-START | dromaeo_css 13:17:14 INFO - operating with platform_type : mac_ 13:17:14 INFO - Initialising browser for dromaeo_css test... 13:17:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpDHZYyS/profile http://localhost:49274/getInfo.html) 13:17:16 INFO - PROCESS | 1655 | 2016-09-27 13:17:16.964 plugin-container[1658:8585] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 13:17:16 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:17:16 INFO - PROCESS | 1655 | 2016-09-27 13:17:16.967 plugin-container[1658:8585] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 13:17:16 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:17:16 INFO - PROCESS | 1655 | 2016-09-27 13:17:16.967 plugin-container[1658:8585] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:17:17 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 13:17:17 INFO - PROCESS | 1655 | colorDepth:24 13:17:17 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 13:17:17 INFO - PROCESS | 1655 | __metrics 13:17:17 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:17:17 INFO - TEST-INFO | 1655: exit 0 13:17:17 INFO - Browser initialized. 13:17:17 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:17 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpDHZYyS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:20 INFO - PROCESS | 1659 | 2016-09-27 13:17:20.089 plugin-container[1660:8698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8613, name = 'com.apple.tsm.portname' 13:17:20 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:17:20 INFO - PROCESS | 1659 | 2016-09-27 13:17:20.092 plugin-container[1660:8698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.CFPasteboardClient' 13:17:20 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:17:20 INFO - PROCESS | 1659 | 2016-09-27 13:17:20.092 plugin-container[1660:8698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:17:29 INFO - PROCESS | 1659 | RSS: Main: 239984640 13:17:29 INFO - PROCESS | 1659 | 13:18:19 INFO - PROCESS | 1659 | 1475007499452 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:20:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 13:20:32 INFO - PROCESS | 1659 | RSS: Main: 253358080 13:20:32 INFO - PROCESS | 1659 | 13:23:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 13:23:35 INFO - PROCESS | 1659 | RSS: Main: 264085504 13:23:35 INFO - PROCESS | 1659 | 13:26:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 13:26:37 INFO - PROCESS | 1659 | RSS: Main: 270237696 13:26:37 INFO - PROCESS | 1659 | 13:29:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 13:29:40 INFO - PROCESS | 1659 | RSS: Main: 270045184 13:29:40 INFO - PROCESS | 1659 | 13:32:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 13:32:43 INFO - PROCESS | 1659 | RSS: Main: 275427328 13:32:43 INFO - PROCESS | 1659 | 13:35:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 13:35:47 INFO - PROCESS | 1659 | RSS: Main: 278175744 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | __start_tp_report 13:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 13:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 13:35:47 INFO - PROCESS | 1659 | |i|pagename|runs| 13:35:47 INFO - PROCESS | 1659 | |0;dojo.html;3340.749443791715;3384.2554637979642;3402.77881937674;3412.931741365173;3430.4682774170014;5578.721063946807;5613.522850557702;5639.4924456798935;5656.943430565703;5772.913406298909;5572.832815015546;5662.688552129631;5762.394948530417;5765.6540607563575;5780.739866705998;4730.834420795273;4911.673848061021;5165.664231824938;5178.016176926372;5242.711650859202;5207.895842083156;5302.284191634138;5316.308879845634;5323.174907889264;5388.568914486851;5101.744912754348;5165.147750621143;5179.04187725272;5234.214867769827;5239.685618862881;4289.270823959903;5181.455947125535;5237.554807841338;5249.396319423277;5285.392179899322;5168.53483186515;5194.844154675366;5206.349206349207;5216.634835561512;5266.34170728659;5596.664200148004;5604.551635869121;5637.379888212294;5738.512226460756;5763;6002.699865006776;6029.944759667084;6116.761878222105;6207.379262073801;6242.344553821874;5631.155326701028;6127.754333119592;6256.499480041586;6257.155284036642;6261.279952805395;5530.723463826793;5598.720063996784;5676.921384936849;5747.712614369265;5851.063829787214;5146.974265128651;5269.288646032813;6022.849428764228;6184.938150618526;6196.0705894116245;5391.32608423947;6081.422264884829;6085.695715214221;6153.476954458832;6175.228096487939;5765.85585360361;6055.576109672281;6234.220722409699;6264.154339164245;6291.748330066837;6046.395360463918;6110.953680641517;6139.8601398601395;6196.47329976948;6234.657093859791;6099.146119543268;6125;6133.6319820810895;6171.907421388682;6250.968745156245;4909.386326709161;4916.237983112624;4923.335349727812;4930.630202734809;4946.208606622923;4347.3261644445165;4357.411749413788;4392.07766369066;4399.988002759384;4505.909881802346;5802.796902108406;5823.5923485355615;5853.824385268449;5860.736266868002;5920.526357891358;6145.170401995673;6168.8766224675255;6190.288116866528;6213.316535181127;6217.4715149212825;5297.702062994591;5741.110127930094;5801.187833703285;5814.738336774855;5874.206982057453;4130.876073717794;4809.78355973982;5385.111456609616;5390.460953904657;5433.239346491494;5165.276861239429;6243.313235544087;6256.937430625727;6267.96866015667;6281;6100.460065610241;6177.011678131477;6178.135061091541;6238.937610623836;6255.24937007562;6160.414760597736;6209.441150296495;6311.873762524632;6317.241930968313;6320;6150.015997440388;6176.227971503562;6180.6909654517995;6182.536309776695;6216.627002379872;6109.435031337353;6158.661273629993;6235.594686345373;6270.529710271657;6295.874082518416;6088.6042407243385;6124.755009799558;6139.26328840542;6145.201123853871;6163.506919446344;6100.115483254992;6121.357257488078;6131.570790044654;6161.353057928853;6209.223847019122;5748.626339287933;5774.942250577608;5781.739821707949;5881.882362352814;6022.789202377896;6074.3259751981095;6118.755249789959;6145.231846019247;6178.752849885954;6194.845128871634;5978.252718410199;5991.460768530853;5993.130996005642;6029.276486821609;6030.728617212324 13:35:47 INFO - PROCESS | 1659 | |1;ext.html;439.18969501270146;475.745476170249;478.6912441475248;523.0376107961351;554.9528290095342;38636.806815965916;40852.5701600444;40885.79557102214;40981.79509102458;43500.56499435005;43427.56572434275;43646.56353436472;43942.90142746433;43953;43988.78005609968;9699.563519641615;9908.900910990906;9920.40477571348;9945.005499450033;9948.502574871263;7406.481546291735;8283.461574997636;9627.652128701988;9733.318667693264;9876.901230987705;8304.833903321929;8337.874931876027;8424.789380265482;9891.208703303719;9930.205583553334;9840.360376575536;9859.704208873782;9861.60553577856;9885.604575816958;9920.404775713409;9759.560819763128;9815.362001469954;9825.312228144032;9852.408855468695;9886.653967111117;41014.1797164058;41492.170156597;41527.754167375024;41560.1687966239;41638.375424368656;3497.930041399183;3545.308664810363;3579.7494175407733;3937.370020796659;3943;30833.691663083308;31900;31912.680873191435;31937.84031079853;32541.83729081363;2790.6232658591034;3229.46713792224;3263.0863358259726;3279.4097062528735;3381.7970921744773;506665;516385;516841;518558;518991.9999999962;57641.13538296929;57985;58046.129308060415;58058;58216;31364.37271254562;31669.841650791597;32000.03999880007;32127.03618891437;32133.51799723006;16063.518094456951;16072.196390180445;16207.513774586781;16280.185990700418;16333.591660208589;12441.93779031117;12540.874591254153;12545.184563003559;12546.309952952675;12616.55842045524;18737.437876863714;18887.08935676734;19108.949007804706;19125.23499060022;19134.808651913303;6772.37677842352;7902.209779022051;7979.561124138112;8010;8076.859632197473;849.4987957105337;924.4453328003144;966.7341481092615;970.5826494607387;1012.2711647613706;28876.711232887403;29193.85403072971;30170.24574385658;30382.240443988634;30841.537376939363;996.3573495095768;1022.2384323678907;1057.0856209378833;1069.1607088435542;1141.3323205924462;11606.76786464266;13895.444182232597;15470;15488;15797.289121989537;682267;683803;691030;691289;692278;56425.71787141038;57109.14336284959;57444.71277643585;57709;57803.421965780646;1322.5899971009019;1360.415021540747;1381.6062422209823;1396.5880065380736;1403.635054885737;28304.575431368135;29101.708982910746;29265.85367073151;29719.40561188721;29905.401891961603;47829.521704782506;47967.04065918732;48365.5163448361;48493.75753121353;48551.028979419505;569204;577434;577478;580187;581440;26236.73763262343;26637.467250654492;26655;26685.86657066702;26712.19863404101;46982.29526557036;47193.292100619205;47270.76364618155;47430.76284618555;47993.76003119962;31969.36061278715;39157.02107447223;39268.018299541596;40614;40686.982825428415;38908.22183556257;39229.80385098056;39462.80268598639;40088.59911400849;40682.389764154155;38210.04474888039;38649.61350386572;38917;38943.805280973414;38980;32385;34114.82942585271;34631.480527792606;34824.65175348214;34836.651633484355;25600.487990240465;25718.31561529691;25882.35294117662;25955.48089038171;26149.477010459304 13:35:47 INFO - PROCESS | 1659 | |2;jquery.html;300.71732571382904;377.8073182676834;378.78220023486494;386.1523954918954;410.8373303550951;18990.62018759624;19397.612047759056;20354;20503.794962050375;20800.47998800031;16799.580010499743;20478.873661948586;20640.483987900272;20953.790462095374;21001.68497472539;5808.912866307009;5893.499052580525;6054.545909056838;6069.78755743549;6125.356837532062;5948.434898684618;6027.9752442084955;6054.33402325746;6078.270607527103;6132.570720049598;5761.337446193678;5841;5893.086571581412;5971.492423144016;5997.580169388123;5890.823275301726;5945.821625351246;5949.583529152961;5957.791477298296;5976.043832986723;5099.872503187413;5183.948160518385;5389.353277606673;5454.509094181542;5510.283663123768;13299.601011969657;13371.933140334333;13525.39135738894;22178.33464996053;24778.876105619536;2032.3598066609118;2097.0877668214225;2136.6794980752857;2164.653655415126;2197.9884169499405;9797.853032204523;10031.097201251923;10645.893541064568;15031.549053528412;15671.216439177995;1777.644471105784;1893.867429279951;1898.1173754204224;1903.847692184622;1943.7473128493348;87622;114916.42541787238;116148;117566;118345;11278.379689117013;11328.660140195807;11421.314721116594;11593.942030289794;11614.941925290488;14109.365078571489;14121.2233327168;14131.222782747047;14133.293335333397;14168.937329700108;8271.54506502148;8325.708600198965;8424.663013479392;8430.957845210734;8573.014103378191;8287.875681864776;8341.082480927093;8367.121452247547;8501.767243749746;8503.705628657488;4482.148391805612;4532.9546704533195;4536.410266665378;4559.475660299042;4621.953780462152;1926.2198809482181;1971.112999150388;1971.714101455281;1978.060421299871;1979.8614097013071;878.3675753457501;924.2144177449114;965.5510187762584;993.9950300248453;997.3816233935007;19885.60228795416;21185.046672899756;21359;21558.880548789457;21647.35057948264;876.6718421591295;903.5437104262437;916.4272329793879;955.5938726041404;999.6900960702205;8014.639341229658;11202.159838012181;11289.548418063185;11313.71715707114;11351.375674337825;518106;574590;581707;586769;587158;82516;105868;121795.39102304609;123193;124303;874.7375787263795;947.9431234125836;986.3736527305069;1004.0311099788739;1008.8587597736176;18610.813891860907;18750.906245468686;19027;19102.617947641247;19114.01727775825;50428.74785626048;50434.49565504298;50840.98318033692;51107.722306942625;51378.74310628423;58030.54923626943;73009;74106.25893740993;74135;74820;7543.509671871311;7976.242256985577;7986;8024.518528888286;8281.50310981319;6826.863462730618;10058.49707514636;10255.28213025111;12027.037836972846;12828.743425131632;9067.419303545958;10536.57853685844;10643.148548116287;11088;11213.66359009231;10560.84158737635;10660.89339106599;10778.73053173677;11210.775784484427;11472;8917.643294268157;10835.530529859567;11274.210805243554;11618.825717614412;11671.01592729221;5812.651240925558;7029.226785053742;7369.115706115301;7652.65563049653;8436.072032076589;11297.661070167907;11388.316700997966;11399.715007124889;11680.94159529197;11780.05759539252 13:35:47 INFO - PROCESS | 1659 | |3;mootools.html;1482.5700546841415;1529.380600856653;1763.3123081998015;1830.5149135479091;1907.608940167266;6974.8605027899475;7978.321842643382;8236.794080148;9108.863367049491;9136.451812891222;8502.914970850305;8839.867401988975;8889.333300002509;8950.194482496574;8957.46255224687;2381.1070848431837;2410.337157281744;2410.6384042393606;2411.46947671512;2414.7343792182846;2363.1728894886824;2383.30884043628;2398.772116648924;2416.8187385946035;2420.394901274681;2373.252425485975;2387.092904696213;2392.473655795731;2414.7585241475886;2420.7700268474555;2361.7520160383256;2374.489484760776;2383.797377222938;2388.1880160745345;2391.1869964212165;2366.585847476702;2377.239283429303;2378.797802186816;2382.9515013394052;2394.4013996500876;8897.73306800797;9006;9033.277337812959;9056.320775941766;9092.727218183465;4292;4460.754658493782;4759.976200118977;5057.544820966131;5384.488473595002;2893.6382952130984;3578.1949061461223;3621.9456708149137;3677.264547090566;3695.63043695631;942.886853577575;1032.803767284221;1064.3454275620516;1088.0099109810114;1090.9563617455292;10024.649137280234;11721.648350549412;11832.408379581073;11944.820827687592;11952.880471195263;4468.798904049326;4590.357349971006;4733.692309999908;4858.5384388483035;4864.36763220779;9024.368294219474;10143.28996970205;10204.38773673567;10210.846837297446;10212.948935255276;5350.197470379397;5423.918641220384;5428.4842939920645;5431.8098866539485;5436.972815135978;4421.778911054499;4613.700109492872;4771.809127634856;4897.99591083827;4966.950330496721;3933.4689816874356;3981.880543583697;4040.676745860324;4074.409210664437;4101.318459431619;1277.3357853916098;1287.3048553780854;1290.1227165527532;1293.4502836294537;1296.6887946892678;789.6407134753673;910.7723069232692;912.3841407050214;912.5802131019673;917.1699611851285;5956.344802071769;5995.160677505153;6027.78902738402;6078.817635470943;6313.96843015782;870.6038752367657;889.3596610440472;920.0983036624145;933.0343094896749;934.8130373925242;3798.981005094957;3813.237352529505;3816.46569480273;4094.467719196485;4147.149834283965;10487.790244195074;10712;10771.515281812337;10839.891601084046;10846.403447810288;10872.67381978542;10994.670159895217;11019.118470522339;11049.779004419866;11080.39057851826;8008.559529225832;8058.11360750317;8283.006039275326;8287.62705678246;8309.542975136426;5796.797112101056;5797.565182611405;5916.083007133901;5957.314908785545;5977.641341519523;10146.441945693057;10164.644237451654;10202.540885660312;10211.927747586396;10226.948865255627;9919.65281215154;10413.219008574235;10422;10511.632092876713;10552.894471055499;7042.401395881203;7256.9274307256255;7480.70077196906;7677.808054798675;7878.330341921001;8441.577921104043;8498.830023399621;8634.266087382643;8651.351148663749;8664.35017373687;7481.588512631857;7664.578448185403;7676.040494938133;7693.230676932262;7778.455508114378;6521.673916304071;7447.515911465737;7520.360769334449;7613.276738709814;7640.159582445815;6798.52410331272;6882.518223724292;6942.722291108299;6945.756898508528;6947.027416161641;4820.517948205152;5149.639525233198;5222.55608273301;5254.474552544715;5363.302770639792;4361.433013708198;4707.176244157327;5137.869668672886;5269.104252277199;5350.197470379474 13:35:47 INFO - PROCESS | 1659 | |4;prototype.html;304.96950304969505;309.92406860319227;317.97453213386825;319.0874100073787;319.23702351380206;4840.951590484094;5503.6147469677135;5671;5735.827925162246;5775.855603609917;4566.497685254628;5396.730163491829;5599.580031497644;5613.80351687691;5617.747201375938;4249.107687385653;4250.681198910079;4254.829806807724;4262.87211383659;4290.4422425084695;4150.709450338478;4248.320268756999;4264.701470897023;4295.914081718363;4315.719478233905;3463.5843698756184;3693.3905905525558;4201.642860356858;4220.936685949698;4267.91464170718;4226.429432026684;4249.532551419341;4259.914801703964;4262.740747403881;4301.451477468109;3683.7291134558536;3685.299793039314;3693.8707145250055;3707.814609269553;3712.2018765965176;5057.825135191866;5128.615353848439;5486.6982315973;5506.091494903336;5512.724363781835;4158.438610787535;4775.713457192544;4870.975645121787;4874.268859671042;4924.261360795909;5538.390777014565;5847.386024467455;5855.3851845556455;5874.530037596982;5888.322842873039;3927.7234898657766;3941.073847645801;3954.2882281189372;3957.920841583181;4002.819873105688;5339.759710813023;5591.329040515164;5914.4381283777975;6092.329843717232;6174;3045.9847700761356;3847.9230415391535;4001.4598029265676;4018.5687658965903;4044.6157615026527;3523.806190659487;3680.613535578779;4057.4522439470293;4073.816678249486;4120.7321524100835;4802.73584952831;4813.772488015534;4826.517348265145;4843.346148270009;4853.635977301646;5988.610740301867;5989.970050149808;6019.518438524908;6019.518438524908;6103.877922441527;1265.4938024790158;1302.768883405173;1327.6813564744584;1382.4055656067787;1404.4663028049276;766.8849672549162;813.9715109971122;826.1903334731996;831.9584020798936;856.3919617071949;4173.582641735802;4588.564086411786;4678.508756580578;4724.480307166209;4780.713157210509;4336.501302350207;5150.819721309736;5187.974060129751;5198.766055527511;5207.921881171786;4642.46611639659;4687.6249900007915;4694.737157675451;4713.434387873409;4740.834070807505;2500.6249062640386;3166.970734511293;3210.8761933323617;3218.839058047135;3235.9191020224685;6306.936930630635;6343.27052388972;6391.146567495467;6433.166547534024;6465.612063276124;4772.427308722976;5936.901673190474;6021.337652858182;6162.5378096642935;6208.844778880564;6158.904328621416;6196.287426945959;6264.21697287839;6276.184096067482;6305.243370795534;5693.971530142323;5992.760289588367;6074.939250607437;6099.4815440688035;6138.224991630204;5481.835544933659;5640.559258852179;5945.613535120204;5964.940350596438;6012.849678757891;5497.752601133038;5985.162077309267;6039.73165635204;6270.780522681866;6326.746930122744;3291.8683252670585;3507.5615548056494;3800.389629851597;3846.7307288489537;3942.955116894083;4990.775415106402;5398.595105367034;5738.454846789548;5850.005499065084;6183.690815459119;4597.770111494478;4994.550490455877;5141.614378921521;5993.220881285405;6046.395360464095;4752.881177970578;5138.280640710229;5251.501107394792;5300.867478313073;5615.876824635171;4653.23221668421;5031.547160755549;5291.7618707159045;5790.739416726173;5809.419058094157;5737.540996720336;5744.798932037359;5818.534517238695;5841.4450627190345;5909.52723782105;5019;5029.899402011866;5304.496072873071;5419.585661033524;5791.625433572215 13:35:47 INFO - PROCESS | 1659 | |5;yui.html;708.1431467923812;759.6391713935881;776.40604937223;788.8934993775839;806.9475484093535;15402.84597154028;16322.836771632281;16340.428085017027;16344.754828677549;16354;14760;14904.478343257988;14923.104613723157;14929.253537323144;14930.701385972274;635.1425575473121;665.0888283052225;781.468601351081;788.5623478969155;826.4586695714316;809.6518497046268;813.495632707722;819.3731795176694;819.848328059308;821.3839620284787;860.1226748716306;867.6009035843488;869.6390997735932;873.0483772687769;876.1851478125341;823.7322870067193;828.6850996621306;855.820277741675;864.2265172670457;874.2394117118116;611.7430679114782;625.4589779840451;638.5913015669975;641.8876696578127;647.5499527828161;14919.701605967819;15224.010439321408;15234.847651523565;15237.780977521772;15268.31292591825;14474.842012638963;14540.563783086523;14558.199299038548;14577;14652.633684157874;11686.201809990835;11719.06247500198;11863.58477453285;11942.462589183508;12258.325792081432;3767.723237105533;3848.288066707668;3850.383938569815;3863.2273545291055;3988.022934381066;121536;123997;125550.11674824885;126300.36849815784;126813;11281.492332845042;11317.603883864025;11338.43307834605;11471.4264286787;11682.824757628472;19625.803741962398;23300;23502;23805.880970595037;23829.642555361683;7919.247671471201;8110.3511719062335;8197.262246397853;8304.211099945616;8313.12712165226;4499.482559505699;4533.5013148553635;4549.249373853278;4581.908361832811;4694.530546945346;3529.629388914127;3585.587657419378;3637.727170462226;3643.3259846928404;3672.4491326300736;594.694645253664;598.3478008970243;648.1282674802384;648.6400047973326;660.4584240922397;478.1894688503024;515.0078046549559;618.0667192539208;628.8585068359674;630.5649102119523;9364.15722584957;9427.811443771086;9544.756982109198;9684.837819461569;9707.514624268759;533.0511689193243;542.9511343979061;583.4078410413434;590.4774274766862;612.8774245150987;4075.836966521306;4192;4248.87253382399;4265.573442655709;4305.634021108178;99480;119767;126818.36590816987;146659;156598.43401566066;100937.99062009285;103794.96205038004;115495.84504154851;139384.30307848597;143076;120938;122272;123296;125480;126468.99999999817;8932.374733768835;9093.77265568366;9133.086691330815;9173.266138709021;9333.533323333942;57183;66810.66594666995;67485.32514674986;67732;68279;87664.5616771912;88556.11443885736;94162;98583;101768.47347289945;12018.879811202125;12021.038316934799;12385.93807030959;12440.066994975232;12587.67109601366;13003.219806811621;13062.738745224851;13285.66785830362;13403.262820544964;13833.170009799444;9773.657921972697;12093.697657558632;12317.199382040139;12364.690882728004;12651.55719549848;12179.147459677737;12412.751744965231;12631;12647.936760316139;12724.300163491096;12213.206141600767;12379.69050773738;12523.56167534132;12607.180533265675;12642.367881605698;9234.353595248269;10278.743031424274;10530.315529490865;10564.947175264075;10677.359358438518;7400.494425304968;9638.42169469834;9714.514274286399;10589.099926506333;10637.680869573926 13:35:47 INFO - PROCESS | 1659 | __end_tp_report 13:35:47 INFO - PROCESS | 1659 | __start_cc_report 13:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,355 13:35:47 INFO - PROCESS | 1659 | __end_cc_report 13:35:47 INFO - PROCESS | 1659 | __startTimestamp1475008547012__endTimestamp 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | ------- Summary: start ------- 13:35:47 INFO - PROCESS | 1659 | Number of tests: 6 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5683.39 Median:5874.21 stddev:649.80 (11.1%) stddev-sans-first:625.26 13:35:47 INFO - PROCESS | 1659 | Values: 3340.7 3384.3 3402.8 3412.9 3430.5 5578.7 5613.5 5639.5 5656.9 5772.9 5572.8 5662.7 5762.4 5765.7 5780.7 4730.8 4911.7 5165.7 5178.0 5242.7 5207.9 5302.3 5316.3 5323.2 5388.6 5101.7 5165.1 5179.0 5234.2 5239.7 4289.3 5181.5 5237.6 5249.4 5285.4 5168.5 5194.8 5206.3 5216.6 5266.3 5596.7 5604.6 5637.4 5738.5 5763.0 6002.7 6029.9 6116.8 6207.4 6242.3 5631.2 6127.8 6256.5 6257.2 6261.3 5530.7 5598.7 5676.9 5747.7 5851.1 5147.0 5269.3 6022.8 6184.9 6196.1 5391.3 6081.4 6085.7 6153.5 6175.2 5765.9 6055.6 6234.2 6264.2 6291.7 6046.4 6111.0 6139.9 6196.5 6234.7 6099.1 6125.0 6133.6 6171.9 6251.0 4909.4 4916.2 4923.3 4930.6 4946.2 4347.3 4357.4 4392.1 4400.0 4505.9 5802.8 5823.6 5853.8 5860.7 5920.5 6145.2 6168.9 6190.3 6213.3 6217.5 5297.7 5741.1 5801.2 5814.7 5874.2 4130.9 4809.8 5385.1 5390.5 5433.2 5165.3 6243.3 6256.9 6268.0 6281.0 6100.5 6177.0 6178.1 6238.9 6255.2 6160.4 6209.4 6311.9 6317.2 6320.0 6150.0 6176.2 6180.7 6182.5 6216.6 6109.4 6158.7 6235.6 6270.5 6295.9 6088.6 6124.8 6139.3 6145.2 6163.5 6100.1 6121.4 6131.6 6161.4 6209.2 5748.6 5774.9 5781.7 5881.9 6022.8 6074.3 6118.8 6145.2 6178.8 6194.8 5978.3 5991.5 5993.1 6029.3 6030.7 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:71453.18 Median:40769.78 stddev:160094.21 (392.7%) stddev-sans-first:160454.53 13:35:47 INFO - PROCESS | 1659 | Values: 439.2 475.7 478.7 523.0 555.0 38636.8 40852.6 40885.8 40981.8 43500.6 43427.6 43646.6 43942.9 43953.0 43988.8 9699.6 9908.9 9920.4 9945.0 9948.5 7406.5 8283.5 9627.7 9733.3 9876.9 8304.8 8337.9 8424.8 9891.2 9930.2 9840.4 9859.7 9861.6 9885.6 9920.4 9759.6 9815.4 9825.3 9852.4 9886.7 41014.2 41492.2 41527.8 41560.2 41638.4 3497.9 3545.3 3579.7 3937.4 3943.0 30833.7 31900.0 31912.7 31937.8 32541.8 2790.6 3229.5 3263.1 3279.4 3381.8 506665.0 516385.0 516841.0 518558.0 518992.0 57641.1 57985.0 58046.1 58058.0 58216.0 31364.4 31669.8 32000.0 32127.0 32133.5 16063.5 16072.2 16207.5 16280.2 16333.6 12441.9 12540.9 12545.2 12546.3 12616.6 18737.4 18887.1 19108.9 19125.2 19134.8 6772.4 7902.2 7979.6 8010.0 8076.9 849.5 924.4 966.7 970.6 1012.3 28876.7 29193.9 30170.2 30382.2 30841.5 996.4 1022.2 1057.1 1069.2 1141.3 11606.8 13895.4 15470.0 15488.0 15797.3 682267.0 683803.0 691030.0 691289.0 692278.0 56425.7 57109.1 57444.7 57709.0 57803.4 1322.6 1360.4 1381.6 1396.6 1403.6 28304.6 29101.7 29265.9 29719.4 29905.4 47829.5 47967.0 48365.5 48493.8 48551.0 569204.0 577434.0 577478.0 580187.0 581440.0 26236.7 26637.5 26655.0 26685.9 26712.2 46982.3 47193.3 47270.8 47430.8 47993.8 31969.4 39157.0 39268.0 40614.0 40687.0 38908.2 39229.8 39462.8 40088.6 40682.4 38210.0 38649.6 38917.0 38943.8 38980.0 32385.0 34114.8 34631.5 34824.7 34836.7 25600.5 25718.3 25882.4 25955.5 26149.5 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33024.46 Median:339.26 stddev:94885.57 (27968.2%) stddev-sans-first:95119.94 13:35:47 INFO - PROCESS | 1659 | Values: 300.7 377.8 378.8 386.2 410.8 18990.6 19397.6 20354.0 20503.8 20800.5 16799.6 20478.9 20640.5 20953.8 21001.7 5808.9 5893.5 6054.5 6069.8 6125.4 5948.4 6028.0 6054.3 6078.3 6132.6 5761.3 5841.0 5893.1 5971.5 5997.6 5890.8 5945.8 5949.6 5957.8 5976.0 5099.9 5183.9 5389.4 5454.5 5510.3 13299.6 13371.9 13525.4 22178.3 24778.9 2032.4 2097.1 2136.7 2164.7 2198.0 9797.9 10031.1 10645.9 15031.5 15671.2 1777.6 1893.9 1898.1 1903.8 1943.7 87622.0 114916.4 116148.0 117566.0 118345.0 11278.4 11328.7 11421.3 11593.9 11614.9 14109.4 14121.2 14131.2 14133.3 14168.9 8271.5 8325.7 8424.7 8431.0 8573.0 8287.9 8341.1 8367.1 8501.8 8503.7 4482.1 4533.0 4536.4 4559.5 4622.0 1926.2 1971.1 1971.7 1978.1 1979.9 878.4 924.2 965.6 994.0 997.4 19885.6 21185.0 21359.0 21558.9 21647.4 876.7 903.5 916.4 955.6 999.7 8014.6 11202.2 11289.5 11313.7 11351.4 518106.0 574590.0 581707.0 586769.0 587158.0 82516.0 105868.0 121795.4 123193.0 124303.0 874.7 947.9 986.4 1004.0 1008.9 18610.8 18750.9 19027.0 19102.6 19114.0 50428.7 50434.5 50841.0 51107.7 51378.7 58030.5 73009.0 74106.3 74135.0 74820.0 7543.5 7976.2 7986.0 8024.5 8281.5 6826.9 10058.5 10255.3 12027.0 12828.7 9067.4 10536.6 10643.1 11088.0 11213.7 10560.8 10660.9 10778.7 11210.8 11472.0 8917.6 10835.5 11274.2 11618.8 11671.0 5812.7 7029.2 7369.1 7652.7 8436.1 11297.7 11388.3 11399.7 11680.9 11780.1 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5750.05 Median:4746.83 stddev:3236.62 (68.2%) stddev-sans-first:3229.81 13:35:47 INFO - PROCESS | 1659 | Values: 1482.6 1529.4 1763.3 1830.5 1907.6 6974.9 7978.3 8236.8 9108.9 9136.5 8502.9 8839.9 8889.3 8950.2 8957.5 2381.1 2410.3 2410.6 2411.5 2414.7 2363.2 2383.3 2398.8 2416.8 2420.4 2373.3 2387.1 2392.5 2414.8 2420.8 2361.8 2374.5 2383.8 2388.2 2391.2 2366.6 2377.2 2378.8 2383.0 2394.4 8897.7 9006.0 9033.3 9056.3 9092.7 4292.0 4460.8 4760.0 5057.5 5384.5 2893.6 3578.2 3621.9 3677.3 3695.6 942.9 1032.8 1064.3 1088.0 1091.0 10024.6 11721.6 11832.4 11944.8 11952.9 4468.8 4590.4 4733.7 4858.5 4864.4 9024.4 10143.3 10204.4 10210.8 10212.9 5350.2 5423.9 5428.5 5431.8 5437.0 4421.8 4613.7 4771.8 4898.0 4967.0 3933.5 3981.9 4040.7 4074.4 4101.3 1277.3 1287.3 1290.1 1293.5 1296.7 789.6 910.8 912.4 912.6 917.2 5956.3 5995.2 6027.8 6078.8 6314.0 870.6 889.4 920.1 933.0 934.8 3799.0 3813.2 3816.5 4094.5 4147.1 10487.8 10712.0 10771.5 10839.9 10846.4 10872.7 10994.7 11019.1 11049.8 11080.4 8008.6 8058.1 8283.0 8287.6 8309.5 5796.8 5797.6 5916.1 5957.3 5977.6 10146.4 10164.6 10202.5 10211.9 10226.9 9919.7 10413.2 10422.0 10511.6 10552.9 7042.4 7256.9 7480.7 7677.8 7878.3 8441.6 8498.8 8634.3 8651.4 8664.4 7481.6 7664.6 7676.0 7693.2 7778.5 6521.7 7447.5 7520.4 7613.3 7640.2 6798.5 6882.5 6942.7 6945.8 6947.0 4820.5 5149.6 5222.6 5254.5 5363.3 4361.4 4707.2 5137.9 5269.1 5350.2 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4664.35 Median:5030.72 stddev:1461.02 (29.0%) stddev-sans-first:1428.01 13:35:47 INFO - PROCESS | 1659 | Values: 305.0 309.9 318.0 319.1 319.2 4841.0 5503.6 5671.0 5735.8 5775.9 4566.5 5396.7 5599.6 5613.8 5617.7 4249.1 4250.7 4254.8 4262.9 4290.4 4150.7 4248.3 4264.7 4295.9 4315.7 3463.6 3693.4 4201.6 4220.9 4267.9 4226.4 4249.5 4259.9 4262.7 4301.5 3683.7 3685.3 3693.9 3707.8 3712.2 5057.8 5128.6 5486.7 5506.1 5512.7 4158.4 4775.7 4871.0 4874.3 4924.3 5538.4 5847.4 5855.4 5874.5 5888.3 3927.7 3941.1 3954.3 3957.9 4002.8 5339.8 5591.3 5914.4 6092.3 6174.0 3046.0 3847.9 4001.5 4018.6 4044.6 3523.8 3680.6 4057.5 4073.8 4120.7 4802.7 4813.8 4826.5 4843.3 4853.6 5988.6 5990.0 6019.5 6019.5 6103.9 1265.5 1302.8 1327.7 1382.4 1404.5 766.9 814.0 826.2 832.0 856.4 4173.6 4588.6 4678.5 4724.5 4780.7 4336.5 5150.8 5188.0 5198.8 5207.9 4642.5 4687.6 4694.7 4713.4 4740.8 2500.6 3167.0 3210.9 3218.8 3235.9 6306.9 6343.3 6391.1 6433.2 6465.6 4772.4 5936.9 6021.3 6162.5 6208.8 6158.9 6196.3 6264.2 6276.2 6305.2 5694.0 5992.8 6074.9 6099.5 6138.2 5481.8 5640.6 5945.6 5964.9 6012.8 5497.8 5985.2 6039.7 6270.8 6326.7 3291.9 3507.6 3800.4 3846.7 3943.0 4990.8 5398.6 5738.5 5850.0 6183.7 4597.8 4994.6 5141.6 5993.2 6046.4 4752.9 5138.3 5251.5 5300.9 5615.9 4653.2 5031.5 5291.8 5790.7 5809.4 5737.5 5744.8 5818.5 5841.4 5909.5 5019.0 5029.9 5304.5 5419.6 5791.6 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24926.21 Median:3808.01 stddev:39849.94 (1046.5%) stddev-sans-first:39920.25 13:35:47 INFO - PROCESS | 1659 | Values: 708.1 759.6 776.4 788.9 806.9 15402.8 16322.8 16340.4 16344.8 16354.0 14760.0 14904.5 14923.1 14929.3 14930.7 635.1 665.1 781.5 788.6 826.5 809.7 813.5 819.4 819.8 821.4 860.1 867.6 869.6 873.0 876.2 823.7 828.7 855.8 864.2 874.2 611.7 625.5 638.6 641.9 647.5 14919.7 15224.0 15234.8 15237.8 15268.3 14474.8 14540.6 14558.2 14577.0 14652.6 11686.2 11719.1 11863.6 11942.5 12258.3 3767.7 3848.3 3850.4 3863.2 3988.0 121536.0 123997.0 125550.1 126300.4 126813.0 11281.5 11317.6 11338.4 11471.4 11682.8 19625.8 23300.0 23502.0 23805.9 23829.6 7919.2 8110.4 8197.3 8304.2 8313.1 4499.5 4533.5 4549.2 4581.9 4694.5 3529.6 3585.6 3637.7 3643.3 3672.4 594.7 598.3 648.1 648.6 660.5 478.2 515.0 618.1 628.9 630.6 9364.2 9427.8 9544.8 9684.8 9707.5 533.1 543.0 583.4 590.5 612.9 4075.8 4192.0 4248.9 4265.6 4305.6 99480.0 119767.0 126818.4 146659.0 156598.4 100938.0 103795.0 115495.8 139384.3 143076.0 120938.0 122272.0 123296.0 125480.0 126469.0 8932.4 9093.8 9133.1 9173.3 9333.5 57183.0 66810.7 67485.3 67732.0 68279.0 87664.6 88556.1 94162.0 98583.0 101768.5 12018.9 12021.0 12385.9 12440.1 12587.7 13003.2 13062.7 13285.7 13403.3 13833.2 9773.7 12093.7 12317.2 12364.7 12651.6 12179.1 12412.8 12631.0 12647.9 12724.3 12213.2 12379.7 12523.6 12607.2 12642.4 9234.4 10278.7 10530.3 10564.9 10677.4 7400.5 9638.4 9714.5 10589.1 10637.7 13:35:47 INFO - PROCESS | 1659 | -------- Summary: end -------- 13:35:47 INFO - PROCESS | 1659 | 13:35:47 INFO - TEST-INFO | 1659: exit 0 13:35:47 INFO - TEST-OK | dromaeo_css | took 1113626ms 13:35:47 INFO - TEST-START | kraken 13:35:47 INFO - operating with platform_type : mac_ 13:35:47 INFO - Initialising browser for kraken test... 13:35:47 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpJMAdSt/profile http://localhost:49274/getInfo.html) 13:35:50 INFO - PROCESS | 1671 | 2016-09-27 13:35:50.298 plugin-container[1672:11127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.tsm.portname' 13:35:50 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:50 INFO - PROCESS | 1671 | 2016-09-27 13:35:50.301 plugin-container[1672:11127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 13:35:50 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:50 INFO - PROCESS | 1671 | 2016-09-27 13:35:50.301 plugin-container[1672:11127] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:35:50 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 13:35:50 INFO - PROCESS | 1671 | colorDepth:24 13:35:50 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 13:35:50 INFO - PROCESS | 1671 | __metrics 13:35:50 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:35:51 INFO - TEST-INFO | 1671: exit 0 13:35:51 INFO - Browser initialized. 13:35:51 INFO - Running cycle 1/1 for kraken test... 13:35:51 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpJMAdSt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:53 INFO - PROCESS | 1673 | 2016-09-27 13:35:53.673 plugin-container[1674:11234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x851f, name = 'com.apple.tsm.portname' 13:35:53 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:53 INFO - PROCESS | 1673 | 2016-09-27 13:35:53.675 plugin-container[1674:11234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 13:35:53 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:53 INFO - PROCESS | 1673 | 2016-09-27 13:35:53.675 plugin-container[1674:11234] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:36:03 INFO - PROCESS | 1673 | RSS: Main: 239869952 13:36:03 INFO - PROCESS | 1673 | 13:36:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:06 INFO - PROCESS | 1673 | RSS: Main: 253476864 13:36:06 INFO - PROCESS | 1673 | 13:36:09 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 13:36:09 INFO - PROCESS | 1673 | RSS: Main: 261062656 13:36:09 INFO - PROCESS | 1673 | 13:36:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 13:36:13 INFO - PROCESS | 1673 | RSS: Main: 261713920 13:36:13 INFO - PROCESS | 1673 | 13:36:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 13:36:16 INFO - PROCESS | 1673 | RSS: Main: 263974912 13:36:16 INFO - PROCESS | 1673 | 13:36:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:18 INFO - PROCESS | 1673 | RSS: Main: 264359936 13:36:18 INFO - PROCESS | 1673 | 13:36:21 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:22 INFO - PROCESS | 1673 | RSS: Main: 264863744 13:36:22 INFO - PROCESS | 1673 | 13:36:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:26 INFO - PROCESS | 1673 | RSS: Main: 265244672 13:36:26 INFO - PROCESS | 1673 | 13:36:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 13:36:29 INFO - PROCESS | 1673 | RSS: Main: 265539584 13:36:29 INFO - PROCESS | 1673 | 13:36:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:32 INFO - PROCESS | 1673 | RSS: Main: 265019392 13:36:32 INFO - PROCESS | 1673 | 13:36:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:36:34 INFO - PROCESS | 1673 | RSS: Main: 265117696 13:36:34 INFO - PROCESS | 1673 | 13:36:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:37 INFO - PROCESS | 1673 | RSS: Main: 265125888 13:36:37 INFO - PROCESS | 1673 | 13:36:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:41 INFO - PROCESS | 1673 | RSS: Main: 265379840 13:36:41 INFO - PROCESS | 1673 | 13:36:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:36:44 INFO - PROCESS | 1673 | RSS: Main: 265453568 13:36:44 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 13:36:46 INFO - PROCESS | 1673 | RSS: Main: 267153408 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | __start_tp_report 13:36:46 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 13:36:46 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 13:36:46 INFO - PROCESS | 1673 | |i|pagename|runs| 13:36:46 INFO - PROCESS | 1673 | |0;ai-astar;117;116;114;115;118;116;115;116;115;117 13:36:46 INFO - PROCESS | 1673 | |1;audio-beat-detection;138;113;111;149;111;114;111;113;137;112 13:36:46 INFO - PROCESS | 1673 | |2;audio-dft;201;195;200;214;227;197;197;197;203;206 13:36:46 INFO - PROCESS | 1673 | |3;audio-fft;83;58;62;84;59;60;59;61;90;60 13:36:46 INFO - PROCESS | 1673 | |4;audio-oscillator;87;71;87;72;69;72;87;69;70;86 13:36:46 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;88;87;89;86;112;111;84;127;89;86 13:36:46 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;91;156;92;101;90;124;151;153;109 13:36:46 INFO - PROCESS | 1673 | |7;imaging-desaturate;91;90;96;107;102;92;152;148;99;131 13:36:46 INFO - PROCESS | 1673 | |8;json-parse-financial;57;57;57;57;58;58;59;57;59;58 13:36:46 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;69;76;72;83;75;70;62;96;70;80 13:36:46 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;87;87;89;87;87;86;87;95;109;110 13:36:46 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;136;138;150;148;156;164;165;141;171;140 13:36:46 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;169;172;168;170;172;171;175;176;172;175 13:36:46 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;65;68;67;69;69;66;68;66;68 13:36:46 INFO - PROCESS | 1673 | __end_tp_report 13:36:46 INFO - PROCESS | 1673 | __start_cc_report 13:36:46 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,903 13:36:46 INFO - PROCESS | 1673 | __end_cc_report 13:36:46 INFO - PROCESS | 1673 | __startTimestamp1475008606528__endTimestamp 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | ------- Summary: start ------- 13:36:46 INFO - PROCESS | 1673 | Number of tests: 14 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:1.20 (1.0%) stddev-sans-first:1.20 13:36:46 INFO - PROCESS | 1673 | Values: 117.0 116.0 114.0 115.0 118.0 116.0 115.0 116.0 115.0 117.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:113.50 stddev:14.48 (12.8%) stddev-sans-first:13.97 13:36:46 INFO - PROCESS | 1673 | Values: 138.0 113.0 111.0 149.0 111.0 114.0 111.0 113.0 137.0 112.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:203.70 Median:202.00 stddev:9.92 (4.9%) stddev-sans-first:10.48 13:36:46 INFO - PROCESS | 1673 | Values: 201.0 195.0 200.0 214.0 227.0 197.0 197.0 197.0 203.0 206.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:67.60 Median:61.50 stddev:12.64 (20.6%) stddev-sans-first:12.12 13:36:46 INFO - PROCESS | 1673 | Values: 83.0 58.0 62.0 84.0 59.0 60.0 59.0 61.0 90.0 60.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.00 stddev:8.46 (10.7%) stddev-sans-first:8.16 13:36:46 INFO - PROCESS | 1673 | Values: 87.0 71.0 87.0 72.0 69.0 72.0 87.0 69.0 70.0 86.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:86.50 stddev:15.01 (17.4%) stddev-sans-first:15.65 13:36:46 INFO - PROCESS | 1673 | Values: 88.0 87.0 89.0 86.0 112.0 111.0 84.0 127.0 89.0 86.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:123.00 stddev:27.76 (22.6%) stddev-sans-first:28.17 13:36:46 INFO - PROCESS | 1673 | Values: 93.0 91.0 156.0 92.0 101.0 90.0 124.0 151.0 153.0 109.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:90.50 stddev:23.85 (26.3%) stddev-sans-first:24.19 13:36:46 INFO - PROCESS | 1673 | Values: 91.0 90.0 96.0 107.0 102.0 92.0 152.0 148.0 99.0 131.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 13:36:46 INFO - PROCESS | 1673 | Values: 57.0 57.0 57.0 57.0 58.0 58.0 59.0 57.0 59.0 58.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:75.50 stddev:9.39 (12.4%) stddev-sans-first:9.68 13:36:46 INFO - PROCESS | 1673 | Values: 69.0 76.0 72.0 83.0 75.0 70.0 62.0 96.0 70.0 80.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:87.00 stddev:9.37 (10.8%) stddev-sans-first:9.73 13:36:46 INFO - PROCESS | 1673 | Values: 87.0 87.0 89.0 87.0 87.0 86.0 87.0 95.0 109.0 110.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:153.00 stddev:12.54 (8.2%) stddev-sans-first:12.08 13:36:46 INFO - PROCESS | 1673 | Values: 136.0 138.0 150.0 148.0 156.0 164.0 165.0 141.0 171.0 140.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:2.67 (1.6%) stddev-sans-first:2.60 13:36:46 INFO - PROCESS | 1673 | Values: 169.0 172.0 168.0 170.0 172.0 171.0 175.0 176.0 172.0 175.0 13:36:46 INFO - PROCESS | 1673 | 13:36:46 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.41 13:36:46 INFO - PROCESS | 1673 | Values: 69.0 65.0 68.0 67.0 69.0 69.0 66.0 68.0 66.0 68.0 13:36:46 INFO - PROCESS | 1673 | -------- Summary: end -------- 13:36:46 INFO - PROCESS | 1673 | 13:36:47 INFO - TEST-INFO | 1673: exit 0 13:36:47 INFO - TEST-OK | kraken | took 59630ms 13:36:47 INFO - SUITE-END | took 1173s 13:36:47 INFO - Completed test suite (00:19:33) 13:36:47 INFO - javascript benchmark 13:36:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7310.030425564115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.749443791715, 3384.2554637979642, 3402.77881937674, 3412.931741365173, 3430.4682774170014, 5578.721063946807, 5613.522850557702, 5639.4924456798935, 5656.943430565703, 5772.913406298909, 5572.832815015546, 5662.688552129631, 5762.394948530417, 5765.6540607563575, 5780.739866705998, 4730.834420795273, 4911.673848061021, 5165.664231824938, 5178.016176926372, 5242.711650859202, 5207.895842083156, 5302.284191634138, 5316.308879845634, 5323.174907889264, 5388.568914486851, 5101.744912754348, 5165.147750621143, 5179.04187725272, 5234.214867769827, 5239.685618862881, 4289.270823959903, 5181.455947125535, 5237.554807841338, 5249.396319423277, 5285.392179899322, 5168.53483186515, 5194.844154675366, 5206.349206349207, 5216.634835561512, 5266.34170728659, 5596.664200148004, 5604.551635869121, 5637.379888212294, 5738.512226460756, 5763.0, 6002.699865006776, 6029.944759667084, 6116.761878222105, 6207.379262073801, 6242.344553821874, 5631.155326701028, 6127.754333119592, 6256.499480041586, 6257.155284036642, 6261.279952805395, 5530.723463826793, 5598.720063996784, 5676.921384936849, 5747.712614369265, 5851.063829787214, 5146.974265128651, 5269.288646032813, 6022.849428764228, 6184.938150618526, 6196.0705894116245, 5391.32608423947, 6081.422264884829, 6085.695715214221, 6153.476954458832, 6175.228096487939, 5765.85585360361, 6055.576109672281, 6234.220722409699, 6264.154339164245, 6291.748330066837, 6046.395360463918, 6110.953680641517, 6139.8601398601395, 6196.47329976948, 6234.657093859791, 6099.146119543268, 6125.0, 6133.6319820810895, 6171.907421388682, 6250.968745156245, 4909.386326709161, 4916.237983112624, 4923.335349727812, 4930.630202734809, 4946.208606622923, 4347.3261644445165, 4357.411749413788, 4392.07766369066, 4399.988002759384, 4505.909881802346, 5802.796902108406, 5823.5923485355615, 5853.824385268449, 5860.736266868002, 5920.526357891358, 6145.170401995673, 6168.8766224675255, 6190.288116866528, 6213.316535181127, 6217.4715149212825, 5297.702062994591, 5741.110127930094, 5801.187833703285, 5814.738336774855, 5874.206982057453, 4130.876073717794, 4809.78355973982, 5385.111456609616, 5390.460953904657, 5433.239346491494, 5165.276861239429, 6243.313235544087, 6256.937430625727, 6267.96866015667, 6281.0, 6100.460065610241, 6177.011678131477, 6178.135061091541, 6238.937610623836, 6255.24937007562, 6160.414760597736, 6209.441150296495, 6311.873762524632, 6317.241930968313, 6320.0, 6150.015997440388, 6176.227971503562, 6180.6909654517995, 6182.536309776695, 6216.627002379872, 6109.435031337353, 6158.661273629993, 6235.594686345373, 6270.529710271657, 6295.874082518416, 6088.6042407243385, 6124.755009799558, 6139.26328840542, 6145.201123853871, 6163.506919446344, 6100.115483254992, 6121.357257488078, 6131.570790044654, 6161.353057928853, 6209.223847019122, 5748.626339287933, 5774.942250577608, 5781.739821707949, 5881.882362352814, 6022.789202377896, 6074.3259751981095, 6118.755249789959, 6145.231846019247, 6178.752849885954, 6194.845128871634, 5978.252718410199, 5991.460768530853, 5993.130996005642, 6029.276486821609, 6030.728617212324], "value": 5643.404575311896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.18969501270146, 475.745476170249, 478.6912441475248, 523.0376107961351, 554.9528290095342, 38636.806815965916, 40852.5701600444, 40885.79557102214, 40981.79509102458, 43500.56499435005, 43427.56572434275, 43646.56353436472, 43942.90142746433, 43953.0, 43988.78005609968, 9699.563519641615, 9908.900910990906, 9920.40477571348, 9945.005499450033, 9948.502574871263, 7406.481546291735, 8283.461574997636, 9627.652128701988, 9733.318667693264, 9876.901230987705, 8304.833903321929, 8337.874931876027, 8424.789380265482, 9891.208703303719, 9930.205583553334, 9840.360376575536, 9859.704208873782, 9861.60553577856, 9885.604575816958, 9920.404775713409, 9759.560819763128, 9815.362001469954, 9825.312228144032, 9852.408855468695, 9886.653967111117, 41014.1797164058, 41492.170156597, 41527.754167375024, 41560.1687966239, 41638.375424368656, 3497.930041399183, 3545.308664810363, 3579.7494175407733, 3937.370020796659, 3943.0, 30833.691663083308, 31900.0, 31912.680873191435, 31937.84031079853, 32541.83729081363, 2790.6232658591034, 3229.46713792224, 3263.0863358259726, 3279.4097062528735, 3381.7970921744773, 506665.0, 516385.0, 516841.0, 518558.0, 518991.9999999962, 57641.13538296929, 57985.0, 58046.129308060415, 58058.0, 58216.0, 31364.37271254562, 31669.841650791597, 32000.03999880007, 32127.03618891437, 32133.51799723006, 16063.518094456951, 16072.196390180445, 16207.513774586781, 16280.185990700418, 16333.591660208589, 12441.93779031117, 12540.874591254153, 12545.184563003559, 12546.309952952675, 12616.55842045524, 18737.437876863714, 18887.08935676734, 19108.949007804706, 19125.23499060022, 19134.808651913303, 6772.37677842352, 7902.209779022051, 7979.561124138112, 8010.0, 8076.859632197473, 849.4987957105337, 924.4453328003144, 966.7341481092615, 970.5826494607387, 1012.2711647613706, 28876.711232887403, 29193.85403072971, 30170.24574385658, 30382.240443988634, 30841.537376939363, 996.3573495095768, 1022.2384323678907, 1057.0856209378833, 1069.1607088435542, 1141.3323205924462, 11606.76786464266, 13895.444182232597, 15470.0, 15488.0, 15797.289121989537, 682267.0, 683803.0, 691030.0, 691289.0, 692278.0, 56425.71787141038, 57109.14336284959, 57444.71277643585, 57709.0, 57803.421965780646, 1322.5899971009019, 1360.415021540747, 1381.6062422209823, 1396.5880065380736, 1403.635054885737, 28304.575431368135, 29101.708982910746, 29265.85367073151, 29719.40561188721, 29905.401891961603, 47829.521704782506, 47967.04065918732, 48365.5163448361, 48493.75753121353, 48551.028979419505, 569204.0, 577434.0, 577478.0, 580187.0, 581440.0, 26236.73763262343, 26637.467250654492, 26655.0, 26685.86657066702, 26712.19863404101, 46982.29526557036, 47193.292100619205, 47270.76364618155, 47430.76284618555, 47993.76003119962, 31969.36061278715, 39157.02107447223, 39268.018299541596, 40614.0, 40686.982825428415, 38908.22183556257, 39229.80385098056, 39462.80268598639, 40088.59911400849, 40682.389764154155, 38210.04474888039, 38649.61350386572, 38917.0, 38943.805280973414, 38980.0, 32385.0, 34114.82942585271, 34631.480527792606, 34824.65175348214, 34836.651633484355, 25600.487990240465, 25718.31561529691, 25882.35294117662, 25955.48089038171, 26149.477010459304], "value": 19675.17821041157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.71732571382904, 377.8073182676834, 378.78220023486494, 386.1523954918954, 410.8373303550951, 18990.62018759624, 19397.612047759056, 20354.0, 20503.794962050375, 20800.47998800031, 16799.580010499743, 20478.873661948586, 20640.483987900272, 20953.790462095374, 21001.68497472539, 5808.912866307009, 5893.499052580525, 6054.545909056838, 6069.78755743549, 6125.356837532062, 5948.434898684618, 6027.9752442084955, 6054.33402325746, 6078.270607527103, 6132.570720049598, 5761.337446193678, 5841.0, 5893.086571581412, 5971.492423144016, 5997.580169388123, 5890.823275301726, 5945.821625351246, 5949.583529152961, 5957.791477298296, 5976.043832986723, 5099.872503187413, 5183.948160518385, 5389.353277606673, 5454.509094181542, 5510.283663123768, 13299.601011969657, 13371.933140334333, 13525.39135738894, 22178.33464996053, 24778.876105619536, 2032.3598066609118, 2097.0877668214225, 2136.6794980752857, 2164.653655415126, 2197.9884169499405, 9797.853032204523, 10031.097201251923, 10645.893541064568, 15031.549053528412, 15671.216439177995, 1777.644471105784, 1893.867429279951, 1898.1173754204224, 1903.847692184622, 1943.7473128493348, 87622.0, 114916.42541787238, 116148.0, 117566.0, 118345.0, 11278.379689117013, 11328.660140195807, 11421.314721116594, 11593.942030289794, 11614.941925290488, 14109.365078571489, 14121.2233327168, 14131.222782747047, 14133.293335333397, 14168.937329700108, 8271.54506502148, 8325.708600198965, 8424.663013479392, 8430.957845210734, 8573.014103378191, 8287.875681864776, 8341.082480927093, 8367.121452247547, 8501.767243749746, 8503.705628657488, 4482.148391805612, 4532.9546704533195, 4536.410266665378, 4559.475660299042, 4621.953780462152, 1926.2198809482181, 1971.112999150388, 1971.714101455281, 1978.060421299871, 1979.8614097013071, 878.3675753457501, 924.2144177449114, 965.5510187762584, 993.9950300248453, 997.3816233935007, 19885.60228795416, 21185.046672899756, 21359.0, 21558.880548789457, 21647.35057948264, 876.6718421591295, 903.5437104262437, 916.4272329793879, 955.5938726041404, 999.6900960702205, 8014.639341229658, 11202.159838012181, 11289.548418063185, 11313.71715707114, 11351.375674337825, 518106.0, 574590.0, 581707.0, 586769.0, 587158.0, 82516.0, 105868.0, 121795.39102304609, 123193.0, 124303.0, 874.7375787263795, 947.9431234125836, 986.3736527305069, 1004.0311099788739, 1008.8587597736176, 18610.813891860907, 18750.906245468686, 19027.0, 19102.617947641247, 19114.01727775825, 50428.74785626048, 50434.49565504298, 50840.98318033692, 51107.722306942625, 51378.74310628423, 58030.54923626943, 73009.0, 74106.25893740993, 74135.0, 74820.0, 7543.509671871311, 7976.242256985577, 7986.0, 8024.518528888286, 8281.50310981319, 6826.863462730618, 10058.49707514636, 10255.28213025111, 12027.037836972846, 12828.743425131632, 9067.419303545958, 10536.57853685844, 10643.148548116287, 11088.0, 11213.66359009231, 10560.84158737635, 10660.89339106599, 10778.73053173677, 11210.775784484427, 11472.0, 8917.643294268157, 10835.530529859567, 11274.210805243554, 11618.825717614412, 11671.01592729221, 5812.651240925558, 7029.226785053742, 7369.115706115301, 7652.65563049653, 8436.072032076589, 11297.661070167907, 11388.316700997966, 11399.715007124889, 11680.94159529197, 11780.05759539252], "value": 9287.77536001779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.5700546841415, 1529.380600856653, 1763.3123081998015, 1830.5149135479091, 1907.608940167266, 6974.8605027899475, 7978.321842643382, 8236.794080148, 9108.863367049491, 9136.451812891222, 8502.914970850305, 8839.867401988975, 8889.333300002509, 8950.194482496574, 8957.46255224687, 2381.1070848431837, 2410.337157281744, 2410.6384042393606, 2411.46947671512, 2414.7343792182846, 2363.1728894886824, 2383.30884043628, 2398.772116648924, 2416.8187385946035, 2420.394901274681, 2373.252425485975, 2387.092904696213, 2392.473655795731, 2414.7585241475886, 2420.7700268474555, 2361.7520160383256, 2374.489484760776, 2383.797377222938, 2388.1880160745345, 2391.1869964212165, 2366.585847476702, 2377.239283429303, 2378.797802186816, 2382.9515013394052, 2394.4013996500876, 8897.73306800797, 9006.0, 9033.277337812959, 9056.320775941766, 9092.727218183465, 4292.0, 4460.754658493782, 4759.976200118977, 5057.544820966131, 5384.488473595002, 2893.6382952130984, 3578.1949061461223, 3621.9456708149137, 3677.264547090566, 3695.63043695631, 942.886853577575, 1032.803767284221, 1064.3454275620516, 1088.0099109810114, 1090.9563617455292, 10024.649137280234, 11721.648350549412, 11832.408379581073, 11944.820827687592, 11952.880471195263, 4468.798904049326, 4590.357349971006, 4733.692309999908, 4858.5384388483035, 4864.36763220779, 9024.368294219474, 10143.28996970205, 10204.38773673567, 10210.846837297446, 10212.948935255276, 5350.197470379397, 5423.918641220384, 5428.4842939920645, 5431.8098866539485, 5436.972815135978, 4421.778911054499, 4613.700109492872, 4771.809127634856, 4897.99591083827, 4966.950330496721, 3933.4689816874356, 3981.880543583697, 4040.676745860324, 4074.409210664437, 4101.318459431619, 1277.3357853916098, 1287.3048553780854, 1290.1227165527532, 1293.4502836294537, 1296.6887946892678, 789.6407134753673, 910.7723069232692, 912.3841407050214, 912.5802131019673, 917.1699611851285, 5956.344802071769, 5995.160677505153, 6027.78902738402, 6078.817635470943, 6313.96843015782, 870.6038752367657, 889.3596610440472, 920.0983036624145, 933.0343094896749, 934.8130373925242, 3798.981005094957, 3813.237352529505, 3816.46569480273, 4094.467719196485, 4147.149834283965, 10487.790244195074, 10712.0, 10771.515281812337, 10839.891601084046, 10846.403447810288, 10872.67381978542, 10994.670159895217, 11019.118470522339, 11049.779004419866, 11080.39057851826, 8008.559529225832, 8058.11360750317, 8283.006039275326, 8287.62705678246, 8309.542975136426, 5796.797112101056, 5797.565182611405, 5916.083007133901, 5957.314908785545, 5977.641341519523, 10146.441945693057, 10164.644237451654, 10202.540885660312, 10211.927747586396, 10226.948865255627, 9919.65281215154, 10413.219008574235, 10422.0, 10511.632092876713, 10552.894471055499, 7042.401395881203, 7256.9274307256255, 7480.70077196906, 7677.808054798675, 7878.330341921001, 8441.577921104043, 8498.830023399621, 8634.266087382643, 8651.351148663749, 8664.35017373687, 7481.588512631857, 7664.578448185403, 7676.040494938133, 7693.230676932262, 7778.455508114378, 6521.673916304071, 7447.515911465737, 7520.360769334449, 7613.276738709814, 7640.159582445815, 6798.52410331272, 6882.518223724292, 6942.722291108299, 6945.756898508528, 6947.027416161641, 4820.517948205152, 5149.639525233198, 5222.55608273301, 5254.474552544715, 5363.302770639792, 4361.433013708198, 4707.176244157327, 5137.869668672886, 5269.104252277199, 5350.197470379474], "value": 4615.713969682326, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.96950304969505, 309.92406860319227, 317.97453213386825, 319.0874100073787, 319.23702351380206, 4840.951590484094, 5503.6147469677135, 5671.0, 5735.827925162246, 5775.855603609917, 4566.497685254628, 5396.730163491829, 5599.580031497644, 5613.80351687691, 5617.747201375938, 4249.107687385653, 4250.681198910079, 4254.829806807724, 4262.87211383659, 4290.4422425084695, 4150.709450338478, 4248.320268756999, 4264.701470897023, 4295.914081718363, 4315.719478233905, 3463.5843698756184, 3693.3905905525558, 4201.642860356858, 4220.936685949698, 4267.91464170718, 4226.429432026684, 4249.532551419341, 4259.914801703964, 4262.740747403881, 4301.451477468109, 3683.7291134558536, 3685.299793039314, 3693.8707145250055, 3707.814609269553, 3712.2018765965176, 5057.825135191866, 5128.615353848439, 5486.6982315973, 5506.091494903336, 5512.724363781835, 4158.438610787535, 4775.713457192544, 4870.975645121787, 4874.268859671042, 4924.261360795909, 5538.390777014565, 5847.386024467455, 5855.3851845556455, 5874.530037596982, 5888.322842873039, 3927.7234898657766, 3941.073847645801, 3954.2882281189372, 3957.920841583181, 4002.819873105688, 5339.759710813023, 5591.329040515164, 5914.4381283777975, 6092.329843717232, 6174.0, 3045.9847700761356, 3847.9230415391535, 4001.4598029265676, 4018.5687658965903, 4044.6157615026527, 3523.806190659487, 3680.613535578779, 4057.4522439470293, 4073.816678249486, 4120.7321524100835, 4802.73584952831, 4813.772488015534, 4826.517348265145, 4843.346148270009, 4853.635977301646, 5988.610740301867, 5989.970050149808, 6019.518438524908, 6019.518438524908, 6103.877922441527, 1265.4938024790158, 1302.768883405173, 1327.6813564744584, 1382.4055656067787, 1404.4663028049276, 766.8849672549162, 813.9715109971122, 826.1903334731996, 831.9584020798936, 856.3919617071949, 4173.582641735802, 4588.564086411786, 4678.508756580578, 4724.480307166209, 4780.713157210509, 4336.501302350207, 5150.819721309736, 5187.974060129751, 5198.766055527511, 5207.921881171786, 4642.46611639659, 4687.6249900007915, 4694.737157675451, 4713.434387873409, 4740.834070807505, 2500.6249062640386, 3166.970734511293, 3210.8761933323617, 3218.839058047135, 3235.9191020224685, 6306.936930630635, 6343.27052388972, 6391.146567495467, 6433.166547534024, 6465.612063276124, 4772.427308722976, 5936.901673190474, 6021.337652858182, 6162.5378096642935, 6208.844778880564, 6158.904328621416, 6196.287426945959, 6264.21697287839, 6276.184096067482, 6305.243370795534, 5693.971530142323, 5992.760289588367, 6074.939250607437, 6099.4815440688035, 6138.224991630204, 5481.835544933659, 5640.559258852179, 5945.613535120204, 5964.940350596438, 6012.849678757891, 5497.752601133038, 5985.162077309267, 6039.73165635204, 6270.780522681866, 6326.746930122744, 3291.8683252670585, 3507.5615548056494, 3800.389629851597, 3846.7307288489537, 3942.955116894083, 4990.775415106402, 5398.595105367034, 5738.454846789548, 5850.005499065084, 6183.690815459119, 4597.770111494478, 4994.550490455877, 5141.614378921521, 5993.220881285405, 6046.395360464095, 4752.881177970578, 5138.280640710229, 5251.501107394792, 5300.867478313073, 5615.876824635171, 4653.23221668421, 5031.547160755549, 5291.7618707159045, 5790.739416726173, 5809.419058094157, 5737.540996720336, 5744.798932037359, 5818.534517238695, 5841.4450627190345, 5909.52723782105, 5019.0, 5029.899402011866, 5304.496072873071, 5419.585661033524, 5791.625433572215], "value": 4192.096206353231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.1431467923812, 759.6391713935881, 776.40604937223, 788.8934993775839, 806.9475484093535, 15402.84597154028, 16322.836771632281, 16340.428085017027, 16344.754828677549, 16354.0, 14760.0, 14904.478343257988, 14923.104613723157, 14929.253537323144, 14930.701385972274, 635.1425575473121, 665.0888283052225, 781.468601351081, 788.5623478969155, 826.4586695714316, 809.6518497046268, 813.495632707722, 819.3731795176694, 819.848328059308, 821.3839620284787, 860.1226748716306, 867.6009035843488, 869.6390997735932, 873.0483772687769, 876.1851478125341, 823.7322870067193, 828.6850996621306, 855.820277741675, 864.2265172670457, 874.2394117118116, 611.7430679114782, 625.4589779840451, 638.5913015669975, 641.8876696578127, 647.5499527828161, 14919.701605967819, 15224.010439321408, 15234.847651523565, 15237.780977521772, 15268.31292591825, 14474.842012638963, 14540.563783086523, 14558.199299038548, 14577.0, 14652.633684157874, 11686.201809990835, 11719.06247500198, 11863.58477453285, 11942.462589183508, 12258.325792081432, 3767.723237105533, 3848.288066707668, 3850.383938569815, 3863.2273545291055, 3988.022934381066, 121536.0, 123997.0, 125550.11674824885, 126300.36849815784, 126813.0, 11281.492332845042, 11317.603883864025, 11338.43307834605, 11471.4264286787, 11682.824757628472, 19625.803741962398, 23300.0, 23502.0, 23805.880970595037, 23829.642555361683, 7919.247671471201, 8110.3511719062335, 8197.262246397853, 8304.211099945616, 8313.12712165226, 4499.482559505699, 4533.5013148553635, 4549.249373853278, 4581.908361832811, 4694.530546945346, 3529.629388914127, 3585.587657419378, 3637.727170462226, 3643.3259846928404, 3672.4491326300736, 594.694645253664, 598.3478008970243, 648.1282674802384, 648.6400047973326, 660.4584240922397, 478.1894688503024, 515.0078046549559, 618.0667192539208, 628.8585068359674, 630.5649102119523, 9364.15722584957, 9427.811443771086, 9544.756982109198, 9684.837819461569, 9707.514624268759, 533.0511689193243, 542.9511343979061, 583.4078410413434, 590.4774274766862, 612.8774245150987, 4075.836966521306, 4192.0, 4248.87253382399, 4265.573442655709, 4305.634021108178, 99480.0, 119767.0, 126818.36590816987, 146659.0, 156598.43401566066, 100937.99062009285, 103794.96205038004, 115495.84504154851, 139384.30307848597, 143076.0, 120938.0, 122272.0, 123296.0, 125480.0, 126468.99999999817, 8932.374733768835, 9093.77265568366, 9133.086691330815, 9173.266138709021, 9333.533323333942, 57183.0, 66810.66594666995, 67485.32514674986, 67732.0, 68279.0, 87664.5616771912, 88556.11443885736, 94162.0, 98583.0, 101768.47347289945, 12018.879811202125, 12021.038316934799, 12385.93807030959, 12440.066994975232, 12587.67109601366, 13003.219806811621, 13062.738745224851, 13285.66785830362, 13403.262820544964, 13833.170009799444, 9773.657921972697, 12093.697657558632, 12317.199382040139, 12364.690882728004, 12651.55719549848, 12179.147459677737, 12412.751744965231, 12631.0, 12647.936760316139, 12724.300163491096, 12213.206141600767, 12379.69050773738, 12523.56167534132, 12607.180533265675, 12642.367881605698, 9234.353595248269, 10278.743031424274, 10530.315529490865, 10564.947175264075, 10677.359358438518, 7400.494425304968, 9638.42169469834, 9714.514274286399, 10589.099926506333, 10637.680869573926], "value": 7645.917583676834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 115.0, 118.0, 116.0, 115.0, 116.0, 115.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 113.0, 111.0, 149.0, 111.0, 114.0, 111.0, 113.0, 137.0, 112.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 195.0, 200.0, 214.0, 227.0, 197.0, 197.0, 197.0, 203.0, 206.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 62.0, 84.0, 59.0, 60.0, 59.0, 61.0, 90.0, 60.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 87.0, 72.0, 69.0, 72.0, 87.0, 69.0, 70.0, 86.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 86.0, 112.0, 111.0, 84.0, 127.0, 89.0, 86.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 156.0, 92.0, 101.0, 90.0, 124.0, 151.0, 153.0, 109.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 96.0, 107.0, 102.0, 92.0, 152.0, 148.0, 99.0, 131.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 58.0, 58.0, 59.0, 57.0, 59.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 72.0, 83.0, 75.0, 70.0, 62.0, 96.0, 70.0, 80.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 89.0, 87.0, 87.0, 86.0, 87.0, 95.0, 109.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 150.0, 148.0, 156.0, 164.0, 165.0, 141.0, 171.0, 140.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 168.0, 170.0, 172.0, 171.0, 175.0, 176.0, 172.0, 175.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 68.0, 67.0, 69.0, 69.0, 66.0, 68.0, 66.0, 68.0], "value": 67.5, "unit": "score"}]}]} 13:36:47 INFO - Return code: 0 13:36:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:36:47 ERROR - # TBPL SUCCESS # 13:36:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:36:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:36:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:36:47 INFO - 2016-09-27 13:36:47.826 screenresolution[1678:11623] starting screenresolution argv=screenresolution get 13:36:47 INFO - 2016-09-27 13:36:47.829 screenresolution[1678:11623] Display 0: 1600x1200x32@60 13:36:47 INFO - 2016-09-27 13:36:47.835 screenresolution[1679:11625] starting screenresolution argv=screenresolution list 13:36:47 INFO - Available Modes on Display 0 13:36:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:36:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:36:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:36:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:36:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:36:48 INFO - Intel Iris: 13:36:48 INFO - Chipset Model: Intel Iris 13:36:48 INFO - Type: GPU 13:36:48 INFO - Bus: Built-In 13:36:48 INFO - VRAM (Dynamic, Max): 1536 MB 13:36:48 INFO - Vendor: Intel (0x8086) 13:36:48 INFO - Device ID: 0x0a2e 13:36:48 INFO - Revision ID: 0x0009 13:36:48 INFO - Displays: 13:36:48 INFO - Display: 13:36:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:36:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:36:48 INFO - Display Serial Number: 1600x1200 60 13:36:48 INFO - Main Display: Yes 13:36:48 INFO - Mirror: Off 13:36:48 INFO - Online: Yes 13:36:48 INFO - Rotation: Supported 13:36:48 INFO - Return code: 0 13:36:48 INFO - Running post-action listener: _resource_record_post_action 13:36:48 INFO - [mozharness: 2016-09-27 20:36:48.069906Z] Finished run-tests step (success) 13:36:48 INFO - Running post-run listener: _resource_record_post_run 13:36:48 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 44078592; Write bytes: 721049088; Read time: 336; Write time: 2052 13:36:48 INFO - TinderboxPrint: CPU usage
54.5% 13:36:48 INFO - TinderboxPrint: I/O read bytes / time
44,078,592 / 336 13:36:48 INFO - TinderboxPrint: I/O write bytes / time
721,049,088 / 2,052 13:36:48 INFO - TinderboxPrint: CPU idle
2,197.8 (45.5%) 13:36:48 INFO - TinderboxPrint: CPU system
976.0 (20.2%) 13:36:48 INFO - TinderboxPrint: CPU user
1,660.0 (34.3%) 13:36:48 INFO - TinderboxPrint: Swap in / out
440,836,096 / 0 13:36:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403689984; Write bytes: 404278272; Read time: 29822; Write time: 787 13:36:48 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 41993728; Write bytes: 309160448; Read time: 317; Write time: 1237 13:36:48 INFO - Running post-run listener: _upload_blobber_files 13:36:48 INFO - Blob upload gear active. 13:36:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:36:48 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 13:36:48 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:36:48 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:36:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:52 INFO - (blobuploader) - INFO - Done attempting. 13:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:52 INFO - (blobuploader) - INFO - Done attempting. 13:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:55 INFO - (blobuploader) - INFO - Done attempting. 13:36:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:36:55 INFO - Return code: 0 13:36:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:36:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:36:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a90857ed0c6836ade098a280fa7851eb5c72e9b534a27ddca07e51300dbf407f29dd78662f96dd2281864ba5e8bcc4772216237ab1bebaec6befc8db45e87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a408949571813bd35878964db5cd8073f368656739d5a2ce0ee6411b48d58bcb669969d91e72bda1a57732f04ea9a8183c486b6a36722e9a19dbb8b575733454", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c10f293777903783ac807ec3249b88efcd53896c70f488049517c00f277ef6ce42f3ce0ad2f67f27c496706d711d6ec7468c4827b59d0aae24681df1ecffe4"} 13:36:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:36:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:36:55 INFO - Contents: 13:36:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a90857ed0c6836ade098a280fa7851eb5c72e9b534a27ddca07e51300dbf407f29dd78662f96dd2281864ba5e8bcc4772216237ab1bebaec6befc8db45e87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a408949571813bd35878964db5cd8073f368656739d5a2ce0ee6411b48d58bcb669969d91e72bda1a57732f04ea9a8183c486b6a36722e9a19dbb8b575733454", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c10f293777903783ac807ec3249b88efcd53896c70f488049517c00f277ef6ce42f3ce0ad2f67f27c496706d711d6ec7468c4827b59d0aae24681df1ecffe4"} 13:36:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:36:55 INFO - Copying logs to upload dir... 13:36:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:36:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.684921 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-27 13:36:55.310028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:36:55.313694) ========= 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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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/Fx-Team/sha512/f3a90857ed0c6836ade098a280fa7851eb5c72e9b534a27ddca07e51300dbf407f29dd78662f96dd2281864ba5e8bcc4772216237ab1bebaec6befc8db45e87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a408949571813bd35878964db5cd8073f368656739d5a2ce0ee6411b48d58bcb669969d91e72bda1a57732f04ea9a8183c486b6a36722e9a19dbb8b575733454", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c10f293777903783ac807ec3249b88efcd53896c70f488049517c00f277ef6ce42f3ce0ad2f67f27c496706d711d6ec7468c4827b59d0aae24681df1ecffe4"} build_url:https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010958 build_url: 'https://queue.taskcluster.net/v1/task/bZEZfXcJRz2GPs_i5Ww5eg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a90857ed0c6836ade098a280fa7851eb5c72e9b534a27ddca07e51300dbf407f29dd78662f96dd2281864ba5e8bcc4772216237ab1bebaec6befc8db45e87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a408949571813bd35878964db5cd8073f368656739d5a2ce0ee6411b48d58bcb669969d91e72bda1a57732f04ea9a8183c486b6a36722e9a19dbb8b575733454", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4c10f293777903783ac807ec3249b88efcd53896c70f488049517c00f277ef6ce42f3ce0ad2f67f27c496706d711d6ec7468c4827b59d0aae24681df1ecffe4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:36:55.348413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:36:55.348808) ========= 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.r8Av59Bl3i/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.qSxyUmcMf5/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005416 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:36:55.397383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:36:55.397729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:36:55.398173) ========= ========= Total master_lag: 0.18 =========