builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1486148630.29 results: success (0) buildid: 20170203094345 builduid: 3d3d81adb2b048558cf9bfa719f2921b revision: bf15d4078c2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.288113) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.288647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.288938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.314159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.314628) ========= 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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-03 11:03:50-- 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% 8.09M=0.001s 2017-02-03 11:03:50 (8.09 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082607 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.421097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.421440) ========= 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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.019897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.470303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:50.470662) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf15d4078c2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bf15d4078c2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-03 11:03:50,562 Setting DEBUG logging. 2017-02-03 11:03:50,562 attempt 1/10 2017-02-03 11:03:50,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf15d4078c2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 11:03:50,861 unpacking tar archive at: mozilla-central-bf15d4078c2a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546945 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:51.049063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:51.049397) ========= script_repo_revision: bf15d4078c2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:51.049795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:51.050077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 11:03:51.069891) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-03 11:03:51.070310) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:03:51 INFO - MultiFileLogger online at 20170203 11:03:51 in /builds/slave/test 11:03:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:03:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:51 INFO - {'append_to_log': False, 11:03:51 INFO - 'base_work_dir': '/builds/slave/test', 11:03:51 INFO - 'blob_upload_branch': 'Firefox', 11:03:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:51 INFO - 'branch': 'Firefox', 11:03:51 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:51 INFO - 'config_files': ('talos/mac_config.py',), 11:03:51 INFO - 'default_actions': ('clobber', 11:03:51 INFO - 'read-buildbot-config', 11:03:51 INFO - 'download-and-extract', 11:03:51 INFO - 'populate-webroot', 11:03:51 INFO - 'create-virtualenv', 11:03:51 INFO - 'install', 11:03:51 INFO - 'run-tests'), 11:03:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:51 INFO - 'download_minidump_stackwalk': True, 11:03:51 INFO - 'download_symbols': 'ondemand', 11:03:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:03:51 INFO - 'tooltool.py': '/tools/tooltool.py', 11:03:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:03:51 INFO - '/tools/misc-python/virtualenv.py')}, 11:03:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:51 INFO - 'installer_path': 'installer.exe', 11:03:51 INFO - 'log_level': 'info', 11:03:51 INFO - 'log_name': 'talos', 11:03:51 INFO - 'log_to_console': True, 11:03:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:03:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:03:51 INFO - 'opt_config_files': (), 11:03:51 INFO - 'pip_index': False, 11:03:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:03:51 INFO - 'cmd': ('bash', 11:03:51 INFO - '-c', 11:03:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:03:51 INFO - 'enabled': True, 11:03:51 INFO - 'halt_on_failure': False, 11:03:51 INFO - 'name': 'check_screen_resolution'},), 11:03:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:03:51 INFO - 'cmd': ('bash', 11:03:51 INFO - '-c', 11:03:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:03:51 INFO - 'enabled': True, 11:03:51 INFO - 'halt_on_failure': False, 11:03:51 INFO - 'name': 'check_screen_resolution'},), 11:03:51 INFO - 'run_cmd_checks_enabled': True, 11:03:51 INFO - 'sps_profile': False, 11:03:51 INFO - 'sps_profile_interval': 0, 11:03:51 INFO - 'suite': 'dromaeojs-e10s', 11:03:51 INFO - 'system_bits': '32', 11:03:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:51 INFO - 'title': 't-yosemite-r7-0009', 11:03:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:51 INFO - 'use_talos_json': True, 11:03:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:51 INFO - 'work_dir': 'build'} 11:03:51 INFO - [mozharness: 2017-02-03 19:03:51.284814Z] Running clobber step. 11:03:51 INFO - Running pre-action listener: _resource_record_pre_action 11:03:51 INFO - Running main action method: clobber 11:03:51 INFO - rmtree: /builds/slave/test/build 11:03:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:51 INFO - Running post-action listener: _resource_record_post_action 11:03:51 INFO - [mozharness: 2017-02-03 19:03:51.977841Z] Finished clobber step (success) 11:03:51 INFO - [mozharness: 2017-02-03 19:03:51.978072Z] Running read-buildbot-config step. 11:03:51 INFO - Running pre-action listener: _resource_record_pre_action 11:03:51 INFO - Running main action method: read_buildbot_config 11:03:51 INFO - Using buildbot properties: 11:03:51 INFO - { 11:03:51 INFO - "project": "", 11:03:51 INFO - "product": "firefox", 11:03:51 INFO - "script_repo_revision": "production", 11:03:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:03:51 INFO - "repository": "", 11:03:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:03:51 INFO - "buildid": "20170203094345", 11:03:51 INFO - "stage_platform": "macosx64", 11:03:51 INFO - "basedir": "/builds/slave/test", 11:03:51 INFO - "nightly_build": "True", 11:03:51 INFO - "buildnumber": 80, 11:03:51 INFO - "slavename": "t-yosemite-r7-0009", 11:03:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:03:51 INFO - "platform": "yosemite_r7", 11:03:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:03:51 INFO - "branch": "mozilla-central", 11:03:51 INFO - "repo_path": "mozilla-central", 11:03:51 INFO - "revision": "bf15d4078c2a", 11:03:51 INFO - "pgo_build": "False", 11:03:51 INFO - "builduid": "3d3d81adb2b048558cf9bfa719f2921b", 11:03:51 INFO - "slavebuilddir": "test" 11:03:51 INFO - } 11:03:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 11:03:51 INFO - Running post-action listener: _resource_record_post_action 11:03:51 INFO - [mozharness: 2017-02-03 19:03:51.983980Z] Finished read-buildbot-config step (success) 11:03:51 INFO - [mozharness: 2017-02-03 19:03:51.984213Z] Running download-and-extract step. 11:03:51 INFO - Running pre-action listener: _resource_record_pre_action 11:03:51 INFO - Running main action method: download_and_extract 11:03:51 INFO - mkdir: /builds/slave/test/build/tests 11:03: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')]} 11:03:51 INFO - trying https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 11:03:51 INFO - Downloading https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 11:03:53 INFO - Downloaded 1199 bytes. 11:03:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 11:03:53 INFO - Using the following test package requirements: 11:03:53 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:03:53 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 11:03:53 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 11:03:53 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'jsshell-mac.zip'], 11:03:53 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 11:03:53 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 11:03:53 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 11:03:53 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 11:03:53 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 11:03:53 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 11:03:53 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 11:03:53 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:03:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:03:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:03:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:03:54 INFO - Expected file size: 34852177 11:03:54 INFO - Obtained file size: 34852177 11:04:01 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:04:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 11:04:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:04:01 INFO - Fetch https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 11:04:02 INFO - Expected file size: 34852177 11:04:02 INFO - Obtained file size: 34852177 11:04:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 11:04:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:04:09 INFO - Fetch https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 11:04:10 INFO - Expected file size: 14403454 11:04:10 INFO - Obtained file size: 14403454 11:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:10 INFO - trying https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:04:10 INFO - Downloading https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 11:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 11:04:12 INFO - Downloaded 70355742 bytes. 11:04:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:04:12 INFO - mkdir: /builds/slave/test/properties 11:04:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:12 INFO - Contents: 11:04:12 INFO - build_url:https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 11:04:13 INFO - Running post-action listener: _resource_record_post_action 11:04:13 INFO - Running post-action listener: set_extra_try_arguments 11:04:13 INFO - [mozharness: 2017-02-03 19:04:13.174031Z] Finished download-and-extract step (success) 11:04:13 INFO - [mozharness: 2017-02-03 19:04:13.174157Z] Running populate-webroot step. 11:04:13 INFO - Running pre-action listener: _resource_record_pre_action 11:04:13 INFO - Running main action method: populate_webroot 11:04:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:13 INFO - '--tppagecycles', 11:04:13 INFO - '7'], 11:04:13 INFO - 'tests': ['tsvgm']}}, 11:04:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:04:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:04:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:04:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['damp', 'tps']}, 11:04:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'tests': ['damp', 'tps']}, 11:04:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['dromaeo_dom']}, 11:04:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['basic_compositor_video']}, 11:04:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:04:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['a11yr', 11:04:13 INFO - 'ts_paint', 11:04:13 INFO - 'tpaint', 11:04:13 INFO - 'sessionrestore', 11:04:13 INFO - 'sessionrestore_no_auto_restore', 11:04:13 INFO - 'tabpaint']}, 11:04:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['tsvgx', 11:04:13 INFO - 'tsvgr_opacity', 11:04:13 INFO - 'tart', 11:04:13 INFO - 'tscrollx', 11:04:13 INFO - 'cart', 11:04:13 INFO - 'tsvg_static']}, 11:04:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:04:13 INFO - 'tsvgr_opacity', 11:04:13 INFO - 'tart', 11:04:13 INFO - 'tscrollx', 11:04:13 INFO - 'cart', 11:04:13 INFO - 'tsvg_static']}, 11:04:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'talos_options': ['--disable-e10s'], 11:04:13 INFO - 'tests': ['tp5o']}, 11:04:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:04:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'talos_options': ['--disable-e10s', 11:04:13 INFO - '--xperf_path', 11:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:13 INFO - 'tests': ['tp5n']}, 11:04:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:04:13 INFO - 'talos_options': ['--xperf_path', 11:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:13 INFO - 'tests': ['tp5n']}}, 11:04:13 INFO - 'talos.zip': {'path': '', 11:04:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:13 INFO - Running post-action listener: _resource_record_post_action 11:04:13 INFO - [mozharness: 2017-02-03 19:04:13.191857Z] Finished populate-webroot step (success) 11:04:13 INFO - [mozharness: 2017-02-03 19:04:13.191992Z] Running create-virtualenv step. 11:04:13 INFO - Running pre-action listener: _resource_record_pre_action 11:04:13 INFO - Running main action method: create_virtualenv 11:04:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:13 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 11:04:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:04:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:13 INFO - Using real prefix '/tools/python27' 11:04:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:16 INFO - Installing pip.................done. 11:04:16 INFO - Return code: 0 11:04:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:04:17 INFO - Reading from file tmpfile_stdout 11:04:17 INFO - Output received: 11:04:17 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) 11:04:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:04:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:17 INFO - 'HOME': '/Users/cltbld', 11:04:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:17 INFO - 'LOGNAME': 'cltbld', 11:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:17 INFO - 'MOZ_NO_REMOTE': '1', 11:04:17 INFO - 'NO_EM_RESTART': '1', 11:04:17 INFO - 'PAGER': '/bin/cat', 11:04:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:17 INFO - 'PWD': '/builds/slave/test', 11:04:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:17 INFO - 'SHELL': '/bin/bash', 11:04:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:17 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:17 INFO - 'USER': 'cltbld', 11:04:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:17 INFO - 'XPC_FLAGS': '0x0', 11:04:17 INFO - 'XPC_SERVICE_NAME': '0', 11:04:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:17 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 11:04:17 INFO - Cleaning up... 11:04:17 INFO - Return code: 0 11:04:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:04:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:17 INFO - 'HOME': '/Users/cltbld', 11:04:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:17 INFO - 'LOGNAME': 'cltbld', 11:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:17 INFO - 'MOZ_NO_REMOTE': '1', 11:04:17 INFO - 'NO_EM_RESTART': '1', 11:04:17 INFO - 'PAGER': '/bin/cat', 11:04:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:17 INFO - 'PWD': '/builds/slave/test', 11:04:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:17 INFO - 'SHELL': '/bin/bash', 11:04:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:17 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:17 INFO - 'USER': 'cltbld', 11:04:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:17 INFO - 'XPC_FLAGS': '0x0', 11:04:17 INFO - 'XPC_SERVICE_NAME': '0', 11:04:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:17 INFO - Downloading/unpacking psutil>=3.1.1 11:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:21 INFO - Installing collected packages: psutil 11:04:21 INFO - Running setup.py install for psutil 11:04:21 INFO - building 'psutil._psutil_osx' extension 11:04:21 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 11:04:21 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 11:04:21 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 11:04:21 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 11:04:21 INFO - building 'psutil._psutil_posix' extension 11:04:21 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 11:04:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:04:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:04:21 INFO - ^ 11:04:21 INFO - 1 warning generated. 11:04:21 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 11:04:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:22 INFO - Successfully installed psutil 11:04:22 INFO - Cleaning up... 11:04:22 INFO - Return code: 0 11:04:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:04:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:22 INFO - 'HOME': '/Users/cltbld', 11:04:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:22 INFO - 'LOGNAME': 'cltbld', 11:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:22 INFO - 'MOZ_NO_REMOTE': '1', 11:04:22 INFO - 'NO_EM_RESTART': '1', 11:04:22 INFO - 'PAGER': '/bin/cat', 11:04:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:22 INFO - 'PWD': '/builds/slave/test', 11:04:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:22 INFO - 'SHELL': '/bin/bash', 11:04:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:22 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:22 INFO - 'USER': 'cltbld', 11:04:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:22 INFO - 'XPC_FLAGS': '0x0', 11:04:22 INFO - 'XPC_SERVICE_NAME': '0', 11:04:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:04:25 INFO - Installing collected packages: mozsystemmonitor 11:04:25 INFO - Running setup.py install for mozsystemmonitor 11:04:25 INFO - Successfully installed mozsystemmonitor 11:04:25 INFO - Cleaning up... 11:04:25 INFO - Return code: 0 11:04:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:04:25 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')]} 11:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:25 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')]} 11:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:25 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:25 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 11:04:25 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 11:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:25 INFO - 'HOME': '/Users/cltbld', 11:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:25 INFO - 'LOGNAME': 'cltbld', 11:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:25 INFO - 'MOZ_NO_REMOTE': '1', 11:04:25 INFO - 'NO_EM_RESTART': '1', 11:04:25 INFO - 'PAGER': '/bin/cat', 11:04:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:25 INFO - 'PWD': '/builds/slave/test', 11:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:25 INFO - 'SHELL': '/bin/bash', 11:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:25 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:25 INFO - 'USER': 'cltbld', 11:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:25 INFO - 'XPC_FLAGS': '0x0', 11:04:25 INFO - 'XPC_SERVICE_NAME': '0', 11:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:04:25 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 11:04:25 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 11:04:25 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 11:04:25 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 11:04:25 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 11:04:25 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 11:04:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:04:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:04:28 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 11:04:28 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 11:04:28 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 11:04:28 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 11:04:28 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 11:04:28 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 11:04:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:04:28 INFO - warning: no files found matching '*.txt' 11:04:28 INFO - no previously-included directories found matching 'build' 11:04:28 INFO - no previously-included directories found matching 'dist' 11:04:28 INFO - no previously-included directories found matching '.git*' 11:04:28 INFO - Installing collected packages: jsonschema, functools32 11:04:28 INFO - Running setup.py install for functools32 11:04:28 INFO - warning: no files found matching '*.txt' 11:04:28 INFO - no previously-included directories found matching 'build' 11:04:28 INFO - no previously-included directories found matching 'dist' 11:04:28 INFO - no previously-included directories found matching '.git*' 11:04:28 INFO - Successfully installed jsonschema functools32 11:04:28 INFO - Cleaning up... 11:04:28 INFO - Return code: 0 11:04:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:28 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:28 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 11:04:28 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 11:04:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:28 INFO - 'HOME': '/Users/cltbld', 11:04:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:28 INFO - 'LOGNAME': 'cltbld', 11:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:28 INFO - 'MOZ_NO_REMOTE': '1', 11:04:28 INFO - 'NO_EM_RESTART': '1', 11:04:28 INFO - 'PAGER': '/bin/cat', 11:04:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:28 INFO - 'PWD': '/builds/slave/test', 11:04:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:28 INFO - 'SHELL': '/bin/bash', 11:04:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:28 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:28 INFO - 'USER': 'cltbld', 11:04:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:28 INFO - 'XPC_FLAGS': '0x0', 11:04:28 INFO - 'XPC_SERVICE_NAME': '0', 11:04:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:04:29 INFO - Cleaning up... 11:04:29 INFO - Return code: 0 11:04:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:29 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:29 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 11:04:29 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 11:04:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:29 INFO - 'HOME': '/Users/cltbld', 11:04:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:29 INFO - 'LOGNAME': 'cltbld', 11:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:29 INFO - 'MOZ_NO_REMOTE': '1', 11:04:29 INFO - 'NO_EM_RESTART': '1', 11:04:29 INFO - 'PAGER': '/bin/cat', 11:04:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:29 INFO - 'PWD': '/builds/slave/test', 11:04:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:29 INFO - 'SHELL': '/bin/bash', 11:04:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:29 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:29 INFO - 'USER': 'cltbld', 11:04:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:29 INFO - 'XPC_FLAGS': '0x0', 11:04:29 INFO - 'XPC_SERVICE_NAME': '0', 11:04:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:29 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 11:04:29 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 11:04:29 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 11:04:29 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 11:04:29 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 11:04:29 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 11:04:31 INFO - Downloading blobuploader-1.2.4.tar.gz 11:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:04:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:04:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:32 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 11:04:33 INFO - Downloading docopt-0.6.1.tar.gz 11:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:04:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:04:33 INFO - Running setup.py install for blobuploader 11:04:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:04:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:04:33 INFO - Running setup.py install for requests 11:04:33 INFO - Running setup.py install for docopt 11:04:34 INFO - Successfully installed blobuploader requests docopt 11:04:34 INFO - Cleaning up... 11:04:34 INFO - Return code: 0 11:04:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:34 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:34 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 11:04:34 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 11:04:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:34 INFO - 'HOME': '/Users/cltbld', 11:04:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:34 INFO - 'LOGNAME': 'cltbld', 11:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:34 INFO - 'MOZ_NO_REMOTE': '1', 11:04:34 INFO - 'NO_EM_RESTART': '1', 11:04:34 INFO - 'PAGER': '/bin/cat', 11:04:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:34 INFO - 'PWD': '/builds/slave/test', 11:04:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:34 INFO - 'SHELL': '/bin/bash', 11:04:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:34 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:34 INFO - 'USER': 'cltbld', 11:04:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:34 INFO - 'XPC_FLAGS': '0x0', 11:04:34 INFO - 'XPC_SERVICE_NAME': '0', 11:04:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VF3Kym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-XpCR6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VUDgIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-CBedPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-miev8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ht5wzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-lkc3_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bvY2is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pE_kqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hv0C1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-fgBoEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-guoD2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-NPokU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-jhD3WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vFeOd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-OhEK5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:36 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-F1jfss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:04:36 INFO - Running setup.py install for manifestparser 11:04:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:04:36 INFO - Running setup.py install for mozcrash 11:04:36 INFO - Running setup.py install for mozdebug 11:04:36 INFO - Running setup.py install for mozdevice 11:04:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:04:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:04:36 INFO - Running setup.py install for mozfile 11:04:36 INFO - Running setup.py install for mozhttpd 11:04:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Running setup.py install for mozinfo 11:04:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Running setup.py install for mozInstall 11:04:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Running setup.py install for mozleak 11:04:37 INFO - Running setup.py install for mozlog 11:04:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Running setup.py install for moznetwork 11:04:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:04:37 INFO - Running setup.py install for mozprocess 11:04:37 INFO - Running setup.py install for mozprofile 11:04:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:04:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:04:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:04:38 INFO - Running setup.py install for mozrunner 11:04:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:04:38 INFO - Running setup.py install for mozscreenshot 11:04:38 INFO - Running setup.py install for moztest 11:04:38 INFO - Running setup.py install for mozversion 11:04:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:04:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:04:38 INFO - Cleaning up... 11:04:38 INFO - Return code: 0 11:04:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:38 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:38 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 11:04:38 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 11:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:38 INFO - 'HOME': '/Users/cltbld', 11:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:38 INFO - 'LOGNAME': 'cltbld', 11:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:38 INFO - 'MOZ_NO_REMOTE': '1', 11:04:38 INFO - 'NO_EM_RESTART': '1', 11:04:38 INFO - 'PAGER': '/bin/cat', 11:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:38 INFO - 'PWD': '/builds/slave/test', 11:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:38 INFO - 'SHELL': '/bin/bash', 11:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:38 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:38 INFO - 'USER': 'cltbld', 11:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:38 INFO - 'XPC_FLAGS': '0x0', 11:04:38 INFO - 'XPC_SERVICE_NAME': '0', 11:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-puCqKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5v7JKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ymq3_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kFP7nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-krebi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-TWbRmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Z92zDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-rQ8zx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:04:39 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)) 11:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:04:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-DNF84x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VmMlwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nS8dYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Flhaoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Xuttnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ohKz7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SAR6bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-uFeZO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:04:40 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)) 11:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:04:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-2ZY6qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:04:40 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)) 11:04:40 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)) 11:04:40 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)) 11:04:40 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)) 11:04:40 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)) 11:04:40 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)) 11:04:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:04:40 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 11:04:40 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 11:04:40 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 11:04:40 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 11:04:40 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 11:04:40 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 11:04:43 INFO - Downloading blessings-1.6.tar.gz 11:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:04:43 INFO - Installing collected packages: blessings 11:04:43 INFO - Running setup.py install for blessings 11:04:43 INFO - Successfully installed blessings 11:04:43 INFO - Cleaning up... 11:04:43 INFO - Return code: 0 11:04:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:04:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:44 INFO - Reading from file tmpfile_stdout 11:04:44 INFO - Current package versions: 11:04:44 INFO - blessings == 1.6 11:04:44 INFO - blobuploader == 1.2.4 11:04:44 INFO - docopt == 0.6.1 11:04:44 INFO - functools32 == 3.2.3-2 11:04:44 INFO - jsonschema == 2.5.1 11:04:44 INFO - manifestparser == 1.1 11:04:44 INFO - mozInstall == 1.12 11:04:44 INFO - mozcrash == 1.0 11:04:44 INFO - mozdebug == 0.1 11:04:44 INFO - mozdevice == 0.49 11:04:44 INFO - mozfile == 1.2 11:04:44 INFO - mozhttpd == 0.7 11:04:44 INFO - mozinfo == 0.9 11:04:44 INFO - mozleak == 0.1 11:04:44 INFO - mozlog == 3.4 11:04:44 INFO - moznetwork == 0.27 11:04:44 INFO - mozprocess == 0.24 11:04:44 INFO - mozprofile == 0.28 11:04:44 INFO - mozrunner == 6.13 11:04:44 INFO - mozscreenshot == 0.1 11:04:44 INFO - mozsystemmonitor == 0.3 11:04:44 INFO - moztest == 0.8 11:04:44 INFO - mozversion == 1.4 11:04:44 INFO - psutil == 3.1.1 11:04:44 INFO - requests == 1.2.3 11:04:44 INFO - wsgiref == 0.1.2 11:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:44 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:44 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 11:04:44 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 11:04:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:44 INFO - 'HOME': '/Users/cltbld', 11:04:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:44 INFO - 'LOGNAME': 'cltbld', 11:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:44 INFO - 'MOZ_NO_REMOTE': '1', 11:04:44 INFO - 'NO_EM_RESTART': '1', 11:04:44 INFO - 'PAGER': '/bin/cat', 11:04:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:44 INFO - 'PWD': '/builds/slave/test', 11:04:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:44 INFO - 'SHELL': '/bin/bash', 11:04:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:44 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:44 INFO - 'USER': 'cltbld', 11:04:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:44 INFO - 'XPC_FLAGS': '0x0', 11:04:44 INFO - 'XPC_SERVICE_NAME': '0', 11:04:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 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)) 11:04:44 INFO - Cleaning up... 11:04:44 INFO - Return code: 0 11:04:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:04: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')]} 11:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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')]} 11:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:44 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 0x1105cdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105d0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff66b568a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, '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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 11:04:44 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 11:04:44 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 11:04:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:04:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:04:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:04:44 INFO - 'HOME': '/Users/cltbld', 11:04:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:04:44 INFO - 'LOGNAME': 'cltbld', 11:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:44 INFO - 'MOZ_NO_REMOTE': '1', 11:04:44 INFO - 'NO_EM_RESTART': '1', 11:04:44 INFO - 'PAGER': '/bin/cat', 11:04:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:44 INFO - 'PWD': '/builds/slave/test', 11:04:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:04:44 INFO - 'SHELL': '/bin/bash', 11:04:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:04:44 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:04:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:04:44 INFO - 'USER': 'cltbld', 11:04:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:04:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:44 INFO - 'XPC_FLAGS': '0x0', 11:04:44 INFO - 'XPC_SERVICE_NAME': '0', 11:04:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:04:44 INFO - Cleaning up... 11:04:44 INFO - Return code: 0 11:04:44 INFO - Running post-action listener: _resource_record_post_action 11:04:44 INFO - Running post-action listener: _start_resource_monitoring 11:04:44 INFO - Starting resource monitoring. 11:04:44 INFO - [mozharness: 2017-02-03 19:04:44.707587Z] Finished create-virtualenv step (success) 11:04:44 INFO - [mozharness: 2017-02-03 19:04:44.708504Z] Running install step. 11:04:44 INFO - Running pre-action listener: _resource_record_pre_action 11:04:44 INFO - Running main action method: install 11:04:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:04:44 INFO - Reading from file tmpfile_stdout 11:04:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:04:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:04:45 INFO - Reading from file tmpfile_stdout 11:04:45 INFO - Output received: 11:04:45 INFO - Usage: mozinstall [options] installer 11:04:45 INFO - Options: 11:04:45 INFO - -h, --help show this help message and exit 11:04:45 INFO - -d DEST, --destination=DEST 11:04:45 INFO - Directory to install application into. [default: 11:04:45 INFO - "/builds/slave/test"] 11:04:45 INFO - --app=APP Application being installed. [default: firefox] 11:04:45 INFO - mkdir: /builds/slave/test/build/application 11:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:05:07 INFO - Reading from file tmpfile_stdout 11:05:07 INFO - Output received: 11:05:07 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 11:05:07 INFO - Running post-action listener: _resource_record_post_action 11:05:07 INFO - [mozharness: 2017-02-03 19:05:07.038431Z] Finished install step (success) 11:05:07 INFO - [mozharness: 2017-02-03 19:05:07.038578Z] Running run-tests step. 11:05:07 INFO - Running pre-action listener: _resource_record_pre_action 11:05:07 INFO - Running main action method: run_tests 11:05:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:05:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:05:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:05:07 INFO - 2017-02-03 11:05:07.053 screenresolution[29674:272606] starting screenresolution argv=screenresolution get 11:05:07 INFO - 2017-02-03 11:05:07.055 screenresolution[29674:272606] Display 0: 1600x1200x32@60 11:05:07 INFO - 2017-02-03 11:05:07.061 screenresolution[29675:272608] starting screenresolution argv=screenresolution list 11:05:07 INFO - Available Modes on Display 0 11:05:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:05:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:05:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:05:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:05:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:05:07 INFO - Intel Iris: 11:05:07 INFO - Chipset Model: Intel Iris 11:05:07 INFO - Type: GPU 11:05:07 INFO - Bus: Built-In 11:05:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:05:07 INFO - Vendor: Intel (0x8086) 11:05:07 INFO - Device ID: 0x0a2e 11:05:07 INFO - Revision ID: 0x0009 11:05:07 INFO - Displays: 11:05:07 INFO - Display: 11:05:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:05:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:05:07 INFO - Display Serial Number: 1600x1200 60 11:05:07 INFO - Main Display: Yes 11:05:07 INFO - Mirror: Off 11:05:07 INFO - Online: Yes 11:05:07 INFO - Rotation: Supported 11:05:07 INFO - Return code: 0 11:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:07 INFO - Python 2.7.3 11:05:07 INFO - Return code: 0 11:05:07 INFO - grabbing minidump binary from tooltool 11:05:07 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')]} 11:05:07 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 0x1103abd30>, '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 0x1102d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103a0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05:07 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 11:05:07 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 11:05:07 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 11:05:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:07 INFO - Return code: 0 11:05:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:05:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:05:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 11:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 11:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whkGWXU9YQ/Render', 11:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:07 INFO - 'HOME': '/Users/cltbld', 11:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:07 INFO - 'LOGNAME': 'cltbld', 11:05:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:07 INFO - 'MOZ_NO_REMOTE': '1', 11:05:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:07 INFO - 'NO_EM_RESTART': '1', 11:05:07 INFO - 'PAGER': '/bin/cat', 11:05:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:07 INFO - 'PWD': '/builds/slave/test', 11:05:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:07 INFO - 'SHELL': '/bin/bash', 11:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FlhrmZLT1Z/Listeners', 11:05:07 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 11:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:07 INFO - 'USER': 'cltbld', 11:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:07 INFO - 'XPC_FLAGS': '0x0', 11:05:07 INFO - 'XPC_SERVICE_NAME': '0', 11:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 11:05:07 INFO - mozversion application_buildid: 20170203094345 11:05:07 INFO - mozversion application_changeset: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d 11:05:07 INFO - mozversion application_display_name: Nightly 11:05:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:07 INFO - mozversion application_name: Firefox 11:05:07 INFO - mozversion application_remotingname: firefox 11:05:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:05:07 INFO - mozversion application_vendor: Mozilla 11:05:07 INFO - mozversion application_version: 54.0a1 11:05:07 INFO - mozversion platform_buildid: 20170203094345 11:05:07 INFO - mozversion platform_changeset: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d 11:05:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:05:07 INFO - mozversion platform_version: 54.0a1 11:05:07 INFO - using testdate: 1486148707 11:05:07 INFO - actual date: 1486148707 11:05:07 INFO - starting webserver on 'localhost:49293' 11:05:07 INFO - SUITE-START | Running 2 tests 11:05:07 INFO - TEST-START | dromaeo_css 11:05:07 INFO - operating with platform_type : mac_ 11:05:07 INFO - Initialising browser for dromaeo_css test... 11:05:07 INFO - TEST-INFO | started process 29685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile http://localhost:49293/getInfo.html) 11:05:10 INFO - PROCESS | 29685 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 11:05:11 INFO - PROCESS | 29685 | 2017-02-03 11:05:11.041 plugin-container[29688:272781] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4b, name = 'com.apple.tsm.portname' 11:05:11 INFO - PROCESS | 29685 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:05:11 INFO - PROCESS | 29685 | 2017-02-03 11:05:11.042 plugin-container[29688:272781] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9703, name = 'com.apple.CFPasteboardClient' 11:05:11 INFO - PROCESS | 29685 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:05:11 INFO - PROCESS | 29685 | 2017-02-03 11:05:11.042 plugin-container[29688:272781] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:05:11 INFO - PROCESS | 29685 | __metrics Screen width/height:1600/1200 11:05:11 INFO - PROCESS | 29685 | colorDepth:24 11:05:11 INFO - PROCESS | 29685 | Browser inner width/height: 1024/689 11:05:11 INFO - PROCESS | 29685 | __metrics 11:05:11 ERROR - PROCESS | 29685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 11:05:11 INFO - PROCESS | 29685 | 1486148711192 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/FirefoxNightly.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/FirefoxNightly.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/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:05:11 INFO - TEST-INFO | 29685: exit 0 11:05:11 INFO - Browser initialized. 11:05:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:11 INFO - TEST-INFO | started process 29690 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpiGL5fH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:14 INFO - PROCESS | 29690 | 2017-02-03 11:05:14.280 plugin-container[29691:272909] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 11:05:14 INFO - PROCESS | 29690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:05:14 INFO - PROCESS | 29690 | 2017-02-03 11:05:14.280 plugin-container[29691:272909] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4817, name = 'com.apple.CFPasteboardClient' 11:05:14 INFO - PROCESS | 29690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:05:14 INFO - PROCESS | 29690 | 2017-02-03 11:05:14.280 plugin-container[29691:272909] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:05:23 INFO - PROCESS | 29690 | RSS: Main: 233226240 11:05:23 INFO - PROCESS | 29690 | 11:08:26 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49293/tests/dromaeo/cssquery-ext.html) 11:08:28 INFO - PROCESS | 29690 | RSS: Main: 258265088 11:08:28 INFO - PROCESS | 29690 | 11:10:12 INFO - PROCESS | 29690 | ************************* 11:10:12 INFO - PROCESS | 29690 | A coding exception was thrown and uncaught in a Task. 11:10:12 INFO - PROCESS | 29690 | 11:10:12 ERROR - PROCESS | 29690 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:10:12 INFO - PROCESS | 29690 | Full stack: 11:10:12 INFO - PROCESS | 29690 | ************************* 11:11:30 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-ext.html (next: http://localhost:49293/tests/dromaeo/cssquery-jquery.html) 11:11:31 INFO - PROCESS | 29690 | RSS: Main: 269172736 11:11:31 INFO - PROCESS | 29690 | 11:14:33 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49293/tests/dromaeo/cssquery-mootools.html) 11:14:34 INFO - PROCESS | 29690 | RSS: Main: 282132480 11:14:34 INFO - PROCESS | 29690 | 11:17:35 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49293/tests/dromaeo/cssquery-prototype.html) 11:17:36 INFO - PROCESS | 29690 | RSS: Main: 273944576 11:17:36 INFO - PROCESS | 29690 | 11:20:39 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49293/tests/dromaeo/cssquery-yui.html) 11:20:40 INFO - PROCESS | 29690 | RSS: Main: 278904832 11:20:40 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-yui.html (next: http://localhost:49293/tests/dromaeo/cssquery-dojo.html) 11:23:42 INFO - PROCESS | 29690 | RSS: Main: 280776704 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | __start_tp_report 11:23:42 INFO - PROCESS | 29690 | _x_x_mozilla_page_load 11:23:42 INFO - PROCESS | 29690 | _x_x_mozilla_page_load_details 11:23:42 INFO - PROCESS | 29690 | |i|pagename|runs| 11:23:42 INFO - PROCESS | 29690 | |0;dojo.html;3334.9666503334965;3346.5649465569486;3362.882299119531;3372.460406334986;3374.0889959710894;5532.28080349554;5705.343885453169;5705.457981491757;5754.338251101125;5775.56683248756;5499.450054994509;5605.411431799654;5606.859828504289;5627.774889004445;5640.858978525529;5093.439721630609;5108.4636113208135;5129.717865517395;5131.3329267195395;5200.08998425276;5222.164453687411;5223.399309079447;5225.085610018251;5228.764705588258;5256.710880901549;5211.661242019257;5213.713245771481;5214.687118772867;5223.791048358061;5228.686278823283;5217.58259339252;5220.190870415073;5222.817201397971;5228.660137091115;5229.37247530295;5017.172166592508;5142.460041695643;5144.382674079135;5148.304978827848;5203.19350500673;4686.414198225222;5645.604807663465;5691.943080569183;5729.512991395736;5831.5334773218465;5829.446202610788;5991.820245392645;6011.068284415923;6191.226096737908;6231.3145553989025;6078.969605151946;6102.359252278536;6124.11200375943;6140.907886381708;6196.163517925068;5903.144044113666;5907.497862681677;5911.438413350725;5916.49709774674;5939.554533410012;6259.906101408483;6264.091706702594;6277;6277.905831412532;6289.842753931189;5944.197533333031;5994.37059108796;6016.8796624068145;6091.14723938649;6120.632762034292;6037.09443583466;6229.2524897012645;6247.5939063960695;6263.592866463665;6271.623702577769;6192.442680158807;6195.132681424604;6204.3795620437595;6223.439890409885;6228.781992630236;5925.881482370329;6029.909551356734;6236.875262494725;6237.719302631393;6241.344658810759;4920.6801557898625;4950.777215025332;4973.35346404965;4979.253112033224;5046.9747651261505;3726.2547490502006;4310.741355518679;4345.630621397154;4388.034632380871;4406.030673251879;5715.885682286331;5740.483356497935;5747.3103227612955;5781.624194427349;5801.535877129904;5825.097109947965;5876.471117599351;6181.289151747606;6263;6278.748850046039;5705.857353566111;5716.971415142898;5754.165645981309;5836.562257830679;5856.970715146397;4760.928586071212;5230.503102205284;5460;5479.205515200274;5497.340319161726;6120.355709576858;6290.622562646256;6292.685365731695;6328;6344.333844946306;4861.829835955725;6083.087536869328;6160.537959652955;6232.065190221503;6233.438990490878;6187.690615469299;6249.593776404519;6249.875002500015;6251.6561589113035;6251.71867265965;6114.266288045463;6133.110698948717;6138.57030007913;6185.721642526007;6203.16257305258;5955.106733989936;6092.329843717099;6121.452973576081;6124.19785563378;6128.900367973304;6004.699765011819;6056.303525094494;6069.119977603311;6108.267007958895;6129.632222066691;6064.241969753781;6064.848378790389;6067.969660151671;6068.757249709962;6069.484093852072;5449.809256675997;5809.8547536311935;5813.651180929158;5864.853378665397;5877.118432235199;6103;6112.755489780359;6117.235345581802;6140.263168419819;6142.3550527194;5923.822285331447;5971.462568368867;5971.492423144082;5972.25346831646;5986.102084687158 11:23:42 INFO - PROCESS | 29690 | |1;ext.html;447.93952816369784;488.1822946564508;498.95220037920393;520.2326568311738;541.385527426371;33267.66732332676;40960.79519602405;40994.59005409945;41069;41080.79459602705;41803;42574;42637.57362426375;42654;42778;7845.333146682538;9055.909440905605;9381.5309234538;9386.436813791195;9433.575489103006;7784.571848548328;10915.836262456069;11217.383043932581;11230;11354.318740875533;11074.723131921686;11092.112630989543;11102.6114086007;11136;11181.888181118207;11128.165387595922;11189;11230.270032447865;11239.831402528927;11242.94378528102;11022.338659680445;11100.056495197918;11115.555377784878;11123;11125.388103654295;39934.800325998185;40144.39783403251;40225.19549609021;40230.79884600588;40340.193196135915;4002.4396584478195;4016.5782592827622;4052.946233979157;4089.652379547742;4157.625813676784;30003.399932001455;30282.69717302821;30295.848520757474;30482.54276185859;30593.541096883564;3054.5876306698756;3174.68253174683;3190.5533225348468;3283.0807373935336;3285.78642388244;452500;454557;454945;455369;457260.7136964327;50913.23630145551;52095.479045209824;60728.69635651882;61032.69483652553;61070.694646526485;71746;72199;73019.2698073023;73165;73592.63203683947;13634.113782604298;15615.765763513557;15783.763243551355;16133.467320604525;16164.949278296874;11361;11381.54473821038;12080.335581543099;12083.972862306626;12256.264624122581;18714;19568.608627827365;20518.58962820735;21039.05324260412;21092.47268818261;6494.318096599789;7315;8207.932968714029;8884.64461421549;8930.553472326357;840.810817566055;858.592168719853;861.388414225894;871.1462766488877;877.5656050255037;29456.705432945397;30189.698103019127;30222.79108835666;30255.546166807515;30836.383272334875;935.1957316707626;952.2058275394165;1016.9847452288221;1061.771719080386;1130.9208355415205;15640.3743850247;15676;15760.369585216464;15947.44183953556;15955.840441595668;554911;589422;615014;620951;621534;59003.11495327573;59652;59661.70169149127;59713.40286597165;59792.40207597955;1083.8374243863484;1421.7156568686305;1425.600831767107;1435.2751860310477;1436.2387934394578;28725.56911646285;29117.708822912347;29717.257068573457;30156.396872062876;30192.09423717204;49809.25286120638;50055;50145.498545015544;50249.24626130538;50466;520991;523545;525703.6003739851;526824;529397;25766.87116564405;26396.208113756617;26540.734592653826;27362.589561156998;41102;40651.796741017286;41081.38377924393;41749.58250417457;42065.78967105145;42085.36871946984;34046.82976585101;34548;34586.82706586451;34799.65200347964;35538.64461355354;27894.3026424341;34070;34109;34830.9550713479;35015.64984350226;32838.507422388204;33737.325253495284;33999.66000340064;34247.48628770521;34269.48595771116;29338.11985640434;30340.696593033786;30469.847650761603;30566.541501877044;30758.692413075583;17311.91344043322;22676.433089172904;23504.764952350943;23568;23640.88179559091 11:23:42 INFO - PROCESS | 29690 | |2;jquery.html;345.77006290816604;398.2135282816438;398.356654003784;407.8001779128228;437.4903237728047;13008.93495532521;19758.80241197586;19958.201671933104;20362.6945595816;21180.470488237803;20876.89561552194;21074.051667674954;21107.47231319218;21287.25494607689;21328.8933555332;5405.810796622119;5707.258056452676;5760;5783.884322313551;5791.710414479259;5653.773849046033;5746.195532625415;5810.912836307459;5851.502622277111;5861.062230043194;5800.042992906166;5853.385394533577;5870.412958704117;5873.530117590604;5882.088276317178;5293.497117773805;5505.091659876116;5859.941400585983;5864.853378665525;5881.85295367615;4248.978755106235;4376.540463251376;4864.854054378339;5044.243363495469;5070.645054846163;24873.378165545826;24896.626550601755;25074.997000119973;25363.266855082697;25986;3026.8183908965534;3064.9693503064905;3085.1670049086847;3090.536419537065;3166;12455.626331210078;15321.233938303152;15325.46360877375;15407.768883466644;16098.919505402398;1835.6971099768523;1853.6570734414177;1888.518427800902;1985.7319261899604;1997.1512107354317;142464;146174;147778.52221477756;149292.01415971728;152066.7189992151;9732.805343893082;11730.941345293219;11741.882581174079;11936.164468487295;12073.396330183456;13816.37826297819;14340.56978290653;15673.216339182994;15687.215639217993;15702.293396797171;7528.698852045857;7973.641186146638;8306.833863322821;8325.625346859406;8405;8025.077116131602;8095.3523718102415;8144.30773384269;8239.423240373117;8243.464174828738;4730.787114579852;4784.827717209306;4818;4874.123462466976;4917.729524876167;1600.903945763258;1680.2606852984648;1806.5393324702118;1912.6652835753966;2065.1842522203647;969.8448248280241;1013.5692330759398;1032.7573020340214;1039.719275795531;1072.790805792863;20260.797392026187;20304.796952030585;20551.4862128445;20670.689939650918;20694.068766905526;949.620151939216;1037.7353774787382;1039.8908114648004;1056.8890266522058;1074.9355038697547;9125.224355929688;10592.981000414844;10918.836217456745;10931.617393391192;10939.890601094046;618324;641541;705861.0604204705;721173.3941330365;723898;138721.30639346738;140301.59698402885;143537;144354;144885;1008.8083264179783;1014.3254735600743;1034.813733527957;1038.7299302181486;1041.9840655360963;15299.61750956235;17162.71279654006;17651;18412.539686507407;18668.906655466635;46469.3029604563;51879;52981.47018529919;53728.194077089654;54239.18641220464;81383.18616813756;81690;83096.58451707703;83675.5816220915;84152.57923710588;8332.708355207538;11948.581799636971;12275.140740148105;12645.87354126447;12981.480740770263;11234.494447749707;12737.93631031876;13626.454941802216;13661.590152295446;14123.788143177655;11555.653330400102;11555.653330400102;11611.593594224161;12028.939855300667;12045.578404755792;9627.711168664951;11222.887771122185;11699.590514331958;11902.940485297519;11909.22590031645;10562.31344962575;11701.654309754487;11835.526578936746;12057.939710301393;12079.51681932713;12591;12631.684207894876;12940.741185176055;13010.284434356201;13025.153365031243;11777.646670599554;12032;12093.637190884288;12125.939370303093;12149.453274602487 11:23:42 INFO - PROCESS | 29690 | |3;mootools.html;1303.7783576791944;1436.4541474239788;1453.1281231261244;1478.4603619678817;1479.4599971010584;7649.196834332399;7842.8039299017555;8377.83244335113;8921.286297096232;8937.704032915231;8290.046644635868;8611.181937715906;8639.222469977702;8784.297256219503;8813.38306318558;2308.6421604651264;2310.2260742651233;2338.2634470141934;2339.87130707811;2346.530693861226;2017.243533674872;2104.1478201328487;2281.8744969026698;2311.630139177732;2323.2101085630884;1859.6001859600183;2241.6301310283784;2313.8727369994645;2325.1513197682893;2333.56828986638;2287.79409853114;2287.805536529397;2305.642625393075;2314.1900334882826;2316.027268547214;2286.965695514569;2338.5089131282452;2346.1084787780533;2364.8817559121976;2367.419982104378;8781.077986811357;8796.8680469793;8855.24730397917;8872.55637218143;8903.688370907052;5250;5383.43473935235;5391.541718953855;5394;5401.405845357008;2975.3008043109853;3520.295940811822;3559.199180184464;3610.277944411102;3641.617630148849;1204.9578264760692;1216.4282787090053;1233.4387853526623;1253.0351629245522;1275.330451512954;10917.727056823564;11270.605528806453;11490.942545287304;11595.884041159648;11626.593069242535;3917.7845218513257;4470.977645111753;4792.448868380111;4798.064377446364;4822.807087716452;9849.261305402124;9965;9996.150327222267;9996.700098997042;10010.149137323264;5305.495977882095;5361.490658387447;5385.865353366119;5386.865328366822;5390.137577987582;4743.905121897543;4899.853004409873;4929.433115191799;4933.679310844784;4962.082014827269;3882.475865758143;3899.6100389960775;3964.4053391991433;3978.8010599469912;4011.8194681239415;1140.321508702321;1176.452949378543;1311.3508813137366;1317.2425855133338;1328.1566205459603;678.7217240931194;719.453215556181;745.5638451505821;808.7007807111289;858.4248553469191;4325.675574331937;5643.322801263793;5859.2090067841145;5901.734421951022;5961.344252132262;864.567716141929;878.1789027259405;988.5847943863595;999.8700168978132;1005.6279176704666;3801.733878628525;3840.7887566183567;3845.5000849889334;3887.922241555153;3929.842806287774;9946.353487023465;10425.165986721044;10444.373337599769;10460.058594726512;10493.108085812639;10397.48012599367;10408.47957602117;10432.791344173074;10445.477726113664;10459.372437653765;8068.798280042928;8109.3917956152345;8168.264856162974;8200.58997050145;8202.38482113844;4702.52974702527;5494.066008778437;5662.971685141548;5748.511376532874;5753.539716822728;8917.509536975529;9192.632294708405;9548.522573871418;9551.235901128031;9554.378965367228;9188.49463279526;9548.761280967754;9629.133377996013;9650.758731031781;9653.855192171983;7385.778426647209;7507;7542.396608271435;7547.132079810673;7568.281013303727;8131.186881311822;8160.755177344689;8199.672013119647;8215.178482151738;8221;7283.963580182065;7289.744858929912;7410.777676669709;7448.106227252764;7528.887066694114;7271.054762880792;7327.120745510573;7343.8531229376185;7373.594452305175;7383.409327253699;6464.709088090953;6536.444402225864;6551.279359270381;6613.10723052401;6627.403533681992;5061.392632884077;5092.083424983539;5137.998090372342;5152.201408781645;5268.894622107613;5088.491150884882;5092.287079808903;5097.413797413196;5227.686338819683;5326.680399176062 11:23:42 INFO - PROCESS | 29690 | |4;prototype.html;366.5399923096515;368.11835653609603;378.8257401595266;379.20934850836005;381.4088163346814;4901.460839307673;5209.322788037554;5607.383187849344;5616.971915140419;5711;4533.523979982104;4579.862604121873;5377.462253774621;5412.864678383033;5450.182472629108;3673.779573225602;4164.604362585549;4164.729292595972;4181.142865712529;4187.413762073312;3968.603139686037;4025.4565633639522;4140.213359461693;4165.770882601456;4190.937135942948;3187.5696780934627;3892.7884495291355;3922.3920292354733;4116.8970775730695;4117.538273912763;4100.8974775630695;4113.9303781017;4126.607972242632;4150.896227594304;4175.958240417587;3416.1118109291515;3584.301061293049;3586.946195807065;3599.3161299353037;3623.4202527595457;5143.459936706629;5189.870253243699;5309.41596424393;5353.678779273256;5408.648437851527;3834.9041273968096;4283.957160428387;4462.419885414875;4712.787924543404;4721.457032441279;4808.422989241279;5762.501749545107;5773.884522309572;5780.595358324919;5788.88422231553;3580.15866271426;3685.4287585424304;3758.4926034985474;3786;3908.9413658795143;5248.766539863129;5414.7834086636485;5670.291213598301;5939.406059394069;5959.791407300767;3572.9281215635206;3885.589855514012;3979.9503255823274;4004.739691920016;4005.499312585927;4045.9797701011894;4064.4309796628495;4081.856915231043;4084.121304200042;4084.9795751021647;3965.3655415134017;4484.529124441887;4770.308305295713;4772.665913386029;4802.903941921142;4883.926741098886;5141.408737995179;5525.231925783711;5713.514351280104;5828.154917536934;1219.3842109734528;1307.235267368581;1311.8294621699117;1313.8686131386976;1315.894728421724;795.5306369242174;800.7068584236532;823.8517066927891;894.6421431427481;899.8796498359453;5080.695158290514;5105.013567063235;5115.948840511547;5126.564242039394;5129.615278854027;4764.475907650156;5174.689518628819;5381.78472861089;5676.460736230051;5703.800366987136;4153.460050193456;4708.364370809965;4749.88630059627;4790.065937142223;5097;2564.6153077038593;2648.933776655599;2760.4617099665775;2932.4634191424266;2991.8331850578293;5448.83653490396;5558.805441809517;5661.575381846378;5763.625364351387;5944.405559444021;5121.436641969381;5162.896742065138;5809.153514777729;5853.536615846038;5878.177055212273;5897.941020589739;5909.468147866713;5928.251165906068;5935.080062590306;5952.285725713029;5304.230886521355;5691.008147148465;5692.373838877803;5742.36342642345;5750.25246717924;5008.520782212682;5054.949450505448;5208.932168905441;5610.85972850682;5662.734906037618;5732.646401854795;5836.941630583639;5955.851103722442;6014.548908831943;6036.034234522455;3888.241792850367;3961;3968.940465892956;3979.422983667294;4018.7789671568344;5133.409657889241;5174.922376164436;5307.124324486416;5655.406182350794;5904.498117660047;5248.291480650063;5568.220449137205;5802.854928626818;5857.414258574279;5869.354371019099;4693.436787585511;4953.653244272867;5310.495502927216;5332.706701131475;5368.597355198453;5027.371578552681;5090.880006398586;5523.696196709219;5648.293963254593;5738.454846789548;5404.297441332602;5404.703001224542;5464.251439539468;5821.301443826768;5863.17915491823;5190.079670521931;5453.300616195009;5751.9424805751405;5754.338251101177;5767.596268261182 11:23:42 INFO - PROCESS | 29690 | |5;yui.html;694.2294053600506;712.5404114346244;760.0233699695892;809.4954310687326;812.939029572782;14522.854771452283;15556.299966501507;17597.296108155657;17640.206190721416;17658.82341176588;16468.01191928485;16538.917305413484;16643.16784160793;16655.25051372688;16702.83297167028;858.3176374782032;863.3093525179862;879.6833140069601;881.4006475596592;881.8853549038616;868.0364795077459;883.4919921045392;886.7517095213351;892.5091199840094;893.7006102955485;932.2448816458656;932.8460803967337;935.5556110847361;935.957881895313;936.0686117313248;915.1351972386097;925.181214625055;927.1562877781221;927.4481683398435;928.6656803550717;671.3722669304167;680.2653134614604;692.6121372031679;695.9652017399161;697.135551915626;15681.529554113395;15899;15988.920055399765;16133.515994520183;16320.75518867218;11920.642380728592;13585.456581736718;14131.505397311044;14403;14433.422663093568;11567.942160289229;11662.941685291604;11758.17692761507;12069.939650301692;12341.753164936741;3641.2717456508803;3682.1346983458866;3684.2631473705096;3705.4997575327257;3845.288621605012;113100.43449782781;114336.4283178587;115620.42189789082;115990.42004789921;117075;10645.92943895904;10857.402842843561;10858.914108589235;10991.450427478594;11057.612983545538;22589.774102259096;22623.20818771335;22836.31491055271;22914.198003070145;22939.42651433694;7420.369268612229;7422.294881986203;7431.479796414307;7432;7667.808304792425;4068.4914385701786;4149.149424367997;4149.2738770715005;4153.1518474278655;4157.355609880473;3550.6626870447267;3623.2753449310244;3652.6712595866497;3661.41417373219;3665.651763082503;652.1228947066188;658.6739563915893;662.8731157033063;663.8207683925409;668.0680450771147;661.8742438936587;699.9440044796404;703.2580627438102;706.9681864316016;732.2311572848488;8490.186635155345;8948.926128864448;9862.408255504693;9884.55519501624;10466.11038061758;580.7096451774113;639.7792761497276;666.4967949198324;672.7241830849329;675.4528831646383;4456.598906098467;4474.679210455812;4546.29532422475;4761.098439196385;4900.166971614834;80137;85504.57247713722;104762;106260.93739062666;108943.45528272308;66429;90927.63608545877;91799.62300565497;92002.16251605842;92057.539712301;58098.7095064522;60169.097463538084;66025.66987165033;66392.67625633176;68440.63118737597;9090.681826136053;10013.468582419438;10883.510242038968;11022.724431888946;11071.612493562687;38783.612163878;44272.55727442684;45407;45678.77160614176;47501.04997900092;56893;59045.40954590399;59611.403885960586;60299.39700602938;60580.091298629675;12793.61619151427;12896.226226426445;13007.804882926574;13449;13521;14342.713145737236;14689.41242350294;14743.041702289316;15141.621459463602;15298.005629634039;13464.461421543028;13564.498297001239;13681.14732932105;13765.739867343136;14101.365438555495;13400.865991340352;13597.320133993459;13646.590602281947;13661.18032918028;14062.929685351917;11187.608433705107;13504.054716169774;13650.317484125953;13900.304984750925;14090.225037622618;10572.41851698164;10986.230963832455;11025.393603351893;11187.944060279971;11631.302121872715;9538.380005299634;10206.285560010729;10553.526159251029;10711.979575415258;10760.085392741705 11:23:42 INFO - PROCESS | 29690 | __end_tp_report 11:23:42 INFO - PROCESS | 29690 | __start_cc_report 11:23:42 INFO - PROCESS | 29690 | _x_x_mozilla_cycle_collect,420 11:23:42 INFO - PROCESS | 29690 | __end_cc_report 11:23:42 INFO - PROCESS | 29690 | __startTimestamp1486149822962__endTimestamp 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | ------- Summary: start ------- 11:23:42 INFO - PROCESS | 29690 | Number of tests: 6 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#0] dojo.html Cycles:165 Average:5691.78 Median:5916.50 stddev:645.19 (10.9%) stddev-sans-first:620.11 11:23:42 INFO - PROCESS | 29690 | Values: 3335.0 3346.6 3362.9 3372.5 3374.1 5532.3 5705.3 5705.5 5754.3 5775.6 5499.5 5605.4 5606.9 5627.8 5640.9 5093.4 5108.5 5129.7 5131.3 5200.1 5222.2 5223.4 5225.1 5228.8 5256.7 5211.7 5213.7 5214.7 5223.8 5228.7 5217.6 5220.2 5222.8 5228.7 5229.4 5017.2 5142.5 5144.4 5148.3 5203.2 4686.4 5645.6 5691.9 5729.5 5831.5 5829.4 5991.8 6011.1 6191.2 6231.3 6079.0 6102.4 6124.1 6140.9 6196.2 5903.1 5907.5 5911.4 5916.5 5939.6 6259.9 6264.1 6277.0 6277.9 6289.8 5944.2 5994.4 6016.9 6091.1 6120.6 6037.1 6229.3 6247.6 6263.6 6271.6 6192.4 6195.1 6204.4 6223.4 6228.8 5925.9 6029.9 6236.9 6237.7 6241.3 4920.7 4950.8 4973.4 4979.3 5047.0 3726.3 4310.7 4345.6 4388.0 4406.0 5715.9 5740.5 5747.3 5781.6 5801.5 5825.1 5876.5 6181.3 6263.0 6278.7 5705.9 5717.0 5754.2 5836.6 5857.0 4760.9 5230.5 5460.0 5479.2 5497.3 6120.4 6290.6 6292.7 6328.0 6344.3 4861.8 6083.1 6160.5 6232.1 6233.4 6187.7 6249.6 6249.9 6251.7 6251.7 6114.3 6133.1 6138.6 6185.7 6203.2 5955.1 6092.3 6121.5 6124.2 6128.9 6004.7 6056.3 6069.1 6108.3 6129.6 6064.2 6064.8 6068.0 6068.8 6069.5 5449.8 5809.9 5813.7 5864.9 5877.1 6103.0 6112.8 6117.2 6140.3 6142.4 5923.8 5971.5 5971.5 5972.3 5986.1 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#1] ext.html Cycles:180 Average:66465.17 Median:34408.74 stddev:141470.26 (411.1%) stddev-sans-first:141780.28 11:23:42 INFO - PROCESS | 29690 | Values: 447.9 488.2 499.0 520.2 541.4 33267.7 40960.8 40994.6 41069.0 41080.8 41803.0 42574.0 42637.6 42654.0 42778.0 7845.3 9055.9 9381.5 9386.4 9433.6 7784.6 10915.8 11217.4 11230.0 11354.3 11074.7 11092.1 11102.6 11136.0 11181.9 11128.2 11189.0 11230.3 11239.8 11242.9 11022.3 11100.1 11115.6 11123.0 11125.4 39934.8 40144.4 40225.2 40230.8 40340.2 4002.4 4016.6 4052.9 4089.7 4157.6 30003.4 30282.7 30295.8 30482.5 30593.5 3054.6 3174.7 3190.6 3283.1 3285.8 452500.0 454557.0 454945.0 455369.0 457260.7 50913.2 52095.5 60728.7 61032.7 61070.7 71746.0 72199.0 73019.3 73165.0 73592.6 13634.1 15615.8 15783.8 16133.5 16164.9 11361.0 11381.5 12080.3 12084.0 12256.3 18714.0 19568.6 20518.6 21039.1 21092.5 6494.3 7315.0 8207.9 8884.6 8930.6 840.8 858.6 861.4 871.1 877.6 29456.7 30189.7 30222.8 30255.5 30836.4 935.2 952.2 1017.0 1061.8 1130.9 15640.4 15676.0 15760.4 15947.4 15955.8 554911.0 589422.0 615014.0 620951.0 621534.0 59003.1 59652.0 59661.7 59713.4 59792.4 1083.8 1421.7 1425.6 1435.3 1436.2 28725.6 29117.7 29717.3 30156.4 30192.1 49809.3 50055.0 50145.5 50249.2 50466.0 520991.0 523545.0 525703.6 526824.0 529397.0 25766.9 26396.2 26540.7 27362.6 41102.0 40651.8 41081.4 41749.6 42065.8 42085.4 34046.8 34548.0 34586.8 34799.7 35538.6 27894.3 34070.0 34109.0 34831.0 35015.6 32838.5 33737.3 33999.7 34247.5 34269.5 29338.1 30340.7 30469.8 30566.5 30758.7 17311.9 22676.4 23504.8 23568.0 23640.9 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#2] jquery.html Cycles:180 Average:39032.92 Median:11128.97 stddev:114363.97 (1027.6%) stddev-sans-first:114647.90 11:23:42 INFO - PROCESS | 29690 | Values: 345.8 398.2 398.4 407.8 437.5 13008.9 19758.8 19958.2 20362.7 21180.5 20876.9 21074.1 21107.5 21287.3 21328.9 5405.8 5707.3 5760.0 5783.9 5791.7 5653.8 5746.2 5810.9 5851.5 5861.1 5800.0 5853.4 5870.4 5873.5 5882.1 5293.5 5505.1 5859.9 5864.9 5881.9 4249.0 4376.5 4864.9 5044.2 5070.6 24873.4 24896.6 25075.0 25363.3 25986.0 3026.8 3065.0 3085.2 3090.5 3166.0 12455.6 15321.2 15325.5 15407.8 16098.9 1835.7 1853.7 1888.5 1985.7 1997.2 142464.0 146174.0 147778.5 149292.0 152066.7 9732.8 11730.9 11741.9 11936.2 12073.4 13816.4 14340.6 15673.2 15687.2 15702.3 7528.7 7973.6 8306.8 8325.6 8405.0 8025.1 8095.4 8144.3 8239.4 8243.5 4730.8 4784.8 4818.0 4874.1 4917.7 1600.9 1680.3 1806.5 1912.7 2065.2 969.8 1013.6 1032.8 1039.7 1072.8 20260.8 20304.8 20551.5 20670.7 20694.1 949.6 1037.7 1039.9 1056.9 1074.9 9125.2 10593.0 10918.8 10931.6 10939.9 618324.0 641541.0 705861.1 721173.4 723898.0 138721.3 140301.6 143537.0 144354.0 144885.0 1008.8 1014.3 1034.8 1038.7 1042.0 15299.6 17162.7 17651.0 18412.5 18668.9 46469.3 51879.0 52981.5 53728.2 54239.2 81383.2 81690.0 83096.6 83675.6 84152.6 8332.7 11948.6 12275.1 12645.9 12981.5 11234.5 12737.9 13626.5 13661.6 14123.8 11555.7 11555.7 11611.6 12028.9 12045.6 9627.7 11222.9 11699.6 11902.9 11909.2 10562.3 11701.7 11835.5 12057.9 12079.5 12591.0 12631.7 12940.7 13010.3 13025.2 11777.6 12032.0 12093.6 12125.9 12149.5 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#3] mootools.html Cycles:180 Average:5604.56 Median:5238.84 stddev:3119.90 (59.6%) stddev-sans-first:3111.91 11:23:42 INFO - PROCESS | 29690 | Values: 1303.8 1436.5 1453.1 1478.5 1479.5 7649.2 7842.8 8377.8 8921.3 8937.7 8290.0 8611.2 8639.2 8784.3 8813.4 2308.6 2310.2 2338.3 2339.9 2346.5 2017.2 2104.1 2281.9 2311.6 2323.2 1859.6 2241.6 2313.9 2325.2 2333.6 2287.8 2287.8 2305.6 2314.2 2316.0 2287.0 2338.5 2346.1 2364.9 2367.4 8781.1 8796.9 8855.2 8872.6 8903.7 5250.0 5383.4 5391.5 5394.0 5401.4 2975.3 3520.3 3559.2 3610.3 3641.6 1205.0 1216.4 1233.4 1253.0 1275.3 10917.7 11270.6 11490.9 11595.9 11626.6 3917.8 4471.0 4792.4 4798.1 4822.8 9849.3 9965.0 9996.2 9996.7 10010.1 5305.5 5361.5 5385.9 5386.9 5390.1 4743.9 4899.9 4929.4 4933.7 4962.1 3882.5 3899.6 3964.4 3978.8 4011.8 1140.3 1176.5 1311.4 1317.2 1328.2 678.7 719.5 745.6 808.7 858.4 4325.7 5643.3 5859.2 5901.7 5961.3 864.6 878.2 988.6 999.9 1005.6 3801.7 3840.8 3845.5 3887.9 3929.8 9946.4 10425.2 10444.4 10460.1 10493.1 10397.5 10408.5 10432.8 10445.5 10459.4 8068.8 8109.4 8168.3 8200.6 8202.4 4702.5 5494.1 5663.0 5748.5 5753.5 8917.5 9192.6 9548.5 9551.2 9554.4 9188.5 9548.8 9629.1 9650.8 9653.9 7385.8 7507.0 7542.4 7547.1 7568.3 8131.2 8160.8 8199.7 8215.2 8221.0 7284.0 7289.7 7410.8 7448.1 7528.9 7271.1 7327.1 7343.9 7373.6 7383.4 6464.7 6536.4 6551.3 6613.1 6627.4 5061.4 5092.1 5138.0 5152.2 5268.9 5088.5 5092.3 5097.4 5227.7 5326.7 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#4] prototype.html Cycles:180 Average:4556.69 Median:5124.00 stddev:1390.56 (27.1%) stddev-sans-first:1358.43 11:23:42 INFO - PROCESS | 29690 | Values: 366.5 368.1 378.8 379.2 381.4 4901.5 5209.3 5607.4 5617.0 5711.0 4533.5 4579.9 5377.5 5412.9 5450.2 3673.8 4164.6 4164.7 4181.1 4187.4 3968.6 4025.5 4140.2 4165.8 4190.9 3187.6 3892.8 3922.4 4116.9 4117.5 4100.9 4113.9 4126.6 4150.9 4176.0 3416.1 3584.3 3586.9 3599.3 3623.4 5143.5 5189.9 5309.4 5353.7 5408.6 3834.9 4284.0 4462.4 4712.8 4721.5 4808.4 5762.5 5773.9 5780.6 5788.9 3580.2 3685.4 3758.5 3786.0 3908.9 5248.8 5414.8 5670.3 5939.4 5959.8 3572.9 3885.6 3980.0 4004.7 4005.5 4046.0 4064.4 4081.9 4084.1 4085.0 3965.4 4484.5 4770.3 4772.7 4802.9 4883.9 5141.4 5525.2 5713.5 5828.2 1219.4 1307.2 1311.8 1313.9 1315.9 795.5 800.7 823.9 894.6 899.9 5080.7 5105.0 5115.9 5126.6 5129.6 4764.5 5174.7 5381.8 5676.5 5703.8 4153.5 4708.4 4749.9 4790.1 5097.0 2564.6 2648.9 2760.5 2932.5 2991.8 5448.8 5558.8 5661.6 5763.6 5944.4 5121.4 5162.9 5809.2 5853.5 5878.2 5897.9 5909.5 5928.3 5935.1 5952.3 5304.2 5691.0 5692.4 5742.4 5750.3 5008.5 5054.9 5208.9 5610.9 5662.7 5732.6 5836.9 5955.9 6014.5 6036.0 3888.2 3961.0 3968.9 3979.4 4018.8 5133.4 5174.9 5307.1 5655.4 5904.5 5248.3 5568.2 5802.9 5857.4 5869.4 4693.4 4953.7 5310.5 5332.7 5368.6 5027.4 5090.9 5523.7 5648.3 5738.5 5404.3 5404.7 5464.3 5821.3 5863.2 5190.1 5453.3 5751.9 5754.3 5767.6 11:23:42 INFO - PROCESS | 29690 | 11:23:42 INFO - PROCESS | 29690 | [#5] yui.html Cycles:180 Average:19875.95 Median:3775.39 stddev:28509.80 (755.1%) stddev-sans-first:28553.39 11:23:42 INFO - PROCESS | 29690 | Values: 694.2 712.5 760.0 809.5 812.9 14522.9 15556.3 17597.3 17640.2 17658.8 16468.0 16538.9 16643.2 16655.3 16702.8 858.3 863.3 879.7 881.4 881.9 868.0 883.5 886.8 892.5 893.7 932.2 932.8 935.6 936.0 936.1 915.1 925.2 927.2 927.4 928.7 671.4 680.3 692.6 696.0 697.1 15681.5 15899.0 15988.9 16133.5 16320.8 11920.6 13585.5 14131.5 14403.0 14433.4 11567.9 11662.9 11758.2 12069.9 12341.8 3641.3 3682.1 3684.3 3705.5 3845.3 113100.4 114336.4 115620.4 115990.4 117075.0 10645.9 10857.4 10858.9 10991.5 11057.6 22589.8 22623.2 22836.3 22914.2 22939.4 7420.4 7422.3 7431.5 7432.0 7667.8 4068.5 4149.1 4149.3 4153.2 4157.4 3550.7 3623.3 3652.7 3661.4 3665.7 652.1 658.7 662.9 663.8 668.1 661.9 699.9 703.3 707.0 732.2 8490.2 8948.9 9862.4 9884.6 10466.1 580.7 639.8 666.5 672.7 675.5 4456.6 4474.7 4546.3 4761.1 4900.2 80137.0 85504.6 104762.0 106260.9 108943.5 66429.0 90927.6 91799.6 92002.2 92057.5 58098.7 60169.1 66025.7 66392.7 68440.6 9090.7 10013.5 10883.5 11022.7 11071.6 38783.6 44272.6 45407.0 45678.8 47501.0 56893.0 59045.4 59611.4 60299.4 60580.1 12793.6 12896.2 13007.8 13449.0 13521.0 14342.7 14689.4 14743.0 15141.6 15298.0 13464.5 13564.5 13681.1 13765.7 14101.4 13400.9 13597.3 13646.6 13661.2 14062.9 11187.6 13504.1 13650.3 13900.3 14090.2 10572.4 10986.2 11025.4 11187.9 11631.3 9538.4 10206.3 10553.5 10712.0 10760.1 11:23:42 INFO - PROCESS | 29690 | -------- Summary: end -------- 11:23:42 INFO - PROCESS | 29690 | 11:23:43 INFO - TEST-INFO | 29690: exit 0 11:23:43 INFO - TEST-OK | dromaeo_css | took 1115929ms 11:23:43 INFO - TEST-START | kraken 11:23:43 INFO - operating with platform_type : mac_ 11:23:43 INFO - Initialising browser for kraken test... 11:23:43 INFO - TEST-INFO | started process 29697 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile http://localhost:49293/getInfo.html) 11:23:46 INFO - PROCESS | 29697 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 11:23:46 INFO - PROCESS | 29697 | 2017-02-03 11:23:46.472 plugin-container[29699:274810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 11:23:46 INFO - PROCESS | 29697 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:46 INFO - PROCESS | 29697 | 2017-02-03 11:23:46.473 plugin-container[29699:274810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 11:23:46 INFO - PROCESS | 29697 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:46 INFO - PROCESS | 29697 | 2017-02-03 11:23:46.473 plugin-container[29699:274810] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:23:46 INFO - PROCESS | 29697 | __metrics Screen width/height:1600/1200 11:23:46 INFO - PROCESS | 29697 | colorDepth:24 11:23:46 INFO - PROCESS | 29697 | Browser inner width/height: 1024/689 11:23:46 INFO - PROCESS | 29697 | __metrics 11:23:46 ERROR - PROCESS | 29697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 11:23:46 INFO - PROCESS | 29697 | 1486149826650 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/FirefoxNightly.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/FirefoxNightly.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/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:23:47 INFO - TEST-INFO | 29697: exit 0 11:23:47 INFO - Browser initialized. 11:23:47 INFO - Running cycle 1/1 for kraken test... 11:23:47 INFO - TEST-INFO | started process 29700 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmp5axnmf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:49 INFO - PROCESS | 29700 | 2017-02-03 11:23:49.914 plugin-container[29701:274923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 11:23:49 INFO - PROCESS | 29700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:49 INFO - PROCESS | 29700 | 2017-02-03 11:23:49.915 plugin-container[29701:274923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 11:23:49 INFO - PROCESS | 29700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:23:49 INFO - PROCESS | 29700 | 2017-02-03 11:23:49.915 plugin-container[29701:274923] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:23:59 INFO - PROCESS | 29700 | RSS: Main: 233558016 11:23:59 INFO - PROCESS | 29700 | 11:24:02 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:03 INFO - PROCESS | 29700 | RSS: Main: 247193600 11:24:03 INFO - PROCESS | 29700 | 11:24:06 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-dft) 11:24:06 INFO - PROCESS | 29700 | RSS: Main: 255086592 11:24:06 INFO - PROCESS | 29700 | 11:24:10 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-fft) 11:24:10 INFO - PROCESS | 29700 | RSS: Main: 257626112 11:24:10 INFO - PROCESS | 29700 | 11:24:12 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator) 11:24:13 INFO - PROCESS | 29700 | RSS: Main: 258826240 11:24:13 INFO - PROCESS | 29700 | 11:24:15 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:16 INFO - PROCESS | 29700 | RSS: Main: 260579328 11:24:16 INFO - PROCESS | 29700 | 11:24:18 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:19 INFO - PROCESS | 29700 | RSS: Main: 266203136 11:24:19 INFO - PROCESS | 29700 | 11:24:22 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:23 INFO - PROCESS | 29700 | RSS: Main: 266022912 11:24:23 INFO - PROCESS | 29700 | 11:24:26 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial) 11:24:27 INFO - PROCESS | 29700 | RSS: Main: 265646080 11:24:27 INFO - PROCESS | 29700 | 11:24:28 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:29 INFO - PROCESS | 29700 | RSS: Main: 265330688 11:24:29 INFO - PROCESS | 29700 | 11:24:31 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:32 INFO - PROCESS | 29700 | RSS: Main: 265170944 11:24:32 INFO - PROCESS | 29700 | 11:24:34 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:34 INFO - PROCESS | 29700 | RSS: Main: 265273344 11:24:34 INFO - PROCESS | 29700 | 11:24:37 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:24:38 INFO - PROCESS | 29700 | RSS: Main: 265576448 11:24:38 INFO - PROCESS | 29700 | 11:24:41 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:24:42 INFO - PROCESS | 29700 | RSS: Main: 265363456 11:24:42 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49293/tests/kraken/driver.html?testName=ai-astar) 11:24:44 INFO - PROCESS | 29700 | RSS: Main: 267366400 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | __start_tp_report 11:24:44 INFO - PROCESS | 29700 | _x_x_mozilla_page_load 11:24:44 INFO - PROCESS | 29700 | _x_x_mozilla_page_load_details 11:24:44 INFO - PROCESS | 29700 | |i|pagename|runs| 11:24:44 INFO - PROCESS | 29700 | |0;ai-astar;104;115;116;117;117;116;118;118;131;173 11:24:44 INFO - PROCESS | 29700 | |1;audio-beat-detection;149;114;115;155;118;115;114;113;137;115 11:24:44 INFO - PROCESS | 29700 | |2;audio-dft;237;207;215;219;196;203;195;197;196;193 11:24:44 INFO - PROCESS | 29700 | |3;audio-fft;84;59;58;88;63;61;58;50;70;54 11:24:44 INFO - PROCESS | 29700 | |4;audio-oscillator;91;71;85;71;76;69;82;69;72;84 11:24:44 INFO - PROCESS | 29700 | |5;imaging-gaussian-blur;108;131;89;86;88;101;90;90;89;76 11:24:44 INFO - PROCESS | 29700 | |6;imaging-darkroom;96;96;120;151;122;100;151;151;96;97 11:24:44 INFO - PROCESS | 29700 | |7;imaging-desaturate;93;95;79;143;93;93;93;93;86;92 11:24:44 INFO - PROCESS | 29700 | |8;json-parse-financial;64;64;63;72;77;98;101;98;75;65 11:24:44 INFO - PROCESS | 29700 | |9;json-stringify-tinderbox;68;85;73;88;79;77;70;79;106;107 11:24:44 INFO - PROCESS | 29700 | |10;stanford-crypto-aes;90;89;89;87;88;85;113;87;88;87 11:24:44 INFO - PROCESS | 29700 | |11;stanford-crypto-ccm;144;163;153;137;138;138;150;141;190;141 11:24:44 INFO - PROCESS | 29700 | |12;stanford-crypto-pbkdf2;181;176;172;176;238;238;174;187;235;168 11:24:44 INFO - PROCESS | 29700 | |13;stanford-crypto-sha256-iterative;68;67;67;67;67;67;70;83;60;77 11:24:44 INFO - PROCESS | 29700 | __end_tp_report 11:24:44 INFO - PROCESS | 29700 | __start_cc_report 11:24:44 INFO - PROCESS | 29700 | _x_x_mozilla_cycle_collect,995 11:24:44 INFO - PROCESS | 29700 | __end_cc_report 11:24:44 INFO - PROCESS | 29700 | __startTimestamp1486149884332__endTimestamp 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | ------- Summary: start ------- 11:24:44 INFO - PROCESS | 29700 | Number of tests: 14 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#0] ai-astar Cycles:10 Average:122.50 Median:117.50 stddev:18.88 (16.1%) stddev-sans-first:18.80 11:24:44 INFO - PROCESS | 29700 | Values: 104.0 115.0 116.0 117.0 117.0 116.0 118.0 118.0 131.0 173.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:116.50 stddev:16.17 (13.9%) stddev-sans-first:14.52 11:24:44 INFO - PROCESS | 29700 | Values: 149.0 114.0 115.0 155.0 118.0 115.0 114.0 113.0 137.0 115.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#2] audio-dft Cycles:10 Average:205.80 Median:205.00 stddev:14.11 (6.9%) stddev-sans-first:9.42 11:24:44 INFO - PROCESS | 29700 | Values: 237.0 207.0 215.0 219.0 196.0 203.0 195.0 197.0 196.0 193.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#3] audio-fft Cycles:10 Average:64.50 Median:62.00 stddev:12.53 (20.2%) stddev-sans-first:11.12 11:24:44 INFO - PROCESS | 29700 | Values: 84.0 59.0 58.0 88.0 63.0 61.0 58.0 50.0 70.0 54.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.00 stddev:7.89 (10.0%) stddev-sans-first:6.54 11:24:44 INFO - PROCESS | 29700 | Values: 91.0 71.0 85.0 71.0 76.0 69.0 82.0 69.0 72.0 84.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:88.50 stddev:15.32 (17.3%) stddev-sans-first:15.49 11:24:44 INFO - PROCESS | 29700 | Values: 108.0 131.0 89.0 86.0 88.0 101.0 90.0 90.0 89.0 76.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:123.50 stddev:24.73 (20.0%) stddev-sans-first:24.92 11:24:44 INFO - PROCESS | 29700 | Values: 96.0 96.0 120.0 151.0 122.0 100.0 151.0 151.0 96.0 97.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:93.00 stddev:17.19 (18.5%) stddev-sans-first:18.20 11:24:44 INFO - PROCESS | 29700 | Values: 93.0 95.0 79.0 143.0 93.0 93.0 93.0 93.0 86.0 92.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#8] json-parse-financial Cycles:10 Average:77.70 Median:73.50 stddev:15.49 (21.1%) stddev-sans-first:15.62 11:24:44 INFO - PROCESS | 29700 | Values: 64.0 64.0 63.0 72.0 77.0 98.0 101.0 98.0 75.0 65.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#9] json-stringify-tinderbox Cycles:10 Average:83.20 Median:78.00 stddev:13.73 (17.6%) stddev-sans-first:13.41 11:24:44 INFO - PROCESS | 29700 | Values: 68.0 85.0 73.0 88.0 79.0 77.0 70.0 79.0 106.0 107.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:88.00 stddev:8.10 (9.2%) stddev-sans-first:8.59 11:24:44 INFO - PROCESS | 29700 | Values: 90.0 89.0 89.0 87.0 88.0 85.0 113.0 87.0 88.0 87.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:147.00 stddev:16.43 (11.2%) stddev-sans-first:17.31 11:24:44 INFO - PROCESS | 29700 | Values: 144.0 163.0 153.0 137.0 138.0 138.0 150.0 141.0 190.0 141.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:184.00 stddev:29.77 (16.2%) stddev-sans-first:31.17 11:24:44 INFO - PROCESS | 29700 | Values: 181.0 176.0 172.0 176.0 238.0 238.0 174.0 187.0 235.0 168.0 11:24:44 INFO - PROCESS | 29700 | 11:24:44 INFO - PROCESS | 29700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:67.50 stddev:6.34 (9.4%) stddev-sans-first:6.71 11:24:44 INFO - PROCESS | 29700 | Values: 68.0 67.0 67.0 67.0 67.0 67.0 70.0 83.0 60.0 77.0 11:24:44 INFO - PROCESS | 29700 | -------- Summary: end -------- 11:24:44 INFO - PROCESS | 29700 | 11:24:45 INFO - TEST-INFO | 29700: exit 0 11:24:45 INFO - TEST-OK | kraken | took 61603ms 11:24:45 INFO - SUITE-END | took 1177s 11:24:45 INFO - Completed test suite (00:19:37) 11:24:45 INFO - javascript benchmark 11:24:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7354.764604074357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.9666503334965, 3346.5649465569486, 3362.882299119531, 3372.460406334986, 3374.0889959710894, 5532.28080349554, 5705.343885453169, 5705.457981491757, 5754.338251101125, 5775.56683248756, 5499.450054994509, 5605.411431799654, 5606.859828504289, 5627.774889004445, 5640.858978525529, 5093.439721630609, 5108.4636113208135, 5129.717865517395, 5131.3329267195395, 5200.08998425276, 5222.164453687411, 5223.399309079447, 5225.085610018251, 5228.764705588258, 5256.710880901549, 5211.661242019257, 5213.713245771481, 5214.687118772867, 5223.791048358061, 5228.686278823283, 5217.58259339252, 5220.190870415073, 5222.817201397971, 5228.660137091115, 5229.37247530295, 5017.172166592508, 5142.460041695643, 5144.382674079135, 5148.304978827848, 5203.19350500673, 4686.414198225222, 5645.604807663465, 5691.943080569183, 5729.512991395736, 5831.5334773218465, 5829.446202610788, 5991.820245392645, 6011.068284415923, 6191.226096737908, 6231.3145553989025, 6078.969605151946, 6102.359252278536, 6124.11200375943, 6140.907886381708, 6196.163517925068, 5903.144044113666, 5907.497862681677, 5911.438413350725, 5916.49709774674, 5939.554533410012, 6259.906101408483, 6264.091706702594, 6277.0, 6277.905831412532, 6289.842753931189, 5944.197533333031, 5994.37059108796, 6016.8796624068145, 6091.14723938649, 6120.632762034292, 6037.09443583466, 6229.2524897012645, 6247.5939063960695, 6263.592866463665, 6271.623702577769, 6192.442680158807, 6195.132681424604, 6204.3795620437595, 6223.439890409885, 6228.781992630236, 5925.881482370329, 6029.909551356734, 6236.875262494725, 6237.719302631393, 6241.344658810759, 4920.6801557898625, 4950.777215025332, 4973.35346404965, 4979.253112033224, 5046.9747651261505, 3726.2547490502006, 4310.741355518679, 4345.630621397154, 4388.034632380871, 4406.030673251879, 5715.885682286331, 5740.483356497935, 5747.3103227612955, 5781.624194427349, 5801.535877129904, 5825.097109947965, 5876.471117599351, 6181.289151747606, 6263.0, 6278.748850046039, 5705.857353566111, 5716.971415142898, 5754.165645981309, 5836.562257830679, 5856.970715146397, 4760.928586071212, 5230.503102205284, 5460.0, 5479.205515200274, 5497.340319161726, 6120.355709576858, 6290.622562646256, 6292.685365731695, 6328.0, 6344.333844946306, 4861.829835955725, 6083.087536869328, 6160.537959652955, 6232.065190221503, 6233.438990490878, 6187.690615469299, 6249.593776404519, 6249.875002500015, 6251.6561589113035, 6251.71867265965, 6114.266288045463, 6133.110698948717, 6138.57030007913, 6185.721642526007, 6203.16257305258, 5955.106733989936, 6092.329843717099, 6121.452973576081, 6124.19785563378, 6128.900367973304, 6004.699765011819, 6056.303525094494, 6069.119977603311, 6108.267007958895, 6129.632222066691, 6064.241969753781, 6064.848378790389, 6067.969660151671, 6068.757249709962, 6069.484093852072, 5449.809256675997, 5809.8547536311935, 5813.651180929158, 5864.853378665397, 5877.118432235199, 6103.0, 6112.755489780359, 6117.235345581802, 6140.263168419819, 6142.3550527194, 5923.822285331447, 5971.462568368867, 5971.492423144082, 5972.25346831646, 5986.102084687158], "value": 5650.686253131947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.93952816369784, 488.1822946564508, 498.95220037920393, 520.2326568311738, 541.385527426371, 33267.66732332676, 40960.79519602405, 40994.59005409945, 41069.0, 41080.79459602705, 41803.0, 42574.0, 42637.57362426375, 42654.0, 42778.0, 7845.333146682538, 9055.909440905605, 9381.5309234538, 9386.436813791195, 9433.575489103006, 7784.571848548328, 10915.836262456069, 11217.383043932581, 11230.0, 11354.318740875533, 11074.723131921686, 11092.112630989543, 11102.6114086007, 11136.0, 11181.888181118207, 11128.165387595922, 11189.0, 11230.270032447865, 11239.831402528927, 11242.94378528102, 11022.338659680445, 11100.056495197918, 11115.555377784878, 11123.0, 11125.388103654295, 39934.800325998185, 40144.39783403251, 40225.19549609021, 40230.79884600588, 40340.193196135915, 4002.4396584478195, 4016.5782592827622, 4052.946233979157, 4089.652379547742, 4157.625813676784, 30003.399932001455, 30282.69717302821, 30295.848520757474, 30482.54276185859, 30593.541096883564, 3054.5876306698756, 3174.68253174683, 3190.5533225348468, 3283.0807373935336, 3285.78642388244, 452500.0, 454557.0, 454945.0, 455369.0, 457260.7136964327, 50913.23630145551, 52095.479045209824, 60728.69635651882, 61032.69483652553, 61070.694646526485, 71746.0, 72199.0, 73019.2698073023, 73165.0, 73592.63203683947, 13634.113782604298, 15615.765763513557, 15783.763243551355, 16133.467320604525, 16164.949278296874, 11361.0, 11381.54473821038, 12080.335581543099, 12083.972862306626, 12256.264624122581, 18714.0, 19568.608627827365, 20518.58962820735, 21039.05324260412, 21092.47268818261, 6494.318096599789, 7315.0, 8207.932968714029, 8884.64461421549, 8930.553472326357, 840.810817566055, 858.592168719853, 861.388414225894, 871.1462766488877, 877.5656050255037, 29456.705432945397, 30189.698103019127, 30222.79108835666, 30255.546166807515, 30836.383272334875, 935.1957316707626, 952.2058275394165, 1016.9847452288221, 1061.771719080386, 1130.9208355415205, 15640.3743850247, 15676.0, 15760.369585216464, 15947.44183953556, 15955.840441595668, 554911.0, 589422.0, 615014.0, 620951.0, 621534.0, 59003.11495327573, 59652.0, 59661.70169149127, 59713.40286597165, 59792.40207597955, 1083.8374243863484, 1421.7156568686305, 1425.600831767107, 1435.2751860310477, 1436.2387934394578, 28725.56911646285, 29117.708822912347, 29717.257068573457, 30156.396872062876, 30192.09423717204, 49809.25286120638, 50055.0, 50145.498545015544, 50249.24626130538, 50466.0, 520991.0, 523545.0, 525703.6003739851, 526824.0, 529397.0, 25766.87116564405, 26396.208113756617, 26540.734592653826, 27362.589561156998, 41102.0, 40651.796741017286, 41081.38377924393, 41749.58250417457, 42065.78967105145, 42085.36871946984, 34046.82976585101, 34548.0, 34586.82706586451, 34799.65200347964, 35538.64461355354, 27894.3026424341, 34070.0, 34109.0, 34830.9550713479, 35015.64984350226, 32838.507422388204, 33737.325253495284, 33999.66000340064, 34247.48628770521, 34269.48595771116, 29338.11985640434, 30340.696593033786, 30469.847650761603, 30566.541501877044, 30758.692413075583, 17311.91344043322, 22676.433089172904, 23504.764952350943, 23568.0, 23640.88179559091], "value": 19816.271374604843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.77006290816604, 398.2135282816438, 398.356654003784, 407.8001779128228, 437.4903237728047, 13008.93495532521, 19758.80241197586, 19958.201671933104, 20362.6945595816, 21180.470488237803, 20876.89561552194, 21074.051667674954, 21107.47231319218, 21287.25494607689, 21328.8933555332, 5405.810796622119, 5707.258056452676, 5760.0, 5783.884322313551, 5791.710414479259, 5653.773849046033, 5746.195532625415, 5810.912836307459, 5851.502622277111, 5861.062230043194, 5800.042992906166, 5853.385394533577, 5870.412958704117, 5873.530117590604, 5882.088276317178, 5293.497117773805, 5505.091659876116, 5859.941400585983, 5864.853378665525, 5881.85295367615, 4248.978755106235, 4376.540463251376, 4864.854054378339, 5044.243363495469, 5070.645054846163, 24873.378165545826, 24896.626550601755, 25074.997000119973, 25363.266855082697, 25986.0, 3026.8183908965534, 3064.9693503064905, 3085.1670049086847, 3090.536419537065, 3166.0, 12455.626331210078, 15321.233938303152, 15325.46360877375, 15407.768883466644, 16098.919505402398, 1835.6971099768523, 1853.6570734414177, 1888.518427800902, 1985.7319261899604, 1997.1512107354317, 142464.0, 146174.0, 147778.52221477756, 149292.01415971728, 152066.7189992151, 9732.805343893082, 11730.941345293219, 11741.882581174079, 11936.164468487295, 12073.396330183456, 13816.37826297819, 14340.56978290653, 15673.216339182994, 15687.215639217993, 15702.293396797171, 7528.698852045857, 7973.641186146638, 8306.833863322821, 8325.625346859406, 8405.0, 8025.077116131602, 8095.3523718102415, 8144.30773384269, 8239.423240373117, 8243.464174828738, 4730.787114579852, 4784.827717209306, 4818.0, 4874.123462466976, 4917.729524876167, 1600.903945763258, 1680.2606852984648, 1806.5393324702118, 1912.6652835753966, 2065.1842522203647, 969.8448248280241, 1013.5692330759398, 1032.7573020340214, 1039.719275795531, 1072.790805792863, 20260.797392026187, 20304.796952030585, 20551.4862128445, 20670.689939650918, 20694.068766905526, 949.620151939216, 1037.7353774787382, 1039.8908114648004, 1056.8890266522058, 1074.9355038697547, 9125.224355929688, 10592.981000414844, 10918.836217456745, 10931.617393391192, 10939.890601094046, 618324.0, 641541.0, 705861.0604204705, 721173.3941330365, 723898.0, 138721.30639346738, 140301.59698402885, 143537.0, 144354.0, 144885.0, 1008.8083264179783, 1014.3254735600743, 1034.813733527957, 1038.7299302181486, 1041.9840655360963, 15299.61750956235, 17162.71279654006, 17651.0, 18412.539686507407, 18668.906655466635, 46469.3029604563, 51879.0, 52981.47018529919, 53728.194077089654, 54239.18641220464, 81383.18616813756, 81690.0, 83096.58451707703, 83675.5816220915, 84152.57923710588, 8332.708355207538, 11948.581799636971, 12275.140740148105, 12645.87354126447, 12981.480740770263, 11234.494447749707, 12737.93631031876, 13626.454941802216, 13661.590152295446, 14123.788143177655, 11555.653330400102, 11555.653330400102, 11611.593594224161, 12028.939855300667, 12045.578404755792, 9627.711168664951, 11222.887771122185, 11699.590514331958, 11902.940485297519, 11909.22590031645, 10562.31344962575, 11701.654309754487, 11835.526578936746, 12057.939710301393, 12079.51681932713, 12591.0, 12631.684207894876, 12940.741185176055, 13010.284434356201, 13025.153365031243, 11777.646670599554, 12032.0, 12093.637190884288, 12125.939370303093, 12149.453274602487], "value": 10142.079437178261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.7783576791944, 1436.4541474239788, 1453.1281231261244, 1478.4603619678817, 1479.4599971010584, 7649.196834332399, 7842.8039299017555, 8377.83244335113, 8921.286297096232, 8937.704032915231, 8290.046644635868, 8611.181937715906, 8639.222469977702, 8784.297256219503, 8813.38306318558, 2308.6421604651264, 2310.2260742651233, 2338.2634470141934, 2339.87130707811, 2346.530693861226, 2017.243533674872, 2104.1478201328487, 2281.8744969026698, 2311.630139177732, 2323.2101085630884, 1859.6001859600183, 2241.6301310283784, 2313.8727369994645, 2325.1513197682893, 2333.56828986638, 2287.79409853114, 2287.805536529397, 2305.642625393075, 2314.1900334882826, 2316.027268547214, 2286.965695514569, 2338.5089131282452, 2346.1084787780533, 2364.8817559121976, 2367.419982104378, 8781.077986811357, 8796.8680469793, 8855.24730397917, 8872.55637218143, 8903.688370907052, 5250.0, 5383.43473935235, 5391.541718953855, 5394.0, 5401.405845357008, 2975.3008043109853, 3520.295940811822, 3559.199180184464, 3610.277944411102, 3641.617630148849, 1204.9578264760692, 1216.4282787090053, 1233.4387853526623, 1253.0351629245522, 1275.330451512954, 10917.727056823564, 11270.605528806453, 11490.942545287304, 11595.884041159648, 11626.593069242535, 3917.7845218513257, 4470.977645111753, 4792.448868380111, 4798.064377446364, 4822.807087716452, 9849.261305402124, 9965.0, 9996.150327222267, 9996.700098997042, 10010.149137323264, 5305.495977882095, 5361.490658387447, 5385.865353366119, 5386.865328366822, 5390.137577987582, 4743.905121897543, 4899.853004409873, 4929.433115191799, 4933.679310844784, 4962.082014827269, 3882.475865758143, 3899.6100389960775, 3964.4053391991433, 3978.8010599469912, 4011.8194681239415, 1140.321508702321, 1176.452949378543, 1311.3508813137366, 1317.2425855133338, 1328.1566205459603, 678.7217240931194, 719.453215556181, 745.5638451505821, 808.7007807111289, 858.4248553469191, 4325.675574331937, 5643.322801263793, 5859.2090067841145, 5901.734421951022, 5961.344252132262, 864.567716141929, 878.1789027259405, 988.5847943863595, 999.8700168978132, 1005.6279176704666, 3801.733878628525, 3840.7887566183567, 3845.5000849889334, 3887.922241555153, 3929.842806287774, 9946.353487023465, 10425.165986721044, 10444.373337599769, 10460.058594726512, 10493.108085812639, 10397.48012599367, 10408.47957602117, 10432.791344173074, 10445.477726113664, 10459.372437653765, 8068.798280042928, 8109.3917956152345, 8168.264856162974, 8200.58997050145, 8202.38482113844, 4702.52974702527, 5494.066008778437, 5662.971685141548, 5748.511376532874, 5753.539716822728, 8917.509536975529, 9192.632294708405, 9548.522573871418, 9551.235901128031, 9554.378965367228, 9188.49463279526, 9548.761280967754, 9629.133377996013, 9650.758731031781, 9653.855192171983, 7385.778426647209, 7507.0, 7542.396608271435, 7547.132079810673, 7568.281013303727, 8131.186881311822, 8160.755177344689, 8199.672013119647, 8215.178482151738, 8221.0, 7283.963580182065, 7289.744858929912, 7410.777676669709, 7448.106227252764, 7528.887066694114, 7271.054762880792, 7327.120745510573, 7343.8531229376185, 7373.594452305175, 7383.409327253699, 6464.709088090953, 6536.444402225864, 6551.279359270381, 6613.10723052401, 6627.403533681992, 5061.392632884077, 5092.083424983539, 5137.998090372342, 5152.201408781645, 5268.894622107613, 5088.491150884882, 5092.287079808903, 5097.413797413196, 5227.686338819683, 5326.680399176062], "value": 4502.138231094007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5399923096515, 368.11835653609603, 378.8257401595266, 379.20934850836005, 381.4088163346814, 4901.460839307673, 5209.322788037554, 5607.383187849344, 5616.971915140419, 5711.0, 4533.523979982104, 4579.862604121873, 5377.462253774621, 5412.864678383033, 5450.182472629108, 3673.779573225602, 4164.604362585549, 4164.729292595972, 4181.142865712529, 4187.413762073312, 3968.603139686037, 4025.4565633639522, 4140.213359461693, 4165.770882601456, 4190.937135942948, 3187.5696780934627, 3892.7884495291355, 3922.3920292354733, 4116.8970775730695, 4117.538273912763, 4100.8974775630695, 4113.9303781017, 4126.607972242632, 4150.896227594304, 4175.958240417587, 3416.1118109291515, 3584.301061293049, 3586.946195807065, 3599.3161299353037, 3623.4202527595457, 5143.459936706629, 5189.870253243699, 5309.41596424393, 5353.678779273256, 5408.648437851527, 3834.9041273968096, 4283.957160428387, 4462.419885414875, 4712.787924543404, 4721.457032441279, 4808.422989241279, 5762.501749545107, 5773.884522309572, 5780.595358324919, 5788.88422231553, 3580.15866271426, 3685.4287585424304, 3758.4926034985474, 3786.0, 3908.9413658795143, 5248.766539863129, 5414.7834086636485, 5670.291213598301, 5939.406059394069, 5959.791407300767, 3572.9281215635206, 3885.589855514012, 3979.9503255823274, 4004.739691920016, 4005.499312585927, 4045.9797701011894, 4064.4309796628495, 4081.856915231043, 4084.121304200042, 4084.9795751021647, 3965.3655415134017, 4484.529124441887, 4770.308305295713, 4772.665913386029, 4802.903941921142, 4883.926741098886, 5141.408737995179, 5525.231925783711, 5713.514351280104, 5828.154917536934, 1219.3842109734528, 1307.235267368581, 1311.8294621699117, 1313.8686131386976, 1315.894728421724, 795.5306369242174, 800.7068584236532, 823.8517066927891, 894.6421431427481, 899.8796498359453, 5080.695158290514, 5105.013567063235, 5115.948840511547, 5126.564242039394, 5129.615278854027, 4764.475907650156, 5174.689518628819, 5381.78472861089, 5676.460736230051, 5703.800366987136, 4153.460050193456, 4708.364370809965, 4749.88630059627, 4790.065937142223, 5097.0, 2564.6153077038593, 2648.933776655599, 2760.4617099665775, 2932.4634191424266, 2991.8331850578293, 5448.83653490396, 5558.805441809517, 5661.575381846378, 5763.625364351387, 5944.405559444021, 5121.436641969381, 5162.896742065138, 5809.153514777729, 5853.536615846038, 5878.177055212273, 5897.941020589739, 5909.468147866713, 5928.251165906068, 5935.080062590306, 5952.285725713029, 5304.230886521355, 5691.008147148465, 5692.373838877803, 5742.36342642345, 5750.25246717924, 5008.520782212682, 5054.949450505448, 5208.932168905441, 5610.85972850682, 5662.734906037618, 5732.646401854795, 5836.941630583639, 5955.851103722442, 6014.548908831943, 6036.034234522455, 3888.241792850367, 3961.0, 3968.940465892956, 3979.422983667294, 4018.7789671568344, 5133.409657889241, 5174.922376164436, 5307.124324486416, 5655.406182350794, 5904.498117660047, 5248.291480650063, 5568.220449137205, 5802.854928626818, 5857.414258574279, 5869.354371019099, 4693.436787585511, 4953.653244272867, 5310.495502927216, 5332.706701131475, 5368.597355198453, 5027.371578552681, 5090.880006398586, 5523.696196709219, 5648.293963254593, 5738.454846789548, 5404.297441332602, 5404.703001224542, 5464.251439539468, 5821.301443826768, 5863.17915491823, 5190.079670521931, 5453.300616195009, 5751.9424805751405, 5754.338251101177, 5767.596268261182], "value": 4124.747329420118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2294053600506, 712.5404114346244, 760.0233699695892, 809.4954310687326, 812.939029572782, 14522.854771452283, 15556.299966501507, 17597.296108155657, 17640.206190721416, 17658.82341176588, 16468.01191928485, 16538.917305413484, 16643.16784160793, 16655.25051372688, 16702.83297167028, 858.3176374782032, 863.3093525179862, 879.6833140069601, 881.4006475596592, 881.8853549038616, 868.0364795077459, 883.4919921045392, 886.7517095213351, 892.5091199840094, 893.7006102955485, 932.2448816458656, 932.8460803967337, 935.5556110847361, 935.957881895313, 936.0686117313248, 915.1351972386097, 925.181214625055, 927.1562877781221, 927.4481683398435, 928.6656803550717, 671.3722669304167, 680.2653134614604, 692.6121372031679, 695.9652017399161, 697.135551915626, 15681.529554113395, 15899.0, 15988.920055399765, 16133.515994520183, 16320.75518867218, 11920.642380728592, 13585.456581736718, 14131.505397311044, 14403.0, 14433.422663093568, 11567.942160289229, 11662.941685291604, 11758.17692761507, 12069.939650301692, 12341.753164936741, 3641.2717456508803, 3682.1346983458866, 3684.2631473705096, 3705.4997575327257, 3845.288621605012, 113100.43449782781, 114336.4283178587, 115620.42189789082, 115990.42004789921, 117075.0, 10645.92943895904, 10857.402842843561, 10858.914108589235, 10991.450427478594, 11057.612983545538, 22589.774102259096, 22623.20818771335, 22836.31491055271, 22914.198003070145, 22939.42651433694, 7420.369268612229, 7422.294881986203, 7431.479796414307, 7432.0, 7667.808304792425, 4068.4914385701786, 4149.149424367997, 4149.2738770715005, 4153.1518474278655, 4157.355609880473, 3550.6626870447267, 3623.2753449310244, 3652.6712595866497, 3661.41417373219, 3665.651763082503, 652.1228947066188, 658.6739563915893, 662.8731157033063, 663.8207683925409, 668.0680450771147, 661.8742438936587, 699.9440044796404, 703.2580627438102, 706.9681864316016, 732.2311572848488, 8490.186635155345, 8948.926128864448, 9862.408255504693, 9884.55519501624, 10466.11038061758, 580.7096451774113, 639.7792761497276, 666.4967949198324, 672.7241830849329, 675.4528831646383, 4456.598906098467, 4474.679210455812, 4546.29532422475, 4761.098439196385, 4900.166971614834, 80137.0, 85504.57247713722, 104762.0, 106260.93739062666, 108943.45528272308, 66429.0, 90927.63608545877, 91799.62300565497, 92002.16251605842, 92057.539712301, 58098.7095064522, 60169.097463538084, 66025.66987165033, 66392.67625633176, 68440.63118737597, 9090.681826136053, 10013.468582419438, 10883.510242038968, 11022.724431888946, 11071.612493562687, 38783.612163878, 44272.55727442684, 45407.0, 45678.77160614176, 47501.04997900092, 56893.0, 59045.40954590399, 59611.403885960586, 60299.39700602938, 60580.091298629675, 12793.61619151427, 12896.226226426445, 13007.804882926574, 13449.0, 13521.0, 14342.713145737236, 14689.41242350294, 14743.041702289316, 15141.621459463602, 15298.005629634039, 13464.461421543028, 13564.498297001239, 13681.14732932105, 13765.739867343136, 14101.365438555495, 13400.865991340352, 13597.320133993459, 13646.590602281947, 13661.18032918028, 14062.929685351917, 11187.608433705107, 13504.054716169774, 13650.317484125953, 13900.304984750925, 14090.225037622618, 10572.41851698164, 10986.230963832455, 11025.393603351893, 11187.944060279971, 11631.302121872715, 9538.380005299634, 10206.285560010729, 10553.526159251029, 10711.979575415258, 10760.085392741705], "value": 7504.114158083735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 116.0, 117.0, 117.0, 116.0, 118.0, 118.0, 131.0, 173.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 115.0, 155.0, 118.0, 115.0, 114.0, 113.0, 137.0, 115.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 207.0, 215.0, 219.0, 196.0, 203.0, 195.0, 197.0, 196.0, 193.0], "value": 205.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 88.0, 63.0, 61.0, 58.0, 50.0, 70.0, 54.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 85.0, 71.0, 76.0, 69.0, 82.0, 69.0, 72.0, 84.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 131.0, 89.0, 86.0, 88.0, 101.0, 90.0, 90.0, 89.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 120.0, 151.0, 122.0, 100.0, 151.0, 151.0, 96.0, 97.0], "value": 118.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 79.0, 143.0, 93.0, 93.0, 93.0, 93.0, 86.0, 92.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 72.0, 77.0, 98.0, 101.0, 98.0, 75.0, 65.0], "value": 77.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 85.0, 73.0, 88.0, 79.0, 77.0, 70.0, 79.0, 106.0, 107.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 87.0, 88.0, 85.0, 113.0, 87.0, 88.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 163.0, 153.0, 137.0, 138.0, 138.0, 150.0, 141.0, 190.0, 141.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 172.0, 176.0, 238.0, 238.0, 174.0, 187.0, 235.0, 168.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 70.0, 83.0, 60.0, 77.0], "value": 69.3, "unit": "score"}]}]} 11:24:45 INFO - Return code: 0 11:24:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:24:45 ERROR - # TBPL SUCCESS # 11:24:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:24:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:24:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:24:45 INFO - 2017-02-03 11:24:45.653 screenresolution[29705:275312] starting screenresolution argv=screenresolution get 11:24:45 INFO - 2017-02-03 11:24:45.655 screenresolution[29705:275312] Display 0: 1600x1200x32@60 11:24:45 INFO - 2017-02-03 11:24:45.662 screenresolution[29706:275315] starting screenresolution argv=screenresolution list 11:24:45 INFO - Available Modes on Display 0 11:24:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:24:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:24:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:24:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:24:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:24:45 INFO - Intel Iris: 11:24:45 INFO - Chipset Model: Intel Iris 11:24:45 INFO - Type: GPU 11:24:45 INFO - Bus: Built-In 11:24:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:24:45 INFO - Vendor: Intel (0x8086) 11:24:45 INFO - Device ID: 0x0a2e 11:24:45 INFO - Revision ID: 0x0009 11:24:45 INFO - Displays: 11:24:45 INFO - Display: 11:24:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:24:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:24:45 INFO - Display Serial Number: 1600x1200 60 11:24:45 INFO - Main Display: Yes 11:24:45 INFO - Mirror: Off 11:24:45 INFO - Online: Yes 11:24:45 INFO - Rotation: Supported 11:24:45 INFO - Return code: 0 11:24:45 INFO - Running post-action listener: _resource_record_post_action 11:24:45 INFO - [mozharness: 2017-02-03 19:24:45.905836Z] Finished run-tests step (success) 11:24:45 INFO - Running post-run listener: _resource_record_post_run 11:24:45 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32116736; Write bytes: 556544512; Read time: 295; Write time: 1956 11:24:45 INFO - TinderboxPrint: CPU usage
54.4% 11:24:45 INFO - TinderboxPrint: I/O read bytes / time
32,116,736 / 295 11:24:45 INFO - TinderboxPrint: I/O write bytes / time
556,544,512 / 1,956 11:24:45 INFO - TinderboxPrint: CPU idle
2,189.4 (45.6%) 11:24:45 INFO - TinderboxPrint: CPU system
964.6 (20.1%) 11:24:45 INFO - TinderboxPrint: CPU user
1,647.7 (34.3%) 11:24:45 INFO - TinderboxPrint: Swap in / out
278,179,840 / 0 11:24:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245944832; Write bytes: 238608384; Read time: 17935; Write time: 440 11:24:45 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31842304; Write bytes: 302510592; Read time: 291; Write time: 1417 11:24:46 INFO - Running post-run listener: _upload_blobber_files 11:24:46 INFO - Blob upload gear active. 11:24:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:24:46 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 11:24:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:24:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:24:46 INFO - (blobuploader) - INFO - Open directory for files ... 11:24:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:24:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:24:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:47 INFO - (blobuploader) - INFO - Done attempting. 11:24:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:24:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:24:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:48 INFO - (blobuploader) - INFO - Done attempting. 11:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:49 INFO - (blobuploader) - INFO - Done attempting. 11:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:24:51 INFO - (blobuploader) - INFO - Done attempting. 11:24:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:24:51 INFO - Return code: 0 11:24:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:24:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:24:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28728e24eebdc46c926fdcb90e52df2106411bf21a6a49d12dde05f2ae38c64b51e388091ad6fb32a8147b7ad2963471a69c6b9018d65263815d00c71d064ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3937d165470de8a4137a544219f1e0de135a99d26b8b04d010cd8b9053a5a1bcd13a26a3b9f48ceb372ccffc2161efce4e82605838c6f41d99388a701284b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67b60a6f56620d0b791ebe2be687088ce57ea6c2ffef4a44739330bbc5ce3cf5cdf8a849787b25ad409d8b52c1676bd82dd387ef0f1c84daf60f30eed5e471c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86571eabe9b5babd6983d4e9bc4c6f226ee96401b35d5dc92b2d2a065e73aff7532bf0af94930bbaf3bf4dfec7ebe57c5178b2ddb0f463e84a9a78d40dd07c43"} 11:24:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:24:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:24:51 INFO - Contents: 11:24:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28728e24eebdc46c926fdcb90e52df2106411bf21a6a49d12dde05f2ae38c64b51e388091ad6fb32a8147b7ad2963471a69c6b9018d65263815d00c71d064ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3937d165470de8a4137a544219f1e0de135a99d26b8b04d010cd8b9053a5a1bcd13a26a3b9f48ceb372ccffc2161efce4e82605838c6f41d99388a701284b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67b60a6f56620d0b791ebe2be687088ce57ea6c2ffef4a44739330bbc5ce3cf5cdf8a849787b25ad409d8b52c1676bd82dd387ef0f1c84daf60f30eed5e471c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86571eabe9b5babd6983d4e9bc4c6f226ee96401b35d5dc92b2d2a065e73aff7532bf0af94930bbaf3bf4dfec7ebe57c5178b2ddb0f463e84a9a78d40dd07c43"} 11:24:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:24:51 INFO - Copying logs to upload dir... 11:24:51 INFO - mkdir: /builds/slave/test/build/upload/logs 11:24:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.919886 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-03 11:24:52.316908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 11:24:52.320622) ========= 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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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/Firefox/sha512/e28728e24eebdc46c926fdcb90e52df2106411bf21a6a49d12dde05f2ae38c64b51e388091ad6fb32a8147b7ad2963471a69c6b9018d65263815d00c71d064ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3937d165470de8a4137a544219f1e0de135a99d26b8b04d010cd8b9053a5a1bcd13a26a3b9f48ceb372ccffc2161efce4e82605838c6f41d99388a701284b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67b60a6f56620d0b791ebe2be687088ce57ea6c2ffef4a44739330bbc5ce3cf5cdf8a849787b25ad409d8b52c1676bd82dd387ef0f1c84daf60f30eed5e471c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86571eabe9b5babd6983d4e9bc4c6f226ee96401b35d5dc92b2d2a065e73aff7532bf0af94930bbaf3bf4dfec7ebe57c5178b2ddb0f463e84a9a78d40dd07c43"} build_url:https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/SYwbvFnORjqMGoXPELwYMQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e28728e24eebdc46c926fdcb90e52df2106411bf21a6a49d12dde05f2ae38c64b51e388091ad6fb32a8147b7ad2963471a69c6b9018d65263815d00c71d064ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3937d165470de8a4137a544219f1e0de135a99d26b8b04d010cd8b9053a5a1bcd13a26a3b9f48ceb372ccffc2161efce4e82605838c6f41d99388a701284b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67b60a6f56620d0b791ebe2be687088ce57ea6c2ffef4a44739330bbc5ce3cf5cdf8a849787b25ad409d8b52c1676bd82dd387ef0f1c84daf60f30eed5e471c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86571eabe9b5babd6983d4e9bc4c6f226ee96401b35d5dc92b2d2a065e73aff7532bf0af94930bbaf3bf4dfec7ebe57c5178b2ddb0f463e84a9a78d40dd07c43"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 11:24:52.417027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:24:52.417355) ========= 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.whkGWXU9YQ/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.FlhrmZLT1Z/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005258 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:24:52.446650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 11:24:52.447407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 11:24:52.448133) ========= ========= Total master_lag: 0.52 =========