builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0169 starttime: 1486572502.04 results: success (0) buildid: 20170208071856 builduid: 947a25c8d39442f087c1f4563fb12313 revision: 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.044095) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.044510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.044784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.070467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.070728) ========= 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.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-08 08:48:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.44M=0.001s 2017-02-08 08:48:22 (9.44 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089010 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.185126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.185438) ========= 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.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.028019 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:22.234033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 08:48:22.234356) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-08 08:48:22,341 truncating revision to first 12 chars 2017-02-08 08:48:22,341 Setting DEBUG logging. 2017-02-08 08:48:22,341 attempt 1/10 2017-02-08 08:48:22,341 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3e1982d9a5ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 08:48:23,393 unpacking tar archive at: mozilla-aurora-3e1982d9a5ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319942 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 08:48:23.580045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:23.583425) ========= script_repo_revision: 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:23.583807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:23.584066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 08:48:23.603244) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 08:48:23.603513) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:48:23 INFO - MultiFileLogger online at 20170208 08:48:23 in /builds/slave/test 08:48:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:48:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:23 INFO - {'append_to_log': False, 08:48:23 INFO - 'base_work_dir': '/builds/slave/test', 08:48:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:48:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:23 INFO - 'branch': 'Mozilla-Aurora', 08:48:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:23 INFO - 'config_files': ('talos/mac_config.py',), 08:48:23 INFO - 'default_actions': ('clobber', 08:48:23 INFO - 'read-buildbot-config', 08:48:23 INFO - 'download-and-extract', 08:48:23 INFO - 'populate-webroot', 08:48:23 INFO - 'create-virtualenv', 08:48:23 INFO - 'install', 08:48:23 INFO - 'run-tests'), 08:48:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:23 INFO - 'download_minidump_stackwalk': True, 08:48:23 INFO - 'download_symbols': 'ondemand', 08:48:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:23 INFO - 'installer_path': 'installer.exe', 08:48:23 INFO - 'log_level': 'info', 08:48:23 INFO - 'log_name': 'talos', 08:48:23 INFO - 'log_to_console': True, 08:48:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:23 INFO - 'opt_config_files': (), 08:48:23 INFO - 'pip_index': False, 08:48:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:23 INFO - 'cmd': ('bash', 08:48:23 INFO - '-c', 08:48:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:23 INFO - 'enabled': True, 08:48:23 INFO - 'halt_on_failure': False, 08:48:23 INFO - 'name': 'check_screen_resolution'},), 08:48:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:23 INFO - 'cmd': ('bash', 08:48:23 INFO - '-c', 08:48:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:23 INFO - 'enabled': True, 08:48:23 INFO - 'halt_on_failure': False, 08:48:23 INFO - 'name': 'check_screen_resolution'},), 08:48:23 INFO - 'run_cmd_checks_enabled': True, 08:48:23 INFO - 'sps_profile': False, 08:48:23 INFO - 'sps_profile_interval': 0, 08:48:23 INFO - 'suite': 'dromaeojs-e10s', 08:48:23 INFO - 'system_bits': '32', 08:48:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:23 INFO - 'title': 't-yosemite-r7-0169', 08:48:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:23 INFO - 'use_talos_json': True, 08:48:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:23 INFO - 'work_dir': 'build'} 08:48:23 INFO - [mozharness: 2017-02-08 16:48:23.815027Z] Running clobber step. 08:48:23 INFO - Running pre-action listener: _resource_record_pre_action 08:48:23 INFO - Running main action method: clobber 08:48:23 INFO - rmtree: /builds/slave/test/build 08:48:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:26 INFO - Running post-action listener: _resource_record_post_action 08:48:26 INFO - [mozharness: 2017-02-08 16:48:26.214664Z] Finished clobber step (success) 08:48:26 INFO - [mozharness: 2017-02-08 16:48:26.214836Z] Running read-buildbot-config step. 08:48:26 INFO - Running pre-action listener: _resource_record_pre_action 08:48:26 INFO - Running main action method: read_buildbot_config 08:48:26 INFO - Using buildbot properties: 08:48:26 INFO - { 08:48:26 INFO - "project": "", 08:48:26 INFO - "product": "firefox", 08:48:26 INFO - "script_repo_revision": "production", 08:48:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:48:26 INFO - "repository": "", 08:48:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:48:26 INFO - "buildid": "20170208071856", 08:48:26 INFO - "pgo_build": "False", 08:48:26 INFO - "basedir": "/builds/slave/test", 08:48:26 INFO - "buildnumber": 55, 08:48:26 INFO - "slavename": "t-yosemite-r7-0169", 08:48:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:48:26 INFO - "platform": "yosemite_r7", 08:48:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:48:26 INFO - "branch": "mozilla-aurora", 08:48:26 INFO - "repo_path": "releases/mozilla-aurora", 08:48:26 INFO - "revision": "3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42", 08:48:26 INFO - "stage_platform": "macosx64", 08:48:26 INFO - "builduid": "947a25c8d39442f087c1f4563fb12313", 08:48:26 INFO - "slavebuilddir": "test" 08:48:26 INFO - } 08:48:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:48:26 INFO - Running post-action listener: _resource_record_post_action 08:48:26 INFO - [mozharness: 2017-02-08 16:48:26.218340Z] Finished read-buildbot-config step (success) 08:48:26 INFO - [mozharness: 2017-02-08 16:48:26.218490Z] Running download-and-extract step. 08:48:26 INFO - Running pre-action listener: _resource_record_pre_action 08:48:26 INFO - Running main action method: download_and_extract 08:48:26 INFO - mkdir: /builds/slave/test/build/tests 08:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:26 INFO - trying https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:48:26 INFO - Downloading https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:48:27 INFO - Downloaded 1199 bytes. 08:48:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:48:27 INFO - Using the following test package requirements: 08:48:27 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:48:27 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:48:27 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:48:27 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'jsshell-mac.zip'], 08:48:27 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:48:27 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:48:27 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:48:27 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:48:27 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:48:27 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:48:27 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:48:27 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:48:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:48:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:48:27 INFO - Fetch https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:48:28 INFO - Expected file size: 16357313 08:48:28 INFO - Obtained file size: 16357313 08:48:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:48:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:48:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:48:35 INFO - Fetch https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:48:36 INFO - Expected file size: 16357313 08:48:36 INFO - Obtained file size: 16357313 08:48:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:48:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:48:42 INFO - Fetch https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:48:44 INFO - Expected file size: 14403485 08:48:44 INFO - Obtained file size: 14403485 08:48:44 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')]} 08:48:44 INFO - trying https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:48:46 INFO - Downloaded 73820171 bytes. 08:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:46 INFO - mkdir: /builds/slave/test/properties 08:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:46 INFO - Contents: 08:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:48:47 INFO - Running post-action listener: _resource_record_post_action 08:48:47 INFO - Running post-action listener: set_extra_try_arguments 08:48:47 INFO - [mozharness: 2017-02-08 16:48:47.163313Z] Finished download-and-extract step (success) 08:48:47 INFO - [mozharness: 2017-02-08 16:48:47.163476Z] Running populate-webroot step. 08:48:47 INFO - Running pre-action listener: _resource_record_pre_action 08:48:47 INFO - Running main action method: populate_webroot 08:48:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:47 INFO - '--tppagecycles', 08:48:47 INFO - '7'], 08:48:47 INFO - 'tests': ['tsvgm']}}, 08:48:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['damp', 'tps']}, 08:48:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'tests': ['damp', 'tps']}, 08:48:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['dromaeo_dom']}, 08:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['basic_compositor_video']}, 08:48:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['a11yr', 08:48:47 INFO - 'ts_paint', 08:48:47 INFO - 'tpaint', 08:48:47 INFO - 'sessionrestore', 08:48:47 INFO - 'sessionrestore_no_auto_restore', 08:48:47 INFO - 'tabpaint']}, 08:48:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['tsvgx', 08:48:47 INFO - 'tsvgr_opacity', 08:48:47 INFO - 'tart', 08:48:47 INFO - 'tscrollx', 08:48:47 INFO - 'cart', 08:48:47 INFO - 'tsvg_static']}, 08:48:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:47 INFO - 'tsvgr_opacity', 08:48:47 INFO - 'tart', 08:48:47 INFO - 'tscrollx', 08:48:47 INFO - 'cart', 08:48:47 INFO - 'tsvg_static']}, 08:48:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'talos_options': ['--disable-e10s'], 08:48:47 INFO - 'tests': ['tp5o']}, 08:48:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:48:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'talos_options': ['--disable-e10s', 08:48:47 INFO - '--xperf_path', 08:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:47 INFO - 'tests': ['tp5n']}, 08:48:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:48:47 INFO - 'talos_options': ['--xperf_path', 08:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:47 INFO - 'tests': ['tp5n']}}, 08:48:47 INFO - 'talos.zip': {'path': '', 08:48:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:47 INFO - Running post-action listener: _resource_record_post_action 08:48:47 INFO - [mozharness: 2017-02-08 16:48:47.182531Z] Finished populate-webroot step (success) 08:48:47 INFO - [mozharness: 2017-02-08 16:48:47.182668Z] Running create-virtualenv step. 08:48:47 INFO - Running pre-action listener: _resource_record_pre_action 08:48:47 INFO - Running main action method: create_virtualenv 08:48:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:47 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 08:48:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:47 INFO - Using real prefix '/tools/python27' 08:48:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:50 INFO - Installing pip.................done. 08:48:50 INFO - Return code: 0 08:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:51 INFO - Reading from file tmpfile_stdout 08:48:51 INFO - Output received: 08:48:51 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) 08:48:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:51 INFO - 'HOME': '/Users/cltbld', 08:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:51 INFO - 'LOGNAME': 'cltbld', 08:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:51 INFO - 'MOZ_NO_REMOTE': '1', 08:48:51 INFO - 'NO_EM_RESTART': '1', 08:48:51 INFO - 'PAGER': '/bin/cat', 08:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:51 INFO - 'PWD': '/builds/slave/test', 08:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:51 INFO - 'SHELL': '/bin/bash', 08:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:48:51 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:51 INFO - 'USER': 'cltbld', 08:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:51 INFO - 'XPC_FLAGS': '0x0', 08:48:51 INFO - 'XPC_SERVICE_NAME': '0', 08:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:51 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 08:48:51 INFO - Cleaning up... 08:48:51 INFO - Return code: 0 08:48:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:51 INFO - 'HOME': '/Users/cltbld', 08:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:51 INFO - 'LOGNAME': 'cltbld', 08:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:51 INFO - 'MOZ_NO_REMOTE': '1', 08:48:51 INFO - 'NO_EM_RESTART': '1', 08:48:51 INFO - 'PAGER': '/bin/cat', 08:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:51 INFO - 'PWD': '/builds/slave/test', 08:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:51 INFO - 'SHELL': '/bin/bash', 08:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:48:51 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:51 INFO - 'USER': 'cltbld', 08:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:51 INFO - 'XPC_FLAGS': '0x0', 08:48:51 INFO - 'XPC_SERVICE_NAME': '0', 08:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:51 INFO - Downloading/unpacking psutil>=3.1.1 08:48:51 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 08:48:51 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 08:48:51 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 08:48:51 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 08:48:51 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 08:48:51 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 08:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:55 INFO - Installing collected packages: psutil 08:48:55 INFO - Running setup.py install for psutil 08:48:55 INFO - building 'psutil._psutil_osx' extension 08:48:55 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 08:48:55 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 08:48:55 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 08:48:55 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 08:48:56 INFO - building 'psutil._psutil_posix' extension 08:48:56 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 08:48:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:56 INFO - ^ 08:48:56 INFO - 1 warning generated. 08:48:56 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 08:48:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:56 INFO - Successfully installed psutil 08:48:56 INFO - Cleaning up... 08:48:56 INFO - Return code: 0 08:48:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:56 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')]} 08:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:56 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')]} 08:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:56 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:48:56 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 08:48:56 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 08:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:56 INFO - 'HOME': '/Users/cltbld', 08:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:56 INFO - 'LOGNAME': 'cltbld', 08:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:56 INFO - 'MOZ_NO_REMOTE': '1', 08:48:56 INFO - 'NO_EM_RESTART': '1', 08:48:56 INFO - 'PAGER': '/bin/cat', 08:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:56 INFO - 'PWD': '/builds/slave/test', 08:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:56 INFO - 'SHELL': '/bin/bash', 08:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:48:56 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:56 INFO - 'USER': 'cltbld', 08:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:56 INFO - 'XPC_FLAGS': '0x0', 08:48:56 INFO - 'XPC_SERVICE_NAME': '0', 08:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:56 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 08:48:56 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 08:48:56 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 08:48:56 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 08:48:56 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 08:48:56 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 08:48:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:59 INFO - Installing collected packages: mozsystemmonitor 08:48:59 INFO - Running setup.py install for mozsystemmonitor 08:48:59 INFO - Successfully installed mozsystemmonitor 08:48:59 INFO - Cleaning up... 08:48:59 INFO - Return code: 0 08:48:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:59 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:48:59 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 08:48:59 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 08:48:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:48:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:59 INFO - 'HOME': '/Users/cltbld', 08:48:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:59 INFO - 'LOGNAME': 'cltbld', 08:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:59 INFO - 'MOZ_NO_REMOTE': '1', 08:48:59 INFO - 'NO_EM_RESTART': '1', 08:48:59 INFO - 'PAGER': '/bin/cat', 08:48:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:59 INFO - 'PWD': '/builds/slave/test', 08:48:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:59 INFO - 'SHELL': '/bin/bash', 08:48:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:48:59 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:48:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:59 INFO - 'USER': 'cltbld', 08:48:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:59 INFO - 'XPC_FLAGS': '0x0', 08:48:59 INFO - 'XPC_SERVICE_NAME': '0', 08:48:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:59 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:59 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 08:48:59 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 08:48:59 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 08:48:59 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 08:48:59 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 08:48:59 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 08:49:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 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 08:49:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:03 INFO - warning: no files found matching '*.txt' 08:49:03 INFO - no previously-included directories found matching 'build' 08:49:03 INFO - no previously-included directories found matching 'dist' 08:49:03 INFO - no previously-included directories found matching '.git*' 08:49:03 INFO - Installing collected packages: jsonschema, functools32 08:49:03 INFO - Running setup.py install for functools32 08:49:03 INFO - warning: no files found matching '*.txt' 08:49:03 INFO - no previously-included directories found matching 'build' 08:49:03 INFO - no previously-included directories found matching 'dist' 08:49:03 INFO - no previously-included directories found matching '.git*' 08:49:03 INFO - Successfully installed jsonschema functools32 08:49:03 INFO - Cleaning up... 08:49:03 INFO - Return code: 0 08:49:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:03 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:03 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 08:49:03 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 08:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:03 INFO - 'HOME': '/Users/cltbld', 08:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:03 INFO - 'LOGNAME': 'cltbld', 08:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:03 INFO - 'MOZ_NO_REMOTE': '1', 08:49:03 INFO - 'NO_EM_RESTART': '1', 08:49:03 INFO - 'PAGER': '/bin/cat', 08:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:03 INFO - 'PWD': '/builds/slave/test', 08:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:03 INFO - 'SHELL': '/bin/bash', 08:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:03 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:03 INFO - 'USER': 'cltbld', 08:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:03 INFO - 'XPC_FLAGS': '0x0', 08:49:03 INFO - 'XPC_SERVICE_NAME': '0', 08:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:49:03 INFO - Cleaning up... 08:49:03 INFO - Return code: 0 08:49:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:03 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:03 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 08:49:03 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 08:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:03 INFO - 'HOME': '/Users/cltbld', 08:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:03 INFO - 'LOGNAME': 'cltbld', 08:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:03 INFO - 'MOZ_NO_REMOTE': '1', 08:49:03 INFO - 'NO_EM_RESTART': '1', 08:49:03 INFO - 'PAGER': '/bin/cat', 08:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:03 INFO - 'PWD': '/builds/slave/test', 08:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:03 INFO - 'SHELL': '/bin/bash', 08:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:03 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:03 INFO - 'USER': 'cltbld', 08:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:03 INFO - 'XPC_FLAGS': '0x0', 08:49:03 INFO - 'XPC_SERVICE_NAME': '0', 08:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:03 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 08:49:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:07 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 08:49:07 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 08:49:07 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 08:49:07 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 08:49:07 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 08:49:07 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 08:49:07 INFO - Downloading docopt-0.6.1.tar.gz 08:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:07 INFO - Running setup.py install for blobuploader 08:49:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:07 INFO - Running setup.py install for requests 08:49:08 INFO - Running setup.py install for docopt 08:49:08 INFO - Successfully installed blobuploader requests docopt 08:49:08 INFO - Cleaning up... 08:49:08 INFO - Return code: 0 08:49:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:08 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')]} 08:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:08 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')]} 08:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:08 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:08 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 08:49:08 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 08:49:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:08 INFO - 'HOME': '/Users/cltbld', 08:49:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:08 INFO - 'LOGNAME': 'cltbld', 08:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:08 INFO - 'MOZ_NO_REMOTE': '1', 08:49:08 INFO - 'NO_EM_RESTART': '1', 08:49:08 INFO - 'PAGER': '/bin/cat', 08:49:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:08 INFO - 'PWD': '/builds/slave/test', 08:49:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:08 INFO - 'SHELL': '/bin/bash', 08:49:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:08 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:08 INFO - 'USER': 'cltbld', 08:49:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:08 INFO - 'XPC_FLAGS': '0x0', 08:49:08 INFO - 'XPC_SERVICE_NAME': '0', 08:49:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:08 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Z1GYKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-7e9n5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ETZf7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ENTNqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ydxi1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vnBu8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-mtQHuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ubbAfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-iygz7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:09 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-5Cyn2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-K225i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-gZq6u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ontuGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-kVpixq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-7BebGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-C1ExZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:10 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-3akZ3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:10 INFO - Running setup.py install for manifestparser 08:49:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:10 INFO - Running setup.py install for mozcrash 08:49:11 INFO - Running setup.py install for mozdebug 08:49:11 INFO - Running setup.py install for mozdevice 08:49:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Running setup.py install for mozfile 08:49:11 INFO - Running setup.py install for mozhttpd 08:49:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Running setup.py install for mozinfo 08:49:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Running setup.py install for mozInstall 08:49:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:11 INFO - Running setup.py install for mozleak 08:49:12 INFO - Running setup.py install for mozlog 08:49:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Running setup.py install for moznetwork 08:49:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Running setup.py install for mozprocess 08:49:12 INFO - Running setup.py install for mozprofile 08:49:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Running setup.py install for mozrunner 08:49:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:12 INFO - Running setup.py install for mozscreenshot 08:49:13 INFO - Running setup.py install for moztest 08:49:13 INFO - Running setup.py install for mozversion 08:49:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:13 INFO - Cleaning up... 08:49:13 INFO - Return code: 0 08:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:13 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:13 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 08:49:13 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 08:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:13 INFO - 'HOME': '/Users/cltbld', 08:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:13 INFO - 'LOGNAME': 'cltbld', 08:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:13 INFO - 'MOZ_NO_REMOTE': '1', 08:49:13 INFO - 'NO_EM_RESTART': '1', 08:49:13 INFO - 'PAGER': '/bin/cat', 08:49:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:13 INFO - 'PWD': '/builds/slave/test', 08:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:13 INFO - 'SHELL': '/bin/bash', 08:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:13 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:13 INFO - 'USER': 'cltbld', 08:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:13 INFO - 'XPC_FLAGS': '0x0', 08:49:13 INFO - 'XPC_SERVICE_NAME': '0', 08:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-gKE8Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:13 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)) 08:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-fajjCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-M07zl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:13 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)) 08:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-yzesx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-rOflbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-opNR9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-W_5bt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-036tkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ih9euX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-EVqSIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Crv65r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:14 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)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-MVOqRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-lJXvLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:15 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)) 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:15 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-b_vdus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:15 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-1bdswb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:15 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)) 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:15 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-UZRAbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:15 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-67EYdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:15 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)) 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:15 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)) 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - Downloading blessings-1.6.tar.gz 08:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:18 INFO - Installing collected packages: blessings 08:49:18 INFO - Running setup.py install for blessings 08:49:18 INFO - Successfully installed blessings 08:49:18 INFO - Cleaning up... 08:49:18 INFO - Return code: 0 08:49:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:19 INFO - Reading from file tmpfile_stdout 08:49:19 INFO - Current package versions: 08:49:19 INFO - blessings == 1.6 08:49:19 INFO - blobuploader == 1.2.4 08:49:19 INFO - docopt == 0.6.1 08:49:19 INFO - functools32 == 3.2.3-2 08:49:19 INFO - jsonschema == 2.5.1 08:49:19 INFO - manifestparser == 1.1 08:49:19 INFO - mozInstall == 1.12 08:49:19 INFO - mozcrash == 1.0 08:49:19 INFO - mozdebug == 0.1 08:49:19 INFO - mozdevice == 0.49 08:49:19 INFO - mozfile == 1.2 08:49:19 INFO - mozhttpd == 0.7 08:49:19 INFO - mozinfo == 0.9 08:49:19 INFO - mozleak == 0.1 08:49:19 INFO - mozlog == 3.4 08:49:19 INFO - moznetwork == 0.27 08:49:19 INFO - mozprocess == 0.24 08:49:19 INFO - mozprofile == 0.28 08:49:19 INFO - mozrunner == 6.13 08:49:19 INFO - mozscreenshot == 0.1 08:49:19 INFO - mozsystemmonitor == 0.3 08:49:19 INFO - moztest == 0.8 08:49:19 INFO - mozversion == 1.4 08:49:19 INFO - psutil == 3.1.1 08:49:19 INFO - requests == 1.2.3 08:49:19 INFO - wsgiref == 0.1.2 08:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 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 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:19 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 08:49:19 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 08:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:19 INFO - 'HOME': '/Users/cltbld', 08:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:19 INFO - 'LOGNAME': 'cltbld', 08:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:19 INFO - 'MOZ_NO_REMOTE': '1', 08:49:19 INFO - 'NO_EM_RESTART': '1', 08:49:19 INFO - 'PAGER': '/bin/cat', 08:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:19 INFO - 'PWD': '/builds/slave/test', 08:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:19 INFO - 'SHELL': '/bin/bash', 08:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:19 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:19 INFO - 'USER': 'cltbld', 08:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:19 INFO - 'XPC_FLAGS': '0x0', 08:49:19 INFO - 'XPC_SERVICE_NAME': '0', 08:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 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)) 08:49:19 INFO - Cleaning up... 08:49:19 INFO - Return code: 0 08:49:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a879b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a87c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddcbca4e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, '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.Byny7O6CwR/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.PEtGGOA91R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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 08:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:19 INFO - 'HOME': '/Users/cltbld', 08:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:19 INFO - 'LOGNAME': 'cltbld', 08:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:19 INFO - 'MOZ_NO_REMOTE': '1', 08:49:19 INFO - 'NO_EM_RESTART': '1', 08:49:19 INFO - 'PAGER': '/bin/cat', 08:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:19 INFO - 'PWD': '/builds/slave/test', 08:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:19 INFO - 'SHELL': '/bin/bash', 08:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:19 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:19 INFO - 'USER': 'cltbld', 08:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:19 INFO - 'XPC_FLAGS': '0x0', 08:49:19 INFO - 'XPC_SERVICE_NAME': '0', 08:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:49:20 INFO - Cleaning up... 08:49:20 INFO - Return code: 0 08:49:20 INFO - Running post-action listener: _resource_record_post_action 08:49:20 INFO - Running post-action listener: _start_resource_monitoring 08:49:20 INFO - Starting resource monitoring. 08:49:20 INFO - [mozharness: 2017-02-08 16:49:20.088836Z] Finished create-virtualenv step (success) 08:49:20 INFO - [mozharness: 2017-02-08 16:49:20.089806Z] Running install step. 08:49:20 INFO - Running pre-action listener: _resource_record_pre_action 08:49:20 INFO - Running main action method: install 08:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:20 INFO - Reading from file tmpfile_stdout 08:49:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:20 INFO - Reading from file tmpfile_stdout 08:49:20 INFO - Output received: 08:49:20 INFO - Usage: mozinstall [options] installer 08:49:20 INFO - Options: 08:49:20 INFO - -h, --help show this help message and exit 08:49:20 INFO - -d DEST, --destination=DEST 08:49:20 INFO - Directory to install application into. [default: 08:49:20 INFO - "/builds/slave/test"] 08:49:20 INFO - --app=APP Application being installed. [default: firefox] 08:49:20 INFO - mkdir: /builds/slave/test/build/application 08:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:49:40 INFO - Reading from file tmpfile_stdout 08:49:40 INFO - Output received: 08:49:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - [mozharness: 2017-02-08 16:49:40.188562Z] Finished install step (success) 08:49:40 INFO - [mozharness: 2017-02-08 16:49:40.188728Z] Running run-tests step. 08:49:40 INFO - Running pre-action listener: _resource_record_pre_action 08:49:40 INFO - Running main action method: run_tests 08:49:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:40 INFO - 2017-02-08 08:49:40.202 screenresolution[1628:7294] starting screenresolution argv=screenresolution get 08:49:40 INFO - 2017-02-08 08:49:40.205 screenresolution[1628:7294] Display 0: 1600x1200x32@60 08:49:40 INFO - 2017-02-08 08:49:40.211 screenresolution[1629:7301] starting screenresolution argv=screenresolution list 08:49:40 INFO - Available Modes on Display 0 08:49:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:40 INFO - Intel Iris: 08:49:40 INFO - Chipset Model: Intel Iris 08:49:40 INFO - Type: GPU 08:49:40 INFO - Bus: Built-In 08:49:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:40 INFO - Vendor: Intel (0x8086) 08:49:40 INFO - Device ID: 0x0a2e 08:49:40 INFO - Revision ID: 0x0009 08:49:40 INFO - Displays: 08:49:40 INFO - Display: 08:49:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:40 INFO - Display Serial Number: 1600x1200 60 08:49:40 INFO - Main Display: Yes 08:49:40 INFO - Mirror: Off 08:49:40 INFO - Online: Yes 08:49:40 INFO - Rotation: Supported 08:49:40 INFO - Return code: 0 08:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:40 INFO - Python 2.7.3 08:49:40 INFO - Return code: 0 08:49:40 INFO - grabbing minidump binary from tooltool 08:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:40 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 0x10a657d30>, '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 0x10a57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a64cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:40 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 08:49:40 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 08:49:40 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 08:49:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:40 INFO - Return code: 0 08:49:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:49:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:49:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 08:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --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 08:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Byny7O6CwR/Render', 08:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:40 INFO - 'HOME': '/Users/cltbld', 08:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:40 INFO - 'LOGNAME': 'cltbld', 08:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:40 INFO - 'MOZ_NO_REMOTE': '1', 08:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:40 INFO - 'NO_EM_RESTART': '1', 08:49:40 INFO - 'PAGER': '/bin/cat', 08:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:40 INFO - 'PWD': '/builds/slave/test', 08:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:40 INFO - 'SHELL': '/bin/bash', 08:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PEtGGOA91R/Listeners', 08:49:40 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 08:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:40 INFO - 'USER': 'cltbld', 08:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:40 INFO - 'XPC_FLAGS': '0x0', 08:49:40 INFO - 'XPC_SERVICE_NAME': '0', 08:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--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 08:49:40 INFO - mozversion application_buildid: 20170208071856 08:49:40 INFO - mozversion application_changeset: 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 08:49:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:49:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:40 INFO - mozversion application_name: Firefox 08:49:40 INFO - mozversion application_remotingname: firefox-dev 08:49:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:49:40 INFO - mozversion application_vendor: Mozilla 08:49:40 INFO - mozversion application_version: 53.0a2 08:49:40 INFO - mozversion platform_buildid: 20170208071856 08:49:40 INFO - mozversion platform_changeset: 3e1982d9a5ea25e0abd9a91d751a5dc3e7214a42 08:49:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:49:40 INFO - mozversion platform_version: 53.0a2 08:49:40 INFO - using testdate: 1486572580 08:49:40 INFO - actual date: 1486572580 08:49:40 INFO - starting webserver on 'localhost:49246' 08:49:40 INFO - SUITE-START | Running 2 tests 08:49:40 INFO - TEST-START | dromaeo_css 08:49:40 INFO - operating with platform_type : mac_ 08:49:40 INFO - Initialising browser for dromaeo_css test... 08:49:40 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile http://localhost:49246/getInfo.html) 08:49:43 INFO - PROCESS | 1639 | 2017-02-08 08:49:43.937 plugin-container[1641:7465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 08:49:43 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:43 INFO - PROCESS | 1639 | 2017-02-08 08:49:43.941 plugin-container[1641:7465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x911b, name = 'com.apple.CFPasteboardClient' 08:49:43 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:43 INFO - PROCESS | 1639 | 2017-02-08 08:49:43.941 plugin-container[1641:7465] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:49:44 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 08:49:44 INFO - PROCESS | 1639 | colorDepth:24 08:49:44 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 08:49:44 INFO - PROCESS | 1639 | __metrics 08:49:44 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:49:44 INFO - PROCESS | 1639 | 1486572584135 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:49:44 INFO - TEST-INFO | 1639: exit 0 08:49:44 INFO - Browser initialized. 08:49:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:44 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpyLSPMG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:47 INFO - PROCESS | 1642 | 2017-02-08 08:49:47.249 plugin-container[1643:7601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 08:49:47 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:47 INFO - PROCESS | 1642 | 2017-02-08 08:49:47.250 plugin-container[1643:7601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d27, name = 'com.apple.CFPasteboardClient' 08:49:47 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:49:47 INFO - PROCESS | 1642 | 2017-02-08 08:49:47.250 plugin-container[1643:7601] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:49:56 INFO - PROCESS | 1642 | RSS: Main: 218890240 08:49:56 INFO - PROCESS | 1642 | 08:52:59 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:53:01 INFO - PROCESS | 1642 | RSS: Main: 237465600 08:53:01 INFO - PROCESS | 1642 | 08:54:45 INFO - PROCESS | 1642 | ************************* 08:54:45 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 08:54:45 INFO - PROCESS | 1642 | 08:54:45 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:54:45 INFO - PROCESS | 1642 | Full stack: 08:54:45 INFO - PROCESS | 1642 | ************************* 08:56:03 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 08:56:04 INFO - PROCESS | 1642 | RSS: Main: 247685120 08:56:04 INFO - PROCESS | 1642 | 08:59:06 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 08:59:07 INFO - PROCESS | 1642 | RSS: Main: 254054400 08:59:07 INFO - PROCESS | 1642 | 09:02:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 09:02:09 INFO - PROCESS | 1642 | RSS: Main: 253702144 09:02:09 INFO - PROCESS | 1642 | 09:05:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 09:05:13 INFO - PROCESS | 1642 | RSS: Main: 258113536 09:05:13 INFO - PROCESS | 1642 | 09:08:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 09:08:16 INFO - PROCESS | 1642 | RSS: Main: 259563520 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | __start_tp_report 09:08:16 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:08:16 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:08:16 INFO - PROCESS | 1642 | |i|pagename|runs| 09:08:16 INFO - PROCESS | 1642 | |0;dojo.html;3387.762856600038;3396.473546600278;3413.5391722117506;3418.1112910643233;3426.366122267381;5362.785488580452;5746.19553262543;5798.956187886179;5836.212111364965;5838.474537291643;5740.823131258093;5744.224529688491;5825.271841019872;5857.150713146591;5859.501942334907;5105.2086926526445;5280.973595132019;5282.7622756976025;5288.709120998363;5324.440933701963;5339.706316152629;5346.705931173784;5357.330333708286;5358.196270559428;5388.4611538846;5192.1952097424955;5214.035403450355;5358.866028349284;5361.437049109846;5364.302640656729;5317.813876514303;5317.813876514323;5320.9467905320835;5331.840044798662;5353.384360798519;4165.97917010416;5154.238571599381;5271.156614941591;5286.947130528684;5316.12283973144;5752.28096487939;5851.61964472308;5857.062869940832;5863.413658634145;5885.617434866763;5736.082226843685;6092.482139018189;6149.5241142126015;6201.844953876144;6218.4714299284615;6259;6307.747690092391;6315.684215789192;6325.430711236011;6325.588836725644;4618.35343051973;4997.625178111656;5996.220491336142;6024.97575412181;6041.848953776147;5306.708131052752;6212.4408803207925;6250.937490625036;6328.335524769925;6439.484841212692;6109.860177052684;6121.239585875146;6157.0456579230295;6225.657588832658;6249.96875015622;6245.96877015612;6272.560920735505;6275.592086514362;6284.151639528696;6324.051392291193;6141.477974372228;6272.3100458949475;6281.089242059968;6306.527010474233;6318.368163183645;4676.859694209179;6101.359357267512;6173.9073913891325;6192.318844927145;6274.6235225885675;5085.923711144335;5086.847394578169;5087.694738315713;5099.184130539096;5109.718965456936;4508;4518.864434066917;4528.547145285445;4538.251188553918;4592.448906131285;5536.474034966672;5536.612437129363;5540.335159780852;5746.712664366765;5810.360860305363;6030.849228769316;6107.908381374283;6112.138751317739;6113.081058499921;6128.938710612926;5560.916586251209;5591.7483713233005;5593.105103183471;5618.43815618443;5624.409437009137;5312.495312945264;5411.512963833274;5465;5473.151661492475;5520.751566179531;6415.935840641534;6416.582922110048;6430.260520040255;6446.323136070832;6452.870942581028;6164.876702466016;6206.06908963641;6246.593971391845;6267.091271765477;6270.404311590391;5853.1805547222575;6350.968245158745;6386.329435409215;6458.289588145394;6528;6134.436587033385;6198.473129784019;6205.844853878689;6272.027835685476;6284.402981716729;6193.628382297076;6227.906581401192;6237.781677641261;6241.032639940817;6270.874582508415;5072.9746351268;6070.2108725865355;6221.657808820558;6227.408396202353;6238.313785483502;6113.816585502442;6136.580349164012;6183;6195.4424101831055;6237.126802247598;4972.428170760409;6035.879282414239;6070.2412198475195;6119.724612392364;6122.112293717475;6212.316645169119;6215.440610345091;6219.0982307566055;6220.0047992321015;6239.812805615838;5629.043062679436;5727.11229759388;6041.577089603686;6060.727267273071;6064.605800622945 09:08:16 INFO - PROCESS | 1642 | |1;ext.html;417.8286902370029;437.31560108430284;469.7463369780319;502.80641952848146;505.0328968667041;34118.80584179554;39422;40628.39057414138;43420.3486947696;43434.262629494864;38264.04339891504;42025.789871050605;44078.33882491757;44383.55616443835;44702.776486117604;7741.690332386726;7988.841617965391;8852.716356128358;8948.284137269035;9311;9731.172850307697;10355.482225888676;11390.487428065715;11527;11540.422978851066;10534.683164604425;10675.946620266888;11515.078793696484;11555.364454954974;11599;11340.943295283512;11390.860913908626;11404.771904561903;11423.828642570368;11451.141164412618;11339.37633430161;11381.487833047533;11390.088792896548;11420;11435.428228588537;41416.79291603523;41785;41829.74510764682;41831.581684183075;42040.36939445911;3973.1854969731135;3984.143409167014;4093.3450647896493;4096.446979657768;4179.582041795827;30107.69892301071;30480.695193048006;30637.080887573407;31806.20484487883;32092;3299.290652509722;3303.933921321584;3314.950275745866;3322.96677033229;3382.52644629752;465531;473908.99999999657;476482;476803;478931.9999999965;65910.67044664746;66042;66119;66202.33797662058;66266;69186.30813691899;69847.65076174587;70012;70041;70109;16534.173291335384;17116.486505404857;17142.40001599938;17149.657006859794;17181.226844792014;11698.88301116995;11927;12723.55467558631;12883.806742898863;13043.086983911035;14787;15532;18196;18221.18004689792;18411.72382414265;7749.961250193825;7775.961120194363;7793.2334021421575;7797.532148071134;7836.608169591497;908.681961313535;910.4719262827545;920.8572671235969;922.9261659067258;944.7732544189345;24785.1325203617;25237.87381063083;30533.23666908345;31074.223144421117;31586.526202106987;1021.3412349034979;1067.151614466501;1075.306427354352;1097.5116073347283;1224.0819385460904;16117.83882161187;16852.904561203482;16942.491725248263;17062.82937170637;17092.48722538326;506370;638530;641480;642029;644403;64317;64912;64985.35014649887;65061.67469162624;65227.67386163134;1286.9613911582667;1501.8122734658168;1505.8644721975074;1511.9319630616649;1518.9392424303126;28908.42183156367;30302.69697303087;30465.847670761505;31032;31087.533686995164;54693.72653136868;55042;55460.445395545525;55460.72269638626;55883.44116558782;592183;594059;594549;595082;597318;40844.38733419061;42277.36583951305;42283.3657495144;42289.78855105828;44233;41200.595829195634;41661.79169104135;42078.36882446705;42567.57432425636;42905;35493;35794.74718384844;36331.910042698764;36370;37535.249295014495;36346.63653363432;36442.63557364392;36472;37070.25859482849;37345.43981840329;35446;35743.821280893426;36309.27381452409;36328;36534.4519832208;31125.533117003717;32870;32898.5065224017;32930.84742034017;32961.67038329682;24282.271531854072;24600.138995135083;24627.753722462545;24906.750932490442;24987 09:08:16 INFO - PROCESS | 1642 | |2;jquery.html;356.22521016788477;373.46594370050826;394.3158619794656;397.7215948835816;404.31872295182603;19464.70802937955;20271.391858244275;21396.25113121041;21664.566708665858;21669.241576544824;20171.09230084646;20462.795372046276;20784.2725504607;21402.46493837655;21571.352859414204;5088.694678319294;5101.744912754366;5209.218617207412;5217.58259339252;5273.86815329616;3830.348840697074;4033.35466325388;5113.846584602468;5188.7146206958605;5194.194899790538;5542.7782888684405;5800.419958004208;5821.3305469870875;5878;5882.411758824105;5625.296837895284;5741.368449470555;5812.157237200625;5836.941630583704;5843.853903652422;4670.486246512881;5219.903820197763;5668.773249070032;5683.460071293221;5691.345495268056;12210.75578488434;12479.875201248053;12497;12565.748685026248;12589.559365422258;2585.6250843627568;2645.232882464083;2656;2682.8390296582265;2697.2852194168563;9412.294077944181;9776.36453630519;9797.058110001495;9974.202063834875;10008.149307308888;1818.209079050604;1869.8504119670395;1871.5508278013315;1890.2533499267713;1902.229597013198;129613;129626.35186824006;129962.70037299601;131410.34294828464;134190.3290483551;11952.88047119535;12079.637610871689;12084.516619335303;12129.636110916686;12295;15670.608234793994;15791.36834526606;15794.815388845882;15821.288042038135;15840.841591584167;8640.827183456297;8817.779555511035;8871.689490867788;8949.731508054769;9002.189802917768;8589.441686290496;8620.827583448296;8622.870656940151;8714.782130446789;8760.299176065899;4613.423322084739;4689.390379250675;4781.474037855833;4895.828645997373;4929.482404347564;1866.1229222265513;1986.771521275043;2031.61399334129;2070.8256330852546;3100.488419410772;662.2946561911549;771.5255118102326;822.7535284044677;828.7140936376941;843.2579330189394;20247.87411785254;21376.58702389277;21881.8380743983;22288.88555572215;22508.099676012775;1054.2040759226734;1058.1640504001907;1068.7541865370852;1090.1496832470687;1099.3898386395467;9105.77235569116;10653.414062226497;10873.945630271955;11044.889551104547;11095.334279943228;708350;715026;719311;726397;733778;132247;143558;143807.40481488046;149792.2510387441;152847;1004.6885465505717;1036.9216015343957;1045.6235755128148;1049.0925349572565;1049.679847646475;18624.906875465535;19132.904335478233;19405.805941940966;19561.70657440168;19615.411537653894;61213.693931530055;61930;62227.688861555405;62627;63059.684701576196;87931;89598.55200723954;89819;90537.6419353697;91654.16691666262;6759.493038022069;7797.220277972384;7995.960020199862;8094.51432914027;8210.58947052657;12026.939865300617;13194;13493.055486116271;13546.254955977516;13664.180149191081;11382.260153090354;11455.255408398427;11643.243189192675;11716.70708232301;11932.761344772882;9971.850422243528;10412.68761937143;10768;11626.53493860236;11633.302001879914;6182.474489668429;8081.63632636521;8877.822443551222;10705.732356691145;11013.889861101607;6744.7976560703255;8263.297619702393;8346.499210047417;8385.874211886705;8395.538245396561;8077.515349079074;11474.598389056677;11800;11801.232919860182;11811.763764724828 09:08:16 INFO - PROCESS | 1642 | |3;mootools.html;1281.9679508012298;1416.4900635771128;1426.108682073704;1429.263929076525;1432.5630682641793;7421.332080112788;7669.616519174033;7928.286454219119;8373.958130209341;8387;6526.6736663166885;8107.067687215972;8121.350291976642;8199.221073997976;8221.6300266488;2225.4547635829204;2261.378121016717;2262.1403866530695;2263.0834512022657;2265.0486795545826;2046.9590608187827;2123.384218576611;2245.820334373246;2289.5993201189726;2292.2550171194343;2197.6704094023125;2270.398344438725;2271.2618399020303;2278.6809846621486;2281.087564974007;2221.9000144993515;2230.2194232018824;2256.2892688802976;2260.79652831246;2261.197274967379;2014.21445636202;2078.7505499340177;2126.8723876567456;2212.2588932707563;2220.200727738013;6838.658067096675;8219.83560328796;8257.504549727035;8321.583920803936;8326.791830204293;4983.426905905831;5100.540951314362;5119.334486516766;5122.154844450662;5123.2827404163445;2778.4443111377605;3320.169957510622;3325.1145472513517;3399.2521645238007;3400.846961886696;990.895955924632;1232.2852745407642;1261.1298204239047;1266.5756971414587;1732.774739283885;10418.843717344245;10582.576696932114;10607.098396636295;10664.840027399596;10671.786564268672;4133.710640255214;4289.828406863753;4363.3018717005125;4369.890752731207;4378.540253273424;7520.6239688015385;8010.919890801134;8606.35452341077;8669.349798765117;8711.085336039625;4934.284528743312;4964.851054468371;4996.975015124901;5014.598832093424;5014.674046186986;4503.977480112644;4657.6273898088075;4693.601043911306;4696.365990591295;4712.976435117871;3849.191669749328;3894.123822139996;3941.5467221269346;3969.543502497192;3990.880273591797;1114.593173491686;1173.730042090324;1210.8304837322783;1281.6667666406802;1300.5773123734823;666.73997141115;750.2609929219714;787.9921200788034;808.4987307869159;813.2436833744674;4949.208126699711;4992.375953005874;5038.269450929594;5058.215976523571;5058.570021548136;536.4367414215136;546.8414159893666;614.9729950981871;929.9732159748273;1019.857759309578;3022.727954484107;3411.300683359905;3421.349943510725;3539.7876127431923;3584.7490675652975;7972.681092756225;9589.760255993517;9839.60641574329;9841.704748857546;9921.900780992097;9737.707868763948;9768.90231097694;9770.609175633037;9788.314817962675;9803.313768036312;6592.274849766618;7318;7661.157272699998;7700.691972321044;7745.993020907246;4641.582257596832;5279.630425870152;5304.7347632618985;5366.758495867617;5485.286912701324;8679.609417576097;8740.650373984969;8792.42849214799;8859.06979767115;9187.540622968958;8843.867341989746;8993.550322483981;9046.411983221069;9166.816663666823;9181.954090229507;6961.860762784817;7047.048648432601;7048.295170482911;7134.357907788324;7155.785326440215;7569.621518923922;7649.502782319131;7666.693332266647;7679.2704693054075;7709.575973321297;6834.316568343126;6972.686229119803;7020.403265722471;7049.894251586128;7061.611611361424;6758.3917447428;6819.181698196248;6828.453723701992;6915.481338899502;6946.930530694628;5526.281583394133;5991.2510936132985;6159.260888693386;6163.568550201443;6265.780697675559;4746.5490778376;4752.572268495714;4786.138495070782;4824.962633033914;4827.179379505563;4614.215583350771;4674.69614475058;4699.107169637758;4802.135615589227;4846.660733748604 09:08:16 INFO - PROCESS | 1642 | |4;prototype.html;360.0584471606749;363.36048554544004;371.2797173483442;375.1690006635302;377.90174554615794;5177.094008548498;5344.877575709096;5441.891162176754;5577.470140336672;5594.972025139874;4657.860264192072;4806.9038619227595;4877.902621722847;5384.165454354581;5494.423085576017;3553.7157027437806;4286.228478873802;4306.913861722764;4307.698461107724;4346.8043938022865;4181.595582540036;4273.764942928137;4317.805698743548;4331.935020974688;4348.5216626171095;3525;4203.222403855281;4252.383404406375;4259.126878989815;4261.680373971949;3372.9325413491592;3936.586658400884;4054.2499637567;4149.190907772985;4236.279832428495;3380.0535849961802;3528.7353448491467;3555.5955397617795;3701.5188025556777;3786.072412258987;4418.82901031227;4573.403729252081;4933.876653083666;5219.8434046978655;5346.465353464661;4448.399466072071;4576.87866472713;4879.8780030499165;4931.3835770528685;4957.900841983176;4910.1586904910655;5768.769249230026;5773.653580785166;5782.653040817564;5787.466321424826;3663.725220608465;3851.364524853396;3936.252112098692;3972.106276087886;4213.6839737019845;5041.823536176253;5391.81128660499;6045.21412216409;6124.571280010401;6172.722227499728;3990.1620659661794;4008.599140086026;4017.31705610047;4029.315016447152;4041.939370909439;3366.1584603849037;3427.520147179397;4031.1859663151113;4056.290149223874;4077;4198.391233271159;4719.646026548023;4723.858284251478;4740.360051393087;4774.236122220428;4918.926216106761;4987.725675087832;5042.974785126051;5621.8194179222;5891.46976772084;1115.6987613344513;1245.339969815999;1253.8401978170339;1272.5736878145924;1300.811382349573;795.738754074798;862.2153840005565;893.9719322778857;896.780288829241;905.6151135767273;4342.69601127918;4574.725516469022;4835.274708793639;5164.431912489698;5173.689578625294;5715.1422789616845;5744;5775.873704627557;5780.826575202666;5784.219130417424;4352.630026447724;4377.409049778303;5197.324347834758;5197.558207552324;5200.5059519345605;2951.2326795033446;2979.5977543031413;3029.4095599810275;3047.9695203048127;3066.6473355564394;4718.9292160617615;5920.79277225295;5975.79084732041;6014.609050411709;6057.6975950170045;5107.795688172431;5275.129603615437;5464.098423760035;5873.706314684248;5927.851803704942;4905.950940490621;5427.9185812212845;5444.237806707064;5955.106733989936;5982.7008649568215;4792.7603619819565;5067.695938243717;5522.144067669517;5539;5724.962033410572;4964.411388355836;5093.592512599057;5442.646227995326;5567.415421380697;5939.584229103922;4945.7527123644395;5481.123020316731;5940.504987905004;6181.629102253879;6282.2147231596055;4166.45905788801;4217.409562661169;4282.828686852616;4292.399064131087;4312.210432670407;4712.057588482386;5099.36257967754;5331.094553468447;5335.253064570886;5942.435468630646;5618.752499000432;5705.286839145107;5794.478496935296;5798.391168927371;5811.82564523065;5512.310961129859;5793.507551858139;5823.970880145572;5826.242588463642;5839.328477225004;5242.929043028059;5437.972810136082;5609.887802244014;5661.915071274017;5743.368229494668;5114.974425127851;5788.768449261982;5806.622569532967;5836.970815145897;5849.53203743708;5017.473165317735;5200.297959775382;5246.921296180637;5662.631928924607;5662.943370566406 09:08:16 INFO - PROCESS | 1642 | |5;yui.html;710.0875375142942;724.3408498266577;738.5273425007996;771.811410427941;835.5154010673808;14604.342804573793;15396.461123860667;15503.689926201483;15507.379704811809;15511.146886921215;14292.571222863306;14359.497417590386;14375.78436323456;14413.486583908696;14622.415103395879;866.8959724832997;888.5468411110315;891.31814162166;897.4211633496391;898.4878619187066;779.6686408276488;859.7850537365658;882.483747008001;882.8013696918206;884.1026358246385;932.580338847518;939.6288466055904;941.5339406993547;942.8114377124602;946.3139224062534;932.8740620016313;934.3646320502056;935.163029088965;935.3125452792192;935.7707361696428;695.6660802814678;699.601227300439;702.3748863511479;703.5251205436361;704.2534912992194;15251.923740381228;15514.069155850684;15519.224038798127;15581.454649087342;15632.218389080614;13809.861901380958;13858.792118118236;13974;14014.159150451005;14044.92977535116;8905;11694.941525292405;11750.353730544817;11902.226355286879;12068.879311206863;3611.4763359313015;3636.6181550937035;3651.06897741077;3657.6342365763476;3693.261347730465;91753;101244;103701.48149259205;104007;105198;9689.740333756567;10587.014070656385;10831.187660925461;10888.510017049251;10935.015848573667;20429.69355459669;21657;21852.672209916545;21869.781302186773;22157.889210554167;7430.294122058396;7677;7720.729774457867;7734.342580880576;7744.2642948919765;4259.21204577148;4322.632576231055;4401.1417773534495;4429.933550996738;4459.063596644741;3394.5417368655408;3466.272082862627;3509.649035096521;3511.613722490524;3515.3848076586496;558.4192439862497;610.9613656783486;628.4626644219127;631.6683741035993;652.3704625036768;697.3235961117708;711.1288671377521;724.2648711557773;730.2259604818909;738.1253214940313;8463.407561470638;10090.293679442515;10368.844467332996;10471.16230701542;10647.414392208348;702.4750338587078;710.5772065620947;717.2110678253879;722.7903907866765;730.302561054192;4063.837446502166;5046;5079.212722028092;5079.593632509391;5101.617378696613;69973.3002669977;70506.23734406578;87588;91191;94850;65727.68544629177;67726.32273677299;85246.14753852507;85592.14407855966;86958;78122;80943.59528202438;81720;81931;83511.99999999878;9355.625774968925;9571.664991725256;9572.329936904629;9787.412755234709;10726.195535334726;44946.77526612346;51116.48883511117;52304.47695522996;52595;53504;74356;75641.62179189069;76860.61569692116;77606.61196694206;77729.22270777446;11149.275297105662;11343.829842552203;11455.541778328774;11657.825132622847;11818.231814932002;12385.256884586954;12471.875281247072;12700.936495317465;13014.609561713163;13064.477420903437;11698.590549331073;12055;12056.216345937486;12522.37388130608;12545.247285162919;11766.294022358687;11975.401229938294;11985.101117416403;12008.579699710817;12355.69110772202;8933.865992009994;11707.88292117102;11890.643280701246;11913.583024594443;12187.329696866758;9811.705648830546;9818.950905245429;9998;10117.342372745748;10419.270651054656;9932.063726419296;9952.970247703071;9967.304764519546;9973.373754699587;9991.35488449024 09:08:16 INFO - PROCESS | 1642 | __end_tp_report 09:08:16 INFO - PROCESS | 1642 | __start_cc_report 09:08:16 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,370 09:08:16 INFO - PROCESS | 1642 | __end_cc_report 09:08:16 INFO - PROCESS | 1642 | __startTimestamp1486573696012__endTimestamp 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:08:16 INFO - PROCESS | 1642 | Number of tests: 6 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5746.74 Median:6030.85 stddev:651.87 (10.8%) stddev-sans-first:627.05 09:08:16 INFO - PROCESS | 1642 | Values: 3387.8 3396.5 3413.5 3418.1 3426.4 5362.8 5746.2 5799.0 5836.2 5838.5 5740.8 5744.2 5825.3 5857.2 5859.5 5105.2 5281.0 5282.8 5288.7 5324.4 5339.7 5346.7 5357.3 5358.2 5388.5 5192.2 5214.0 5358.9 5361.4 5364.3 5317.8 5317.8 5320.9 5331.8 5353.4 4166.0 5154.2 5271.2 5286.9 5316.1 5752.3 5851.6 5857.1 5863.4 5885.6 5736.1 6092.5 6149.5 6201.8 6218.5 6259.0 6307.7 6315.7 6325.4 6325.6 4618.4 4997.6 5996.2 6025.0 6041.8 5306.7 6212.4 6250.9 6328.3 6439.5 6109.9 6121.2 6157.0 6225.7 6250.0 6246.0 6272.6 6275.6 6284.2 6324.1 6141.5 6272.3 6281.1 6306.5 6318.4 4676.9 6101.4 6173.9 6192.3 6274.6 5085.9 5086.8 5087.7 5099.2 5109.7 4508.0 4518.9 4528.5 4538.3 4592.4 5536.5 5536.6 5540.3 5746.7 5810.4 6030.8 6107.9 6112.1 6113.1 6128.9 5560.9 5591.7 5593.1 5618.4 5624.4 5312.5 5411.5 5465.0 5473.2 5520.8 6415.9 6416.6 6430.3 6446.3 6452.9 6164.9 6206.1 6246.6 6267.1 6270.4 5853.2 6351.0 6386.3 6458.3 6528.0 6134.4 6198.5 6205.8 6272.0 6284.4 6193.6 6227.9 6237.8 6241.0 6270.9 5073.0 6070.2 6221.7 6227.4 6238.3 6113.8 6136.6 6183.0 6195.4 6237.1 4972.4 6035.9 6070.2 6119.7 6122.1 6212.3 6215.4 6219.1 6220.0 6239.8 5629.0 5727.1 6041.6 6060.7 6064.6 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:70586.51 Median:36503.23 stddev:150899.91 (413.4%) stddev-sans-first:151231.25 09:08:16 INFO - PROCESS | 1642 | Values: 417.8 437.3 469.7 502.8 505.0 34118.8 39422.0 40628.4 43420.3 43434.3 38264.0 42025.8 44078.3 44383.6 44702.8 7741.7 7988.8 8852.7 8948.3 9311.0 9731.2 10355.5 11390.5 11527.0 11540.4 10534.7 10675.9 11515.1 11555.4 11599.0 11340.9 11390.9 11404.8 11423.8 11451.1 11339.4 11381.5 11390.1 11420.0 11435.4 41416.8 41785.0 41829.7 41831.6 42040.4 3973.2 3984.1 4093.3 4096.4 4179.6 30107.7 30480.7 30637.1 31806.2 32092.0 3299.3 3303.9 3315.0 3323.0 3382.5 465531.0 473909.0 476482.0 476803.0 478932.0 65910.7 66042.0 66119.0 66202.3 66266.0 69186.3 69847.7 70012.0 70041.0 70109.0 16534.2 17116.5 17142.4 17149.7 17181.2 11698.9 11927.0 12723.6 12883.8 13043.1 14787.0 15532.0 18196.0 18221.2 18411.7 7750.0 7776.0 7793.2 7797.5 7836.6 908.7 910.5 920.9 922.9 944.8 24785.1 25237.9 30533.2 31074.2 31586.5 1021.3 1067.2 1075.3 1097.5 1224.1 16117.8 16852.9 16942.5 17062.8 17092.5 506370.0 638530.0 641480.0 642029.0 644403.0 64317.0 64912.0 64985.4 65061.7 65227.7 1287.0 1501.8 1505.9 1511.9 1518.9 28908.4 30302.7 30465.8 31032.0 31087.5 54693.7 55042.0 55460.4 55460.7 55883.4 592183.0 594059.0 594549.0 595082.0 597318.0 40844.4 42277.4 42283.4 42289.8 44233.0 41200.6 41661.8 42078.4 42567.6 42905.0 35493.0 35794.7 36331.9 36370.0 37535.2 36346.6 36442.6 36472.0 37070.3 37345.4 35446.0 35743.8 36309.3 36328.0 36534.5 31125.5 32870.0 32898.5 32930.8 32961.7 24282.3 24600.1 24627.8 24906.8 24987.0 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:39502.25 Median:2650.62 stddev:120140.35 (4532.5%) stddev-sans-first:120441.41 09:08:16 INFO - PROCESS | 1642 | Values: 356.2 373.5 394.3 397.7 404.3 19464.7 20271.4 21396.3 21664.6 21669.2 20171.1 20462.8 20784.3 21402.5 21571.4 5088.7 5101.7 5209.2 5217.6 5273.9 3830.3 4033.4 5113.8 5188.7 5194.2 5542.8 5800.4 5821.3 5878.0 5882.4 5625.3 5741.4 5812.2 5836.9 5843.9 4670.5 5219.9 5668.8 5683.5 5691.3 12210.8 12479.9 12497.0 12565.7 12589.6 2585.6 2645.2 2656.0 2682.8 2697.3 9412.3 9776.4 9797.1 9974.2 10008.1 1818.2 1869.9 1871.6 1890.3 1902.2 129613.0 129626.4 129962.7 131410.3 134190.3 11952.9 12079.6 12084.5 12129.6 12295.0 15670.6 15791.4 15794.8 15821.3 15840.8 8640.8 8817.8 8871.7 8949.7 9002.2 8589.4 8620.8 8622.9 8714.8 8760.3 4613.4 4689.4 4781.5 4895.8 4929.5 1866.1 1986.8 2031.6 2070.8 3100.5 662.3 771.5 822.8 828.7 843.3 20247.9 21376.6 21881.8 22288.9 22508.1 1054.2 1058.2 1068.8 1090.1 1099.4 9105.8 10653.4 10873.9 11044.9 11095.3 708350.0 715026.0 719311.0 726397.0 733778.0 132247.0 143558.0 143807.4 149792.3 152847.0 1004.7 1036.9 1045.6 1049.1 1049.7 18624.9 19132.9 19405.8 19561.7 19615.4 61213.7 61930.0 62227.7 62627.0 63059.7 87931.0 89598.6 89819.0 90537.6 91654.2 6759.5 7797.2 7996.0 8094.5 8210.6 12026.9 13194.0 13493.1 13546.3 13664.2 11382.3 11455.3 11643.2 11716.7 11932.8 9971.9 10412.7 10768.0 11626.5 11633.3 6182.5 8081.6 8877.8 10705.7 11013.9 6744.8 8263.3 8346.5 8385.9 8395.5 8077.5 11474.6 11800.0 11801.2 11811.8 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5211.77 Median:5058.39 stddev:2852.35 (56.4%) stddev-sans-first:2845.06 09:08:16 INFO - PROCESS | 1642 | Values: 1282.0 1416.5 1426.1 1429.3 1432.6 7421.3 7669.6 7928.3 8374.0 8387.0 6526.7 8107.1 8121.4 8199.2 8221.6 2225.5 2261.4 2262.1 2263.1 2265.0 2047.0 2123.4 2245.8 2289.6 2292.3 2197.7 2270.4 2271.3 2278.7 2281.1 2221.9 2230.2 2256.3 2260.8 2261.2 2014.2 2078.8 2126.9 2212.3 2220.2 6838.7 8219.8 8257.5 8321.6 8326.8 4983.4 5100.5 5119.3 5122.2 5123.3 2778.4 3320.2 3325.1 3399.3 3400.8 990.9 1232.3 1261.1 1266.6 1732.8 10418.8 10582.6 10607.1 10664.8 10671.8 4133.7 4289.8 4363.3 4369.9 4378.5 7520.6 8010.9 8606.4 8669.3 8711.1 4934.3 4964.9 4997.0 5014.6 5014.7 4504.0 4657.6 4693.6 4696.4 4713.0 3849.2 3894.1 3941.5 3969.5 3990.9 1114.6 1173.7 1210.8 1281.7 1300.6 666.7 750.3 788.0 808.5 813.2 4949.2 4992.4 5038.3 5058.2 5058.6 536.4 546.8 615.0 930.0 1019.9 3022.7 3411.3 3421.3 3539.8 3584.7 7972.7 9589.8 9839.6 9841.7 9921.9 9737.7 9768.9 9770.6 9788.3 9803.3 6592.3 7318.0 7661.2 7700.7 7746.0 4641.6 5279.6 5304.7 5366.8 5485.3 8679.6 8740.7 8792.4 8859.1 9187.5 8843.9 8993.6 9046.4 9166.8 9182.0 6961.9 7047.0 7048.3 7134.4 7155.8 7569.6 7649.5 7666.7 7679.3 7709.6 6834.3 6972.7 7020.4 7049.9 7061.6 6758.4 6819.2 6828.5 6915.5 6946.9 5526.3 5991.3 6159.3 6163.6 6265.8 4746.5 4752.6 4786.1 4825.0 4827.2 4614.2 4674.7 4699.1 4802.1 4846.7 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4586.23 Median:5029.65 stddev:1385.15 (27.5%) stddev-sans-first:1352.23 09:08:16 INFO - PROCESS | 1642 | Values: 360.1 363.4 371.3 375.2 377.9 5177.1 5344.9 5441.9 5577.5 5595.0 4657.9 4806.9 4877.9 5384.2 5494.4 3553.7 4286.2 4306.9 4307.7 4346.8 4181.6 4273.8 4317.8 4331.9 4348.5 3525.0 4203.2 4252.4 4259.1 4261.7 3372.9 3936.6 4054.2 4149.2 4236.3 3380.1 3528.7 3555.6 3701.5 3786.1 4418.8 4573.4 4933.9 5219.8 5346.5 4448.4 4576.9 4879.9 4931.4 4957.9 4910.2 5768.8 5773.7 5782.7 5787.5 3663.7 3851.4 3936.3 3972.1 4213.7 5041.8 5391.8 6045.2 6124.6 6172.7 3990.2 4008.6 4017.3 4029.3 4041.9 3366.2 3427.5 4031.2 4056.3 4077.0 4198.4 4719.6 4723.9 4740.4 4774.2 4918.9 4987.7 5043.0 5621.8 5891.5 1115.7 1245.3 1253.8 1272.6 1300.8 795.7 862.2 894.0 896.8 905.6 4342.7 4574.7 4835.3 5164.4 5173.7 5715.1 5744.0 5775.9 5780.8 5784.2 4352.6 4377.4 5197.3 5197.6 5200.5 2951.2 2979.6 3029.4 3048.0 3066.6 4718.9 5920.8 5975.8 6014.6 6057.7 5107.8 5275.1 5464.1 5873.7 5927.9 4906.0 5427.9 5444.2 5955.1 5982.7 4792.8 5067.7 5522.1 5539.0 5725.0 4964.4 5093.6 5442.6 5567.4 5939.6 4945.8 5481.1 5940.5 6181.6 6282.2 4166.5 4217.4 4282.8 4292.4 4312.2 4712.1 5099.4 5331.1 5335.3 5942.4 5618.8 5705.3 5794.5 5798.4 5811.8 5512.3 5793.5 5824.0 5826.2 5839.3 5242.9 5438.0 5609.9 5661.9 5743.4 5115.0 5788.8 5806.6 5837.0 5849.5 5017.5 5200.3 5246.9 5662.6 5662.9 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19559.53 Median:52449.74 stddev:27740.79 (52.9%) stddev-sans-first:27782.51 09:08:16 INFO - PROCESS | 1642 | Values: 710.1 724.3 738.5 771.8 835.5 14604.3 15396.5 15503.7 15507.4 15511.1 14292.6 14359.5 14375.8 14413.5 14622.4 866.9 888.5 891.3 897.4 898.5 779.7 859.8 882.5 882.8 884.1 932.6 939.6 941.5 942.8 946.3 932.9 934.4 935.2 935.3 935.8 695.7 699.6 702.4 703.5 704.3 15251.9 15514.1 15519.2 15581.5 15632.2 13809.9 13858.8 13974.0 14014.2 14044.9 8905.0 11694.9 11750.4 11902.2 12068.9 3611.5 3636.6 3651.1 3657.6 3693.3 91753.0 101244.0 103701.5 104007.0 105198.0 9689.7 10587.0 10831.2 10888.5 10935.0 20429.7 21657.0 21852.7 21869.8 22157.9 7430.3 7677.0 7720.7 7734.3 7744.3 4259.2 4322.6 4401.1 4429.9 4459.1 3394.5 3466.3 3509.6 3511.6 3515.4 558.4 611.0 628.5 631.7 652.4 697.3 711.1 724.3 730.2 738.1 8463.4 10090.3 10368.8 10471.2 10647.4 702.5 710.6 717.2 722.8 730.3 4063.8 5046.0 5079.2 5079.6 5101.6 69973.3 70506.2 87588.0 91191.0 94850.0 65727.7 67726.3 85246.1 85592.1 86958.0 78122.0 80943.6 81720.0 81931.0 83512.0 9355.6 9571.7 9572.3 9787.4 10726.2 44946.8 51116.5 52304.5 52595.0 53504.0 74356.0 75641.6 76860.6 77606.6 77729.2 11149.3 11343.8 11455.5 11657.8 11818.2 12385.3 12471.9 12700.9 13014.6 13064.5 11698.6 12055.0 12056.2 12522.4 12545.2 11766.3 11975.4 11985.1 12008.6 12355.7 8933.9 11707.9 11890.6 11913.6 12187.3 9811.7 9819.0 9998.0 10117.3 10419.3 9932.1 9953.0 9967.3 9973.4 9991.4 09:08:16 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:08:16 INFO - PROCESS | 1642 | 09:08:16 INFO - TEST-INFO | 1642: exit 0 09:08:16 INFO - TEST-OK | dromaeo_css | took 1115877ms 09:08:16 INFO - TEST-START | kraken 09:08:16 INFO - operating with platform_type : mac_ 09:08:16 INFO - Initialising browser for kraken test... 09:08:16 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile http://localhost:49246/getInfo.html) 09:08:19 INFO - PROCESS | 1654 | 2017-02-08 09:08:19.458 plugin-container[1655:10009] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:08:19 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:19 INFO - PROCESS | 1654 | 2017-02-08 09:08:19.461 plugin-container[1655:10009] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 09:08:19 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:19 INFO - PROCESS | 1654 | 2017-02-08 09:08:19.461 plugin-container[1655:10009] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:08:19 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:08:19 INFO - PROCESS | 1654 | colorDepth:24 09:08:19 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:08:19 INFO - PROCESS | 1654 | __metrics 09:08:19 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:08:19 INFO - PROCESS | 1654 | 1486573699640 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:08:20 INFO - TEST-INFO | 1654: exit 0 09:08:20 INFO - Browser initialized. 09:08:20 INFO - Running cycle 1/1 for kraken test... 09:08:20 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpQCgxW4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:22 INFO - PROCESS | 1656 | 2017-02-08 09:08:22.725 plugin-container[1657:10134] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:08:22 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:22 INFO - PROCESS | 1656 | 2017-02-08 09:08:22.726 plugin-container[1657:10134] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.CFPasteboardClient' 09:08:22 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:22 INFO - PROCESS | 1656 | 2017-02-08 09:08:22.726 plugin-container[1657:10134] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:08:32 INFO - PROCESS | 1656 | RSS: Main: 218677248 09:08:32 INFO - PROCESS | 1656 | 09:08:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:36 INFO - PROCESS | 1656 | RSS: Main: 232824832 09:08:36 INFO - PROCESS | 1656 | 09:08:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 09:08:39 INFO - PROCESS | 1656 | RSS: Main: 241836032 09:08:39 INFO - PROCESS | 1656 | 09:08:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 09:08:43 INFO - PROCESS | 1656 | RSS: Main: 244760576 09:08:43 INFO - PROCESS | 1656 | 09:08:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 09:08:46 INFO - PROCESS | 1656 | RSS: Main: 246140928 09:08:46 INFO - PROCESS | 1656 | 09:08:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:49 INFO - PROCESS | 1656 | RSS: Main: 246132736 09:08:49 INFO - PROCESS | 1656 | 09:08:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:52 INFO - PROCESS | 1656 | RSS: Main: 249913344 09:08:52 INFO - PROCESS | 1656 | 09:08:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:56 INFO - PROCESS | 1656 | RSS: Main: 248840192 09:08:56 INFO - PROCESS | 1656 | 09:08:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 09:09:00 INFO - PROCESS | 1656 | RSS: Main: 249077760 09:09:00 INFO - PROCESS | 1656 | 09:09:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:02 INFO - PROCESS | 1656 | RSS: Main: 248610816 09:09:02 INFO - PROCESS | 1656 | 09:09:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:05 INFO - PROCESS | 1656 | RSS: Main: 248623104 09:09:05 INFO - PROCESS | 1656 | 09:09:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:08 INFO - PROCESS | 1656 | RSS: Main: 248705024 09:09:08 INFO - PROCESS | 1656 | 09:09:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:11 INFO - PROCESS | 1656 | RSS: Main: 249028608 09:09:11 INFO - PROCESS | 1656 | 09:09:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:15 INFO - PROCESS | 1656 | RSS: Main: 248750080 09:09:15 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 09:09:17 INFO - PROCESS | 1656 | RSS: Main: 250847232 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | __start_tp_report 09:09:17 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:09:17 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:09:17 INFO - PROCESS | 1656 | |i|pagename|runs| 09:09:17 INFO - PROCESS | 1656 | |0;ai-astar;99;144;161;121;156;169;170;117;122;172 09:09:17 INFO - PROCESS | 1656 | |1;audio-beat-detection;153;135;148;184;122;114;112;115;130;114 09:09:17 INFO - PROCESS | 1656 | |2;audio-dft;199;201;197;198;235;256;196;195;195;196 09:09:17 INFO - PROCESS | 1656 | |3;audio-fft;82;60;60;87;62;86;60;62;73;59 09:09:17 INFO - PROCESS | 1656 | |4;audio-oscillator;80;77;86;73;70;69;80;79;91;93 09:09:17 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;130;86;88;86;126;131;89;87;89;102 09:09:17 INFO - PROCESS | 1656 | |6;imaging-darkroom;99;138;117;103;175;174;99;98;99;99 09:09:17 INFO - PROCESS | 1656 | |7;imaging-desaturate;88;145;142;95;128;144;126;91;95;91 09:09:17 INFO - PROCESS | 1656 | |8;json-parse-financial;60;61;60;64;65;63;63;64;64;61 09:09:17 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;71;72;69;84;80;94;104;100;70;71 09:09:17 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;85;82;85;98;98;84;83;87;86;89 09:09:17 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;133;155;157;152;137;143;140;162;208;178 09:09:17 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;232;235;169;171;172;167;171;174;172;171 09:09:17 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;66;67;68;69;66;68;67;64;86;83 09:09:17 INFO - PROCESS | 1656 | __end_tp_report 09:09:17 INFO - PROCESS | 1656 | __start_cc_report 09:09:17 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,948 09:09:17 INFO - PROCESS | 1656 | __end_cc_report 09:09:17 INFO - PROCESS | 1656 | __startTimestamp1486573757383__endTimestamp 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:09:17 INFO - PROCESS | 1656 | Number of tests: 14 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:143.10 Median:165.00 stddev:26.41 (16.0%) stddev-sans-first:22.68 09:09:17 INFO - PROCESS | 1656 | Values: 99.0 144.0 161.0 121.0 156.0 169.0 170.0 117.0 122.0 172.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:132.50 stddev:23.20 (17.5%) stddev-sans-first:23.42 09:09:17 INFO - PROCESS | 1656 | Values: 153.0 135.0 148.0 184.0 122.0 114.0 112.0 115.0 130.0 114.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:206.80 Median:198.50 stddev:21.07 (10.6%) stddev-sans-first:22.16 09:09:17 INFO - PROCESS | 1656 | Values: 199.0 201.0 197.0 198.0 235.0 256.0 196.0 195.0 195.0 196.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:69.10 Median:67.50 stddev:11.73 (17.4%) stddev-sans-first:11.48 09:09:17 INFO - PROCESS | 1656 | Values: 82.0 60.0 60.0 87.0 62.0 86.0 60.0 62.0 73.0 59.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:80.00 stddev:8.20 (10.3%) stddev-sans-first:8.70 09:09:17 INFO - PROCESS | 1656 | Values: 80.0 77.0 86.0 73.0 70.0 69.0 80.0 79.0 91.0 93.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:86.50 stddev:19.63 (22.7%) stddev-sans-first:17.89 09:09:17 INFO - PROCESS | 1656 | Values: 130.0 86.0 88.0 86.0 126.0 131.0 89.0 87.0 89.0 102.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:120.10 Median:98.50 stddev:31.29 (31.8%) stddev-sans-first:32.24 09:09:17 INFO - PROCESS | 1656 | Values: 99.0 138.0 117.0 103.0 175.0 174.0 99.0 98.0 99.0 99.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:114.50 Median:89.50 stddev:24.58 (27.5%) stddev-sans-first:24.13 09:09:17 INFO - PROCESS | 1656 | Values: 88.0 145.0 142.0 95.0 128.0 144.0 126.0 91.0 95.0 91.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.50 stddev:1.84 (2.9%) stddev-sans-first:1.72 09:09:17 INFO - PROCESS | 1656 | Values: 60.0 61.0 60.0 64.0 65.0 63.0 63.0 64.0 64.0 61.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:81.50 Median:71.50 stddev:13.39 (18.7%) stddev-sans-first:13.65 09:09:17 INFO - PROCESS | 1656 | Values: 71.0 72.0 69.0 84.0 80.0 94.0 104.0 100.0 70.0 71.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:86.50 stddev:5.77 (6.7%) stddev-sans-first:6.04 09:09:17 INFO - PROCESS | 1656 | Values: 85.0 82.0 85.0 98.0 98.0 84.0 83.0 87.0 86.0 89.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:156.00 stddev:22.50 (14.4%) stddev-sans-first:22.19 09:09:17 INFO - PROCESS | 1656 | Values: 133.0 155.0 157.0 152.0 137.0 143.0 140.0 162.0 208.0 178.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:172.00 stddev:26.48 (15.4%) stddev-sans-first:21.47 09:09:17 INFO - PROCESS | 1656 | Values: 232.0 235.0 169.0 171.0 172.0 167.0 171.0 174.0 172.0 171.0 09:09:17 INFO - PROCESS | 1656 | 09:09:17 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:68.00 stddev:7.59 (11.2%) stddev-sans-first:7.88 09:09:17 INFO - PROCESS | 1656 | Values: 66.0 67.0 68.0 69.0 66.0 68.0 67.0 64.0 86.0 83.0 09:09:17 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:09:17 INFO - PROCESS | 1656 | 09:09:18 INFO - TEST-INFO | 1656: exit 0 09:09:18 INFO - TEST-OK | kraken | took 61600ms 09:09:18 INFO - SUITE-END | took 1177s 09:09:18 INFO - Completed test suite (00:19:37) 09:09:18 INFO - javascript benchmark 09:09:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.623312793179, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.762856600038, 3396.473546600278, 3413.5391722117506, 3418.1112910643233, 3426.366122267381, 5362.785488580452, 5746.19553262543, 5798.956187886179, 5836.212111364965, 5838.474537291643, 5740.823131258093, 5744.224529688491, 5825.271841019872, 5857.150713146591, 5859.501942334907, 5105.2086926526445, 5280.973595132019, 5282.7622756976025, 5288.709120998363, 5324.440933701963, 5339.706316152629, 5346.705931173784, 5357.330333708286, 5358.196270559428, 5388.4611538846, 5192.1952097424955, 5214.035403450355, 5358.866028349284, 5361.437049109846, 5364.302640656729, 5317.813876514303, 5317.813876514323, 5320.9467905320835, 5331.840044798662, 5353.384360798519, 4165.97917010416, 5154.238571599381, 5271.156614941591, 5286.947130528684, 5316.12283973144, 5752.28096487939, 5851.61964472308, 5857.062869940832, 5863.413658634145, 5885.617434866763, 5736.082226843685, 6092.482139018189, 6149.5241142126015, 6201.844953876144, 6218.4714299284615, 6259.0, 6307.747690092391, 6315.684215789192, 6325.430711236011, 6325.588836725644, 4618.35343051973, 4997.625178111656, 5996.220491336142, 6024.97575412181, 6041.848953776147, 5306.708131052752, 6212.4408803207925, 6250.937490625036, 6328.335524769925, 6439.484841212692, 6109.860177052684, 6121.239585875146, 6157.0456579230295, 6225.657588832658, 6249.96875015622, 6245.96877015612, 6272.560920735505, 6275.592086514362, 6284.151639528696, 6324.051392291193, 6141.477974372228, 6272.3100458949475, 6281.089242059968, 6306.527010474233, 6318.368163183645, 4676.859694209179, 6101.359357267512, 6173.9073913891325, 6192.318844927145, 6274.6235225885675, 5085.923711144335, 5086.847394578169, 5087.694738315713, 5099.184130539096, 5109.718965456936, 4508.0, 4518.864434066917, 4528.547145285445, 4538.251188553918, 4592.448906131285, 5536.474034966672, 5536.612437129363, 5540.335159780852, 5746.712664366765, 5810.360860305363, 6030.849228769316, 6107.908381374283, 6112.138751317739, 6113.081058499921, 6128.938710612926, 5560.916586251209, 5591.7483713233005, 5593.105103183471, 5618.43815618443, 5624.409437009137, 5312.495312945264, 5411.512963833274, 5465.0, 5473.151661492475, 5520.751566179531, 6415.935840641534, 6416.582922110048, 6430.260520040255, 6446.323136070832, 6452.870942581028, 6164.876702466016, 6206.06908963641, 6246.593971391845, 6267.091271765477, 6270.404311590391, 5853.1805547222575, 6350.968245158745, 6386.329435409215, 6458.289588145394, 6528.0, 6134.436587033385, 6198.473129784019, 6205.844853878689, 6272.027835685476, 6284.402981716729, 6193.628382297076, 6227.906581401192, 6237.781677641261, 6241.032639940817, 6270.874582508415, 5072.9746351268, 6070.2108725865355, 6221.657808820558, 6227.408396202353, 6238.313785483502, 6113.816585502442, 6136.580349164012, 6183.0, 6195.4424101831055, 6237.126802247598, 4972.428170760409, 6035.879282414239, 6070.2412198475195, 6119.724612392364, 6122.112293717475, 6212.316645169119, 6215.440610345091, 6219.0982307566055, 6220.0047992321015, 6239.812805615838, 5629.043062679436, 5727.11229759388, 6041.577089603686, 6060.727267273071, 6064.605800622945], "value": 5708.452661888241, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.8286902370029, 437.31560108430284, 469.7463369780319, 502.80641952848146, 505.0328968667041, 34118.80584179554, 39422.0, 40628.39057414138, 43420.3486947696, 43434.262629494864, 38264.04339891504, 42025.789871050605, 44078.33882491757, 44383.55616443835, 44702.776486117604, 7741.690332386726, 7988.841617965391, 8852.716356128358, 8948.284137269035, 9311.0, 9731.172850307697, 10355.482225888676, 11390.487428065715, 11527.0, 11540.422978851066, 10534.683164604425, 10675.946620266888, 11515.078793696484, 11555.364454954974, 11599.0, 11340.943295283512, 11390.860913908626, 11404.771904561903, 11423.828642570368, 11451.141164412618, 11339.37633430161, 11381.487833047533, 11390.088792896548, 11420.0, 11435.428228588537, 41416.79291603523, 41785.0, 41829.74510764682, 41831.581684183075, 42040.36939445911, 3973.1854969731135, 3984.143409167014, 4093.3450647896493, 4096.446979657768, 4179.582041795827, 30107.69892301071, 30480.695193048006, 30637.080887573407, 31806.20484487883, 32092.0, 3299.290652509722, 3303.933921321584, 3314.950275745866, 3322.96677033229, 3382.52644629752, 465531.0, 473908.99999999657, 476482.0, 476803.0, 478931.9999999965, 65910.67044664746, 66042.0, 66119.0, 66202.33797662058, 66266.0, 69186.30813691899, 69847.65076174587, 70012.0, 70041.0, 70109.0, 16534.173291335384, 17116.486505404857, 17142.40001599938, 17149.657006859794, 17181.226844792014, 11698.88301116995, 11927.0, 12723.55467558631, 12883.806742898863, 13043.086983911035, 14787.0, 15532.0, 18196.0, 18221.18004689792, 18411.72382414265, 7749.961250193825, 7775.961120194363, 7793.2334021421575, 7797.532148071134, 7836.608169591497, 908.681961313535, 910.4719262827545, 920.8572671235969, 922.9261659067258, 944.7732544189345, 24785.1325203617, 25237.87381063083, 30533.23666908345, 31074.223144421117, 31586.526202106987, 1021.3412349034979, 1067.151614466501, 1075.306427354352, 1097.5116073347283, 1224.0819385460904, 16117.83882161187, 16852.904561203482, 16942.491725248263, 17062.82937170637, 17092.48722538326, 506370.0, 638530.0, 641480.0, 642029.0, 644403.0, 64317.0, 64912.0, 64985.35014649887, 65061.67469162624, 65227.67386163134, 1286.9613911582667, 1501.8122734658168, 1505.8644721975074, 1511.9319630616649, 1518.9392424303126, 28908.42183156367, 30302.69697303087, 30465.847670761505, 31032.0, 31087.533686995164, 54693.72653136868, 55042.0, 55460.445395545525, 55460.72269638626, 55883.44116558782, 592183.0, 594059.0, 594549.0, 595082.0, 597318.0, 40844.38733419061, 42277.36583951305, 42283.3657495144, 42289.78855105828, 44233.0, 41200.595829195634, 41661.79169104135, 42078.36882446705, 42567.57432425636, 42905.0, 35493.0, 35794.74718384844, 36331.910042698764, 36370.0, 37535.249295014495, 36346.63653363432, 36442.63557364392, 36472.0, 37070.25859482849, 37345.43981840329, 35446.0, 35743.821280893426, 36309.27381452409, 36328.0, 36534.4519832208, 31125.533117003717, 32870.0, 32898.5065224017, 32930.84742034017, 32961.67038329682, 24282.271531854072, 24600.138995135083, 24627.753722462545, 24906.750932490442, 24987.0], "value": 20684.814187071002, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.22521016788477, 373.46594370050826, 394.3158619794656, 397.7215948835816, 404.31872295182603, 19464.70802937955, 20271.391858244275, 21396.25113121041, 21664.566708665858, 21669.241576544824, 20171.09230084646, 20462.795372046276, 20784.2725504607, 21402.46493837655, 21571.352859414204, 5088.694678319294, 5101.744912754366, 5209.218617207412, 5217.58259339252, 5273.86815329616, 3830.348840697074, 4033.35466325388, 5113.846584602468, 5188.7146206958605, 5194.194899790538, 5542.7782888684405, 5800.419958004208, 5821.3305469870875, 5878.0, 5882.411758824105, 5625.296837895284, 5741.368449470555, 5812.157237200625, 5836.941630583704, 5843.853903652422, 4670.486246512881, 5219.903820197763, 5668.773249070032, 5683.460071293221, 5691.345495268056, 12210.75578488434, 12479.875201248053, 12497.0, 12565.748685026248, 12589.559365422258, 2585.6250843627568, 2645.232882464083, 2656.0, 2682.8390296582265, 2697.2852194168563, 9412.294077944181, 9776.36453630519, 9797.058110001495, 9974.202063834875, 10008.149307308888, 1818.209079050604, 1869.8504119670395, 1871.5508278013315, 1890.2533499267713, 1902.229597013198, 129613.0, 129626.35186824006, 129962.70037299601, 131410.34294828464, 134190.3290483551, 11952.88047119535, 12079.637610871689, 12084.516619335303, 12129.636110916686, 12295.0, 15670.608234793994, 15791.36834526606, 15794.815388845882, 15821.288042038135, 15840.841591584167, 8640.827183456297, 8817.779555511035, 8871.689490867788, 8949.731508054769, 9002.189802917768, 8589.441686290496, 8620.827583448296, 8622.870656940151, 8714.782130446789, 8760.299176065899, 4613.423322084739, 4689.390379250675, 4781.474037855833, 4895.828645997373, 4929.482404347564, 1866.1229222265513, 1986.771521275043, 2031.61399334129, 2070.8256330852546, 3100.488419410772, 662.2946561911549, 771.5255118102326, 822.7535284044677, 828.7140936376941, 843.2579330189394, 20247.87411785254, 21376.58702389277, 21881.8380743983, 22288.88555572215, 22508.099676012775, 1054.2040759226734, 1058.1640504001907, 1068.7541865370852, 1090.1496832470687, 1099.3898386395467, 9105.77235569116, 10653.414062226497, 10873.945630271955, 11044.889551104547, 11095.334279943228, 708350.0, 715026.0, 719311.0, 726397.0, 733778.0, 132247.0, 143558.0, 143807.40481488046, 149792.2510387441, 152847.0, 1004.6885465505717, 1036.9216015343957, 1045.6235755128148, 1049.0925349572565, 1049.679847646475, 18624.906875465535, 19132.904335478233, 19405.805941940966, 19561.70657440168, 19615.411537653894, 61213.693931530055, 61930.0, 62227.688861555405, 62627.0, 63059.684701576196, 87931.0, 89598.55200723954, 89819.0, 90537.6419353697, 91654.16691666262, 6759.493038022069, 7797.220277972384, 7995.960020199862, 8094.51432914027, 8210.58947052657, 12026.939865300617, 13194.0, 13493.055486116271, 13546.254955977516, 13664.180149191081, 11382.260153090354, 11455.255408398427, 11643.243189192675, 11716.70708232301, 11932.761344772882, 9971.850422243528, 10412.68761937143, 10768.0, 11626.53493860236, 11633.302001879914, 6182.474489668429, 8081.63632636521, 8877.822443551222, 10705.732356691145, 11013.889861101607, 6744.7976560703255, 8263.297619702393, 8346.499210047417, 8385.874211886705, 8395.538245396561, 8077.515349079074, 11474.598389056677, 11800.0, 11801.232919860182, 11811.763764724828], "value": 9573.932367778449, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.9679508012298, 1416.4900635771128, 1426.108682073704, 1429.263929076525, 1432.5630682641793, 7421.332080112788, 7669.616519174033, 7928.286454219119, 8373.958130209341, 8387.0, 6526.6736663166885, 8107.067687215972, 8121.350291976642, 8199.221073997976, 8221.6300266488, 2225.4547635829204, 2261.378121016717, 2262.1403866530695, 2263.0834512022657, 2265.0486795545826, 2046.9590608187827, 2123.384218576611, 2245.820334373246, 2289.5993201189726, 2292.2550171194343, 2197.6704094023125, 2270.398344438725, 2271.2618399020303, 2278.6809846621486, 2281.087564974007, 2221.9000144993515, 2230.2194232018824, 2256.2892688802976, 2260.79652831246, 2261.197274967379, 2014.21445636202, 2078.7505499340177, 2126.8723876567456, 2212.2588932707563, 2220.200727738013, 6838.658067096675, 8219.83560328796, 8257.504549727035, 8321.583920803936, 8326.791830204293, 4983.426905905831, 5100.540951314362, 5119.334486516766, 5122.154844450662, 5123.2827404163445, 2778.4443111377605, 3320.169957510622, 3325.1145472513517, 3399.2521645238007, 3400.846961886696, 990.895955924632, 1232.2852745407642, 1261.1298204239047, 1266.5756971414587, 1732.774739283885, 10418.843717344245, 10582.576696932114, 10607.098396636295, 10664.840027399596, 10671.786564268672, 4133.710640255214, 4289.828406863753, 4363.3018717005125, 4369.890752731207, 4378.540253273424, 7520.6239688015385, 8010.919890801134, 8606.35452341077, 8669.349798765117, 8711.085336039625, 4934.284528743312, 4964.851054468371, 4996.975015124901, 5014.598832093424, 5014.674046186986, 4503.977480112644, 4657.6273898088075, 4693.601043911306, 4696.365990591295, 4712.976435117871, 3849.191669749328, 3894.123822139996, 3941.5467221269346, 3969.543502497192, 3990.880273591797, 1114.593173491686, 1173.730042090324, 1210.8304837322783, 1281.6667666406802, 1300.5773123734823, 666.73997141115, 750.2609929219714, 787.9921200788034, 808.4987307869159, 813.2436833744674, 4949.208126699711, 4992.375953005874, 5038.269450929594, 5058.215976523571, 5058.570021548136, 536.4367414215136, 546.8414159893666, 614.9729950981871, 929.9732159748273, 1019.857759309578, 3022.727954484107, 3411.300683359905, 3421.349943510725, 3539.7876127431923, 3584.7490675652975, 7972.681092756225, 9589.760255993517, 9839.60641574329, 9841.704748857546, 9921.900780992097, 9737.707868763948, 9768.90231097694, 9770.609175633037, 9788.314817962675, 9803.313768036312, 6592.274849766618, 7318.0, 7661.157272699998, 7700.691972321044, 7745.993020907246, 4641.582257596832, 5279.630425870152, 5304.7347632618985, 5366.758495867617, 5485.286912701324, 8679.609417576097, 8740.650373984969, 8792.42849214799, 8859.06979767115, 9187.540622968958, 8843.867341989746, 8993.550322483981, 9046.411983221069, 9166.816663666823, 9181.954090229507, 6961.860762784817, 7047.048648432601, 7048.295170482911, 7134.357907788324, 7155.785326440215, 7569.621518923922, 7649.502782319131, 7666.693332266647, 7679.2704693054075, 7709.575973321297, 6834.316568343126, 6972.686229119803, 7020.403265722471, 7049.894251586128, 7061.611611361424, 6758.3917447428, 6819.181698196248, 6828.453723701992, 6915.481338899502, 6946.930530694628, 5526.281583394133, 5991.2510936132985, 6159.260888693386, 6163.568550201443, 6265.780697675559, 4746.5490778376, 4752.572268495714, 4786.138495070782, 4824.962633033914, 4827.179379505563, 4614.215583350771, 4674.69614475058, 4699.107169637758, 4802.135615589227, 4846.660733748604], "value": 4219.374392122046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.0584471606749, 363.36048554544004, 371.2797173483442, 375.1690006635302, 377.90174554615794, 5177.094008548498, 5344.877575709096, 5441.891162176754, 5577.470140336672, 5594.972025139874, 4657.860264192072, 4806.9038619227595, 4877.902621722847, 5384.165454354581, 5494.423085576017, 3553.7157027437806, 4286.228478873802, 4306.913861722764, 4307.698461107724, 4346.8043938022865, 4181.595582540036, 4273.764942928137, 4317.805698743548, 4331.935020974688, 4348.5216626171095, 3525.0, 4203.222403855281, 4252.383404406375, 4259.126878989815, 4261.680373971949, 3372.9325413491592, 3936.586658400884, 4054.2499637567, 4149.190907772985, 4236.279832428495, 3380.0535849961802, 3528.7353448491467, 3555.5955397617795, 3701.5188025556777, 3786.072412258987, 4418.82901031227, 4573.403729252081, 4933.876653083666, 5219.8434046978655, 5346.465353464661, 4448.399466072071, 4576.87866472713, 4879.8780030499165, 4931.3835770528685, 4957.900841983176, 4910.1586904910655, 5768.769249230026, 5773.653580785166, 5782.653040817564, 5787.466321424826, 3663.725220608465, 3851.364524853396, 3936.252112098692, 3972.106276087886, 4213.6839737019845, 5041.823536176253, 5391.81128660499, 6045.21412216409, 6124.571280010401, 6172.722227499728, 3990.1620659661794, 4008.599140086026, 4017.31705610047, 4029.315016447152, 4041.939370909439, 3366.1584603849037, 3427.520147179397, 4031.1859663151113, 4056.290149223874, 4077.0, 4198.391233271159, 4719.646026548023, 4723.858284251478, 4740.360051393087, 4774.236122220428, 4918.926216106761, 4987.725675087832, 5042.974785126051, 5621.8194179222, 5891.46976772084, 1115.6987613344513, 1245.339969815999, 1253.8401978170339, 1272.5736878145924, 1300.811382349573, 795.738754074798, 862.2153840005565, 893.9719322778857, 896.780288829241, 905.6151135767273, 4342.69601127918, 4574.725516469022, 4835.274708793639, 5164.431912489698, 5173.689578625294, 5715.1422789616845, 5744.0, 5775.873704627557, 5780.826575202666, 5784.219130417424, 4352.630026447724, 4377.409049778303, 5197.324347834758, 5197.558207552324, 5200.5059519345605, 2951.2326795033446, 2979.5977543031413, 3029.4095599810275, 3047.9695203048127, 3066.6473355564394, 4718.9292160617615, 5920.79277225295, 5975.79084732041, 6014.609050411709, 6057.6975950170045, 5107.795688172431, 5275.129603615437, 5464.098423760035, 5873.706314684248, 5927.851803704942, 4905.950940490621, 5427.9185812212845, 5444.237806707064, 5955.106733989936, 5982.7008649568215, 4792.7603619819565, 5067.695938243717, 5522.144067669517, 5539.0, 5724.962033410572, 4964.411388355836, 5093.592512599057, 5442.646227995326, 5567.415421380697, 5939.584229103922, 4945.7527123644395, 5481.123020316731, 5940.504987905004, 6181.629102253879, 6282.2147231596055, 4166.45905788801, 4217.409562661169, 4282.828686852616, 4292.399064131087, 4312.210432670407, 4712.057588482386, 5099.36257967754, 5331.094553468447, 5335.253064570886, 5942.435468630646, 5618.752499000432, 5705.286839145107, 5794.478496935296, 5798.391168927371, 5811.82564523065, 5512.310961129859, 5793.507551858139, 5823.970880145572, 5826.242588463642, 5839.328477225004, 5242.929043028059, 5437.972810136082, 5609.887802244014, 5661.915071274017, 5743.368229494668, 5114.974425127851, 5788.768449261982, 5806.622569532967, 5836.970815145897, 5849.53203743708, 5017.473165317735, 5200.297959775382, 5246.921296180637, 5662.631928924607, 5662.943370566406], "value": 4155.560249711216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.0875375142942, 724.3408498266577, 738.5273425007996, 771.811410427941, 835.5154010673808, 14604.342804573793, 15396.461123860667, 15503.689926201483, 15507.379704811809, 15511.146886921215, 14292.571222863306, 14359.497417590386, 14375.78436323456, 14413.486583908696, 14622.415103395879, 866.8959724832997, 888.5468411110315, 891.31814162166, 897.4211633496391, 898.4878619187066, 779.6686408276488, 859.7850537365658, 882.483747008001, 882.8013696918206, 884.1026358246385, 932.580338847518, 939.6288466055904, 941.5339406993547, 942.8114377124602, 946.3139224062534, 932.8740620016313, 934.3646320502056, 935.163029088965, 935.3125452792192, 935.7707361696428, 695.6660802814678, 699.601227300439, 702.3748863511479, 703.5251205436361, 704.2534912992194, 15251.923740381228, 15514.069155850684, 15519.224038798127, 15581.454649087342, 15632.218389080614, 13809.861901380958, 13858.792118118236, 13974.0, 14014.159150451005, 14044.92977535116, 8905.0, 11694.941525292405, 11750.353730544817, 11902.226355286879, 12068.879311206863, 3611.4763359313015, 3636.6181550937035, 3651.06897741077, 3657.6342365763476, 3693.261347730465, 91753.0, 101244.0, 103701.48149259205, 104007.0, 105198.0, 9689.740333756567, 10587.014070656385, 10831.187660925461, 10888.510017049251, 10935.015848573667, 20429.69355459669, 21657.0, 21852.672209916545, 21869.781302186773, 22157.889210554167, 7430.294122058396, 7677.0, 7720.729774457867, 7734.342580880576, 7744.2642948919765, 4259.21204577148, 4322.632576231055, 4401.1417773534495, 4429.933550996738, 4459.063596644741, 3394.5417368655408, 3466.272082862627, 3509.649035096521, 3511.613722490524, 3515.3848076586496, 558.4192439862497, 610.9613656783486, 628.4626644219127, 631.6683741035993, 652.3704625036768, 697.3235961117708, 711.1288671377521, 724.2648711557773, 730.2259604818909, 738.1253214940313, 8463.407561470638, 10090.293679442515, 10368.844467332996, 10471.16230701542, 10647.414392208348, 702.4750338587078, 710.5772065620947, 717.2110678253879, 722.7903907866765, 730.302561054192, 4063.837446502166, 5046.0, 5079.212722028092, 5079.593632509391, 5101.617378696613, 69973.3002669977, 70506.23734406578, 87588.0, 91191.0, 94850.0, 65727.68544629177, 67726.32273677299, 85246.14753852507, 85592.14407855966, 86958.0, 78122.0, 80943.59528202438, 81720.0, 81931.0, 83511.99999999878, 9355.625774968925, 9571.664991725256, 9572.329936904629, 9787.412755234709, 10726.195535334726, 44946.77526612346, 51116.48883511117, 52304.47695522996, 52595.0, 53504.0, 74356.0, 75641.62179189069, 76860.61569692116, 77606.61196694206, 77729.22270777446, 11149.275297105662, 11343.829842552203, 11455.541778328774, 11657.825132622847, 11818.231814932002, 12385.256884586954, 12471.875281247072, 12700.936495317465, 13014.609561713163, 13064.477420903437, 11698.590549331073, 12055.0, 12056.216345937486, 12522.37388130608, 12545.247285162919, 11766.294022358687, 11975.401229938294, 11985.101117416403, 12008.579699710817, 12355.69110772202, 8933.865992009994, 11707.88292117102, 11890.643280701246, 11913.583024594443, 12187.329696866758, 9811.705648830546, 9818.950905245429, 9998.0, 10117.342372745748, 10419.270651054656, 9932.063726419296, 9952.970247703071, 9967.304764519546, 9973.373754699587, 9991.35488449024], "value": 7335.3975943405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 144.0, 161.0, 121.0, 156.0, 169.0, 170.0, 117.0, 122.0, 172.0], "value": 143.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 148.0, 184.0, 122.0, 114.0, 112.0, 115.0, 130.0, 114.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 201.0, 197.0, 198.0, 235.0, 256.0, 196.0, 195.0, 195.0, 196.0], "value": 206.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 87.0, 62.0, 86.0, 60.0, 62.0, 73.0, 59.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 86.0, 73.0, 70.0, 69.0, 80.0, 79.0, 91.0, 93.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 86.0, 88.0, 86.0, 126.0, 131.0, 89.0, 87.0, 89.0, 102.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 138.0, 117.0, 103.0, 175.0, 174.0, 99.0, 98.0, 99.0, 99.0], "value": 120.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 145.0, 142.0, 95.0, 128.0, 144.0, 126.0, 91.0, 95.0, 91.0], "value": 114.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 64.0, 65.0, 63.0, 63.0, 64.0, 64.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 84.0, 80.0, 94.0, 104.0, 100.0, 70.0, 71.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 98.0, 98.0, 84.0, 83.0, 87.0, 86.0, 89.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 155.0, 157.0, 152.0, 137.0, 143.0, 140.0, 162.0, 208.0, 178.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 235.0, 169.0, 171.0, 172.0, 167.0, 171.0, 174.0, 172.0, 171.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 69.0, 66.0, 68.0, 67.0, 64.0, 86.0, 83.0], "value": 70.4, "unit": "score"}]}]} 09:09:18 INFO - Return code: 0 09:09:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:18 ERROR - # TBPL SUCCESS # 09:09:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:09:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:09:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:09:18 INFO - 2017-02-08 09:09:18.694 screenresolution[1661:10512] starting screenresolution argv=screenresolution get 09:09:18 INFO - 2017-02-08 09:09:18.697 screenresolution[1661:10512] Display 0: 1600x1200x32@60 09:09:18 INFO - 2017-02-08 09:09:18.703 screenresolution[1662:10515] starting screenresolution argv=screenresolution list 09:09:18 INFO - Available Modes on Display 0 09:09:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:09:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:09:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:09:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:09:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:09:18 INFO - Intel Iris: 09:09:18 INFO - Chipset Model: Intel Iris 09:09:18 INFO - Type: GPU 09:09:18 INFO - Bus: Built-In 09:09:18 INFO - VRAM (Dynamic, Max): 1536 MB 09:09:18 INFO - Vendor: Intel (0x8086) 09:09:18 INFO - Device ID: 0x0a2e 09:09:18 INFO - Revision ID: 0x0009 09:09:18 INFO - Displays: 09:09:18 INFO - Display: 09:09:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:09:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:09:18 INFO - Display Serial Number: 1600x1200 60 09:09:18 INFO - Main Display: Yes 09:09:18 INFO - Mirror: Off 09:09:18 INFO - Online: Yes 09:09:18 INFO - Rotation: Supported 09:09:18 INFO - Return code: 0 09:09:18 INFO - Running post-action listener: _resource_record_post_action 09:09:18 INFO - [mozharness: 2017-02-08 17:09:18.940861Z] Finished run-tests step (success) 09:09:18 INFO - Running post-run listener: _resource_record_post_run 09:09:18 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39709184; Write bytes: 510779904; Read time: 449; Write time: 1699 09:09:18 INFO - TinderboxPrint: CPU usage
54.3% 09:09:18 INFO - TinderboxPrint: I/O read bytes / time
39,709,184 / 449 09:09:18 INFO - TinderboxPrint: I/O write bytes / time
510,779,904 / 1,699 09:09:18 INFO - TinderboxPrint: CPU idle
2,191.0 (45.7%) 09:09:18 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 09:09:18 INFO - TinderboxPrint: CPU user
1,636.2 (34.1%) 09:09:18 INFO - TinderboxPrint: Swap in / out
247,836,672 / 0 09:09:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208773632; Write bytes: 208502784; Read time: 16035; Write time: 487 09:09:19 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35359232; Write bytes: 300921344; Read time: 352; Write time: 1208 09:09:19 INFO - Running post-run listener: _upload_blobber_files 09:09:19 INFO - Blob upload gear active. 09:09:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:19 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 09:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:09:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:20 INFO - (blobuploader) - INFO - Done attempting. 09:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:21 INFO - (blobuploader) - INFO - Done attempting. 09:09:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:09:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:09:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:22 INFO - (blobuploader) - INFO - Done attempting. 09:09:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:24 INFO - (blobuploader) - INFO - Done attempting. 09:09:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:24 INFO - Return code: 0 09:09:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/256e672901be1670a5b7ebeafaaf1d731b10f7c3ccd2e3f89753f0674360f2559508a95209a5502298f789e16cdf622e8149c432e024f879db39a25be0e776e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3f7c2ec419392c9794386208447e1dad8ca237146d323234b8ba720735db0e4fed8b57a609a1476c82cd205372582106dcef9673a1ace8030f424a96a2add10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecce192afc6da17b26e4a54d60b84c0cd243160813e8638582ca6f82f0631bcfdca736d6ec0a0041b63127f1be3b0203ce31f4ad3d176894825dc553e4bb780b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b56bfe406dbfa20059ea1ee8a6ebde96ee96c04126f36ef68b240aab02cf13b16f9d10a9f668ba6d1e6101814c1af95178f9db50bd4f186b94ce27abd21091f7"} 09:09:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:24 INFO - Contents: 09:09:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/256e672901be1670a5b7ebeafaaf1d731b10f7c3ccd2e3f89753f0674360f2559508a95209a5502298f789e16cdf622e8149c432e024f879db39a25be0e776e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3f7c2ec419392c9794386208447e1dad8ca237146d323234b8ba720735db0e4fed8b57a609a1476c82cd205372582106dcef9673a1ace8030f424a96a2add10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecce192afc6da17b26e4a54d60b84c0cd243160813e8638582ca6f82f0631bcfdca736d6ec0a0041b63127f1be3b0203ce31f4ad3d176894825dc553e4bb780b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b56bfe406dbfa20059ea1ee8a6ebde96ee96c04126f36ef68b240aab02cf13b16f9d10a9f668ba6d1e6101814c1af95178f9db50bd4f186b94ce27abd21091f7"} 09:09:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:24 INFO - Copying logs to upload dir... 09:09:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.250906 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 09:09:24.910566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 09:09:24.913567) ========= 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.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/256e672901be1670a5b7ebeafaaf1d731b10f7c3ccd2e3f89753f0674360f2559508a95209a5502298f789e16cdf622e8149c432e024f879db39a25be0e776e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3f7c2ec419392c9794386208447e1dad8ca237146d323234b8ba720735db0e4fed8b57a609a1476c82cd205372582106dcef9673a1ace8030f424a96a2add10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecce192afc6da17b26e4a54d60b84c0cd243160813e8638582ca6f82f0631bcfdca736d6ec0a0041b63127f1be3b0203ce31f4ad3d176894825dc553e4bb780b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b56bfe406dbfa20059ea1ee8a6ebde96ee96c04126f36ef68b240aab02cf13b16f9d10a9f668ba6d1e6101814c1af95178f9db50bd4f186b94ce27abd21091f7"} build_url:https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010692 build_url: 'https://queue.taskcluster.net/v1/task/JfEeUsVGS_ezrfknFWSIuw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/256e672901be1670a5b7ebeafaaf1d731b10f7c3ccd2e3f89753f0674360f2559508a95209a5502298f789e16cdf622e8149c432e024f879db39a25be0e776e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3f7c2ec419392c9794386208447e1dad8ca237146d323234b8ba720735db0e4fed8b57a609a1476c82cd205372582106dcef9673a1ace8030f424a96a2add10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecce192afc6da17b26e4a54d60b84c0cd243160813e8638582ca6f82f0631bcfdca736d6ec0a0041b63127f1be3b0203ce31f4ad3d176894825dc553e4bb780b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b56bfe406dbfa20059ea1ee8a6ebde96ee96c04126f36ef68b240aab02cf13b16f9d10a9f668ba6d1e6101814c1af95178f9db50bd4f186b94ce27abd21091f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 09:09:24.947059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:09:24.950383) ========= 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.Byny7O6CwR/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.PEtGGOA91R/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005034 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 09:09:24.998728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 09:09:24.999009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 09:09:25.002318) ========= ========= Total master_lag: 0.19 =========