builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1486140882.84 results: success (0) buildid: 20170203071808 builduid: 2c72ceb435c043a7ad8d1e39135e1bc8 revision: 38f8808782c3209051b97de2ae3ea8c6a535e01a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:42.838381) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:42.838811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:42.839081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:42.864995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:42.865343) ========= 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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:54:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2017-02-03 08:54:43 (15.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:43.029729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:43.030035) ========= 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.SLQxpIkaIY/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.GSFuDyE4h2/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.028098 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:43.079985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 08:54:43.080343) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38f8808782c3209051b97de2ae3ea8c6a535e01a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38f8808782c3209051b97de2ae3ea8c6a535e01a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SLQxpIkaIY/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.GSFuDyE4h2/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 08:54:43,182 truncating revision to first 12 chars 2017-02-03 08:54:43,182 Setting DEBUG logging. 2017-02-03 08:54:43,182 attempt 1/10 2017-02-03 08:54:43,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/38f8808782c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 08:54:44,447 unpacking tar archive at: mozilla-aurora-38f8808782c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.699839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 08:54:44.803258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:44.803577) ========= script_repo_revision: 38f8808782c3209051b97de2ae3ea8c6a535e01a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:44.803952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:44.804212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 08:54:44.823536) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 08:54:44.823803) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SLQxpIkaIY/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.GSFuDyE4h2/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 08:54:45 INFO - MultiFileLogger online at 20170203 08:54:45 in /builds/slave/test 08:54:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:54:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:45 INFO - {'append_to_log': False, 08:54:45 INFO - 'base_work_dir': '/builds/slave/test', 08:54:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:54:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:45 INFO - 'branch': 'Mozilla-Aurora', 08:54:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:45 INFO - 'config_files': ('talos/mac_config.py',), 08:54:45 INFO - 'default_actions': ('clobber', 08:54:45 INFO - 'read-buildbot-config', 08:54:45 INFO - 'download-and-extract', 08:54:45 INFO - 'populate-webroot', 08:54:45 INFO - 'create-virtualenv', 08:54:45 INFO - 'install', 08:54:45 INFO - 'run-tests'), 08:54:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:45 INFO - 'download_minidump_stackwalk': True, 08:54:45 INFO - 'download_symbols': 'ondemand', 08:54:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:45 INFO - 'installer_path': 'installer.exe', 08:54:45 INFO - 'log_level': 'info', 08:54:45 INFO - 'log_name': 'talos', 08:54:45 INFO - 'log_to_console': True, 08:54:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:54:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:54:45 INFO - 'opt_config_files': (), 08:54:45 INFO - 'pip_index': False, 08:54:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:54:45 INFO - 'cmd': ('bash', 08:54:45 INFO - '-c', 08:54:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:54:45 INFO - 'enabled': True, 08:54:45 INFO - 'halt_on_failure': False, 08:54:45 INFO - 'name': 'check_screen_resolution'},), 08:54:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:54:45 INFO - 'cmd': ('bash', 08:54:45 INFO - '-c', 08:54:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:54:45 INFO - 'enabled': True, 08:54:45 INFO - 'halt_on_failure': False, 08:54:45 INFO - 'name': 'check_screen_resolution'},), 08:54:45 INFO - 'run_cmd_checks_enabled': True, 08:54:45 INFO - 'sps_profile': False, 08:54:45 INFO - 'sps_profile_interval': 0, 08:54:45 INFO - 'suite': 'dromaeojs-e10s', 08:54:45 INFO - 'system_bits': '32', 08:54:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:45 INFO - 'title': 't-yosemite-r7-0009', 08:54:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:45 INFO - 'use_talos_json': True, 08:54:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:45 INFO - 'work_dir': 'build'} 08:54:45 INFO - [mozharness: 2017-02-03 16:54:45.040314Z] Running clobber step. 08:54:45 INFO - Running pre-action listener: _resource_record_pre_action 08:54:45 INFO - Running main action method: clobber 08:54:45 INFO - rmtree: /builds/slave/test/build 08:54:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:47 INFO - Running post-action listener: _resource_record_post_action 08:54:47 INFO - [mozharness: 2017-02-03 16:54:47.574814Z] Finished clobber step (success) 08:54:47 INFO - [mozharness: 2017-02-03 16:54:47.574935Z] Running read-buildbot-config step. 08:54:47 INFO - Running pre-action listener: _resource_record_pre_action 08:54:47 INFO - Running main action method: read_buildbot_config 08:54:47 INFO - Using buildbot properties: 08:54:47 INFO - { 08:54:47 INFO - "project": "", 08:54:47 INFO - "product": "firefox", 08:54:47 INFO - "script_repo_revision": "production", 08:54:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:54:47 INFO - "repository": "", 08:54:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:54:47 INFO - "buildid": "20170203071808", 08:54:47 INFO - "pgo_build": "False", 08:54:47 INFO - "basedir": "/builds/slave/test", 08:54:47 INFO - "buildnumber": 36, 08:54:47 INFO - "slavename": "t-yosemite-r7-0009", 08:54:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:54:47 INFO - "platform": "yosemite_r7", 08:54:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:54:47 INFO - "branch": "mozilla-aurora", 08:54:47 INFO - "repo_path": "releases/mozilla-aurora", 08:54:47 INFO - "revision": "38f8808782c3209051b97de2ae3ea8c6a535e01a", 08:54:47 INFO - "stage_platform": "macosx64", 08:54:47 INFO - "builduid": "2c72ceb435c043a7ad8d1e39135e1bc8", 08:54:47 INFO - "slavebuilddir": "test" 08:54:47 INFO - } 08:54:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:54:47 INFO - Running post-action listener: _resource_record_post_action 08:54:47 INFO - [mozharness: 2017-02-03 16:54:47.578567Z] Finished read-buildbot-config step (success) 08:54:47 INFO - [mozharness: 2017-02-03 16:54:47.578710Z] Running download-and-extract step. 08:54:47 INFO - Running pre-action listener: _resource_record_pre_action 08:54:47 INFO - Running main action method: download_and_extract 08:54:47 INFO - mkdir: /builds/slave/test/build/tests 08:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:47 INFO - trying https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:54:47 INFO - Downloading https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:54:48 INFO - Downloaded 1199 bytes. 08:54:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:54:48 INFO - Using the following test package requirements: 08:54:48 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:54:48 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:54:48 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:54:48 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'jsshell-mac.zip'], 08:54:48 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:54:48 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:54:48 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:54:48 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:54:48 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:54:48 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:54:48 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:54:48 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:54:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:54:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:54:48 INFO - Fetch https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:54:49 INFO - Expected file size: 16356338 08:54:49 INFO - Obtained file size: 16356338 08:54:56 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:54:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:54:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:54:56 INFO - Fetch https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:54:57 INFO - Expected file size: 16356338 08:54:57 INFO - Obtained file size: 16356338 08:55:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:55:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:55:03 INFO - Fetch https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:55:04 INFO - Expected file size: 14403485 08:55:04 INFO - Obtained file size: 14403485 08:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:05 INFO - trying https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:55:05 INFO - Downloading https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:55:07 INFO - Downloaded 73831408 bytes. 08:55:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:55:07 INFO - mkdir: /builds/slave/test/properties 08:55:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:07 INFO - Contents: 08:55:07 INFO - build_url:https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:55:07 INFO - Running post-action listener: _resource_record_post_action 08:55:07 INFO - Running post-action listener: set_extra_try_arguments 08:55:07 INFO - [mozharness: 2017-02-03 16:55:07.809642Z] Finished download-and-extract step (success) 08:55:07 INFO - [mozharness: 2017-02-03 16:55:07.809752Z] Running populate-webroot step. 08:55:07 INFO - Running pre-action listener: _resource_record_pre_action 08:55:07 INFO - Running main action method: populate_webroot 08:55:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:07 INFO - '--tppagecycles', 08:55:07 INFO - '7'], 08:55:07 INFO - 'tests': ['tsvgm']}}, 08:55:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['damp', 'tps']}, 08:55:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'tests': ['damp', 'tps']}, 08:55:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['dromaeo_dom']}, 08:55:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['basic_compositor_video']}, 08:55:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:55:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['a11yr', 08:55:07 INFO - 'ts_paint', 08:55:07 INFO - 'tpaint', 08:55:07 INFO - 'sessionrestore', 08:55:07 INFO - 'sessionrestore_no_auto_restore', 08:55:07 INFO - 'tabpaint']}, 08:55:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['tsvgx', 08:55:07 INFO - 'tsvgr_opacity', 08:55:07 INFO - 'tart', 08:55:07 INFO - 'tscrollx', 08:55:07 INFO - 'cart', 08:55:07 INFO - 'tsvg_static']}, 08:55:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:07 INFO - 'tsvgr_opacity', 08:55:07 INFO - 'tart', 08:55:07 INFO - 'tscrollx', 08:55:07 INFO - 'cart', 08:55:07 INFO - 'tsvg_static']}, 08:55:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'talos_options': ['--disable-e10s'], 08:55:07 INFO - 'tests': ['tp5o']}, 08:55:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:55:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'talos_options': ['--disable-e10s', 08:55:07 INFO - '--xperf_path', 08:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:07 INFO - 'tests': ['tp5n']}, 08:55:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:55:07 INFO - 'talos_options': ['--xperf_path', 08:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:07 INFO - 'tests': ['tp5n']}}, 08:55:07 INFO - 'talos.zip': {'path': '', 08:55:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:07 INFO - Running post-action listener: _resource_record_post_action 08:55:07 INFO - [mozharness: 2017-02-03 16:55:07.828593Z] Finished populate-webroot step (success) 08:55:07 INFO - [mozharness: 2017-02-03 16:55:07.828731Z] Running create-virtualenv step. 08:55:07 INFO - Running pre-action listener: _resource_record_pre_action 08:55:07 INFO - Running main action method: create_virtualenv 08:55:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:55:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:07 INFO - Using real prefix '/tools/python27' 08:55:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:11 INFO - Installing pip.................done. 08:55:11 INFO - Return code: 0 08:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:55:11 INFO - Reading from file tmpfile_stdout 08:55:11 INFO - Output received: 08:55:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:55:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:11 INFO - 'HOME': '/Users/cltbld', 08:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:11 INFO - 'LOGNAME': 'cltbld', 08:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:11 INFO - 'MOZ_NO_REMOTE': '1', 08:55:11 INFO - 'NO_EM_RESTART': '1', 08:55:11 INFO - 'PAGER': '/bin/cat', 08:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:11 INFO - 'PWD': '/builds/slave/test', 08:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:11 INFO - 'SHELL': '/bin/bash', 08:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:11 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:11 INFO - 'USER': 'cltbld', 08:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:11 INFO - 'XPC_FLAGS': '0x0', 08:55:11 INFO - 'XPC_SERVICE_NAME': '0', 08:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:55:12 INFO - Cleaning up... 08:55:12 INFO - Return code: 0 08:55:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:12 INFO - 'HOME': '/Users/cltbld', 08:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:12 INFO - 'LOGNAME': 'cltbld', 08:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:12 INFO - 'MOZ_NO_REMOTE': '1', 08:55:12 INFO - 'NO_EM_RESTART': '1', 08:55:12 INFO - 'PAGER': '/bin/cat', 08:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:12 INFO - 'PWD': '/builds/slave/test', 08:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:12 INFO - 'SHELL': '/bin/bash', 08:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:12 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:12 INFO - 'USER': 'cltbld', 08:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:12 INFO - 'XPC_FLAGS': '0x0', 08:55:12 INFO - 'XPC_SERVICE_NAME': '0', 08:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:12 INFO - Downloading/unpacking psutil>=3.1.1 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:15 INFO - Installing collected packages: psutil 08:55:15 INFO - Running setup.py install for psutil 08:55:15 INFO - building 'psutil._psutil_osx' extension 08:55:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:55:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:55:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:55:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:55:16 INFO - building 'psutil._psutil_posix' extension 08:55:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:55:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:55:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:55:16 INFO - ^ 08:55:16 INFO - 1 warning generated. 08:55:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:55:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:16 INFO - Successfully installed psutil 08:55:16 INFO - Cleaning up... 08:55:17 INFO - Return code: 0 08:55:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:17 INFO - 'HOME': '/Users/cltbld', 08:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:17 INFO - 'LOGNAME': 'cltbld', 08:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:17 INFO - 'MOZ_NO_REMOTE': '1', 08:55:17 INFO - 'NO_EM_RESTART': '1', 08:55:17 INFO - 'PAGER': '/bin/cat', 08:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:17 INFO - 'PWD': '/builds/slave/test', 08:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:17 INFO - 'SHELL': '/bin/bash', 08:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:17 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:17 INFO - 'USER': 'cltbld', 08:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:17 INFO - 'XPC_FLAGS': '0x0', 08:55:17 INFO - 'XPC_SERVICE_NAME': '0', 08:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:20 INFO - Installing collected packages: mozsystemmonitor 08:55:20 INFO - Running setup.py install for mozsystemmonitor 08:55:20 INFO - Successfully installed mozsystemmonitor 08:55:20 INFO - Cleaning up... 08:55:20 INFO - Return code: 0 08:55:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:20 INFO - 'HOME': '/Users/cltbld', 08:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:20 INFO - 'LOGNAME': 'cltbld', 08:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:20 INFO - 'MOZ_NO_REMOTE': '1', 08:55:20 INFO - 'NO_EM_RESTART': '1', 08:55:20 INFO - 'PAGER': '/bin/cat', 08:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:20 INFO - 'PWD': '/builds/slave/test', 08:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:20 INFO - 'SHELL': '/bin/bash', 08:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:20 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:20 INFO - 'USER': 'cltbld', 08:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:20 INFO - 'XPC_FLAGS': '0x0', 08:55:20 INFO - 'XPC_SERVICE_NAME': '0', 08:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:23 INFO - warning: no files found matching '*.txt' 08:55:23 INFO - no previously-included directories found matching 'build' 08:55:23 INFO - no previously-included directories found matching 'dist' 08:55:23 INFO - no previously-included directories found matching '.git*' 08:55:23 INFO - Installing collected packages: jsonschema, functools32 08:55:23 INFO - Running setup.py install for functools32 08:55:23 INFO - warning: no files found matching '*.txt' 08:55:23 INFO - no previously-included directories found matching 'build' 08:55:23 INFO - no previously-included directories found matching 'dist' 08:55:23 INFO - no previously-included directories found matching '.git*' 08:55:23 INFO - Successfully installed jsonschema functools32 08:55:23 INFO - Cleaning up... 08:55:23 INFO - Return code: 0 08:55:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:23 INFO - 'HOME': '/Users/cltbld', 08:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:23 INFO - 'LOGNAME': 'cltbld', 08:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:23 INFO - 'MOZ_NO_REMOTE': '1', 08:55:23 INFO - 'NO_EM_RESTART': '1', 08:55:23 INFO - 'PAGER': '/bin/cat', 08:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:23 INFO - 'PWD': '/builds/slave/test', 08:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:23 INFO - 'SHELL': '/bin/bash', 08:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:23 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:23 INFO - 'USER': 'cltbld', 08:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:23 INFO - 'XPC_FLAGS': '0x0', 08:55:23 INFO - 'XPC_SERVICE_NAME': '0', 08:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:24 INFO - Cleaning up... 08:55:24 INFO - Return code: 0 08:55:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:24 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 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:24 INFO - 'HOME': '/Users/cltbld', 08:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:24 INFO - 'LOGNAME': 'cltbld', 08:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:24 INFO - 'MOZ_NO_REMOTE': '1', 08:55:24 INFO - 'NO_EM_RESTART': '1', 08:55:24 INFO - 'PAGER': '/bin/cat', 08:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:24 INFO - 'PWD': '/builds/slave/test', 08:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:24 INFO - 'SHELL': '/bin/bash', 08:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:24 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:24 INFO - 'USER': 'cltbld', 08:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:24 INFO - 'XPC_FLAGS': '0x0', 08:55:24 INFO - 'XPC_SERVICE_NAME': '0', 08:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:28 INFO - Downloading docopt-0.6.1.tar.gz 08:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:28 INFO - Running setup.py install for blobuploader 08:55:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:28 INFO - Running setup.py install for requests 08:55:29 INFO - Running setup.py install for docopt 08:55:29 INFO - Successfully installed blobuploader requests docopt 08:55:29 INFO - Cleaning up... 08:55:29 INFO - Return code: 0 08:55:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:29 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 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:29 INFO - 'HOME': '/Users/cltbld', 08:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:29 INFO - 'LOGNAME': 'cltbld', 08:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:29 INFO - 'MOZ_NO_REMOTE': '1', 08:55:29 INFO - 'NO_EM_RESTART': '1', 08:55:29 INFO - 'PAGER': '/bin/cat', 08:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:29 INFO - 'PWD': '/builds/slave/test', 08:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:29 INFO - 'SHELL': '/bin/bash', 08:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:29 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:29 INFO - 'USER': 'cltbld', 08:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:29 INFO - 'XPC_FLAGS': '0x0', 08:55:29 INFO - 'XPC_SERVICE_NAME': '0', 08:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:29 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-6dRLDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:29 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-FG_7LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:29 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-86zuWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:29 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-EKarQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5BQv8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ZyTnWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ZAbSRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-cXdaGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-sxgKSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GVd03s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-PQG7bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-xO7Tdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-V6eiSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:30 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-quuPdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:31 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_DTHZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:31 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-60uR7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:31 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7Y0j40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:31 INFO - Running setup.py install for manifestparser 08:55:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:31 INFO - Running setup.py install for mozcrash 08:55:31 INFO - Running setup.py install for mozdebug 08:55:31 INFO - Running setup.py install for mozdevice 08:55:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:55:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:31 INFO - Running setup.py install for mozfile 08:55:32 INFO - Running setup.py install for mozhttpd 08:55:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Running setup.py install for mozinfo 08:55:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Running setup.py install for mozInstall 08:55:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Running setup.py install for mozleak 08:55:32 INFO - Running setup.py install for mozlog 08:55:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:32 INFO - Running setup.py install for moznetwork 08:55:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Running setup.py install for mozprocess 08:55:33 INFO - Running setup.py install for mozprofile 08:55:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Running setup.py install for mozrunner 08:55:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Running setup.py install for mozscreenshot 08:55:33 INFO - Running setup.py install for moztest 08:55:33 INFO - Running setup.py install for mozversion 08:55:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:33 INFO - Cleaning up... 08:55:33 INFO - Return code: 0 08:55:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:33 INFO - 'HOME': '/Users/cltbld', 08:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:33 INFO - 'LOGNAME': 'cltbld', 08:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:33 INFO - 'MOZ_NO_REMOTE': '1', 08:55:33 INFO - 'NO_EM_RESTART': '1', 08:55:33 INFO - 'PAGER': '/bin/cat', 08:55:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:33 INFO - 'PWD': '/builds/slave/test', 08:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:33 INFO - 'SHELL': '/bin/bash', 08:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:33 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:33 INFO - 'USER': 'cltbld', 08:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:33 INFO - 'XPC_FLAGS': '0x0', 08:55:33 INFO - 'XPC_SERVICE_NAME': '0', 08:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-TxQDY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-AqlBxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GMsLs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Hns4ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-c4vKNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-crvsGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zhW6vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:34 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zbNdY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ebiakg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kLivZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LyGjkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-DG9OLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-KQCm9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Oq9gWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qLngRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vVHpLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:35 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-F6AHco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:38 INFO - Downloading blessings-1.6.tar.gz 08:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:38 INFO - Installing collected packages: blessings 08:55:38 INFO - Running setup.py install for blessings 08:55:38 INFO - Successfully installed blessings 08:55:38 INFO - Cleaning up... 08:55:39 INFO - Return code: 0 08:55:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:39 INFO - Reading from file tmpfile_stdout 08:55:39 INFO - Current package versions: 08:55:39 INFO - blessings == 1.6 08:55:39 INFO - blobuploader == 1.2.4 08:55:39 INFO - docopt == 0.6.1 08:55:39 INFO - functools32 == 3.2.3-2 08:55:39 INFO - jsonschema == 2.5.1 08:55:39 INFO - manifestparser == 1.1 08:55:39 INFO - mozInstall == 1.12 08:55:39 INFO - mozcrash == 1.0 08:55:39 INFO - mozdebug == 0.1 08:55:39 INFO - mozdevice == 0.49 08:55:39 INFO - mozfile == 1.2 08:55:39 INFO - mozhttpd == 0.7 08:55:39 INFO - mozinfo == 0.9 08:55:39 INFO - mozleak == 0.1 08:55:39 INFO - mozlog == 3.4 08:55:39 INFO - moznetwork == 0.27 08:55:39 INFO - mozprocess == 0.24 08:55:39 INFO - mozprofile == 0.28 08:55:39 INFO - mozrunner == 6.13 08:55:39 INFO - mozscreenshot == 0.1 08:55:39 INFO - mozsystemmonitor == 0.3 08:55:39 INFO - moztest == 0.8 08:55:39 INFO - mozversion == 1.4 08:55:39 INFO - psutil == 3.1.1 08:55:39 INFO - requests == 1.2.3 08:55:39 INFO - wsgiref == 0.1.2 08:55:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:40 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 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:40 INFO - 'HOME': '/Users/cltbld', 08:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:40 INFO - 'LOGNAME': 'cltbld', 08:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:40 INFO - 'MOZ_NO_REMOTE': '1', 08:55:40 INFO - 'NO_EM_RESTART': '1', 08:55:40 INFO - 'PAGER': '/bin/cat', 08:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:40 INFO - 'PWD': '/builds/slave/test', 08:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:40 INFO - 'SHELL': '/bin/bash', 08:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:40 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:40 INFO - 'USER': 'cltbld', 08:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:40 INFO - 'XPC_FLAGS': '0x0', 08:55:40 INFO - 'XPC_SERVICE_NAME': '0', 08:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:40 INFO - Cleaning up... 08:55:40 INFO - Return code: 0 08:55:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:40 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 0x1093a2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb35614e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, '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.SLQxpIkaIY/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.GSFuDyE4h2/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 08:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:40 INFO - 'HOME': '/Users/cltbld', 08:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:40 INFO - 'LOGNAME': 'cltbld', 08:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:40 INFO - 'MOZ_NO_REMOTE': '1', 08:55:40 INFO - 'NO_EM_RESTART': '1', 08:55:40 INFO - 'PAGER': '/bin/cat', 08:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:40 INFO - 'PWD': '/builds/slave/test', 08:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:40 INFO - 'SHELL': '/bin/bash', 08:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:55:40 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:40 INFO - 'USER': 'cltbld', 08:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:40 INFO - 'XPC_FLAGS': '0x0', 08:55:40 INFO - 'XPC_SERVICE_NAME': '0', 08:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:55:41 INFO - Cleaning up... 08:55:41 INFO - Return code: 0 08:55:41 INFO - Running post-action listener: _resource_record_post_action 08:55:41 INFO - Running post-action listener: _start_resource_monitoring 08:55:41 INFO - Starting resource monitoring. 08:55:41 INFO - [mozharness: 2017-02-03 16:55:41.072221Z] Finished create-virtualenv step (success) 08:55:41 INFO - [mozharness: 2017-02-03 16:55:41.073174Z] Running install step. 08:55:41 INFO - Running pre-action listener: _resource_record_pre_action 08:55:41 INFO - Running main action method: install 08:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:41 INFO - Reading from file tmpfile_stdout 08:55:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:41 INFO - Reading from file tmpfile_stdout 08:55:41 INFO - Output received: 08:55:41 INFO - Usage: mozinstall [options] installer 08:55:41 INFO - Options: 08:55:41 INFO - -h, --help show this help message and exit 08:55:41 INFO - -d DEST, --destination=DEST 08:55:41 INFO - Directory to install application into. [default: 08:55:41 INFO - "/builds/slave/test"] 08:55:41 INFO - --app=APP Application being installed. [default: firefox] 08:55:41 INFO - mkdir: /builds/slave/test/build/application 08:55:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:56:01 INFO - Reading from file tmpfile_stdout 08:56:01 INFO - Output received: 08:56:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:56:01 INFO - Running post-action listener: _resource_record_post_action 08:56:01 INFO - [mozharness: 2017-02-03 16:56:01.390550Z] Finished install step (success) 08:56:01 INFO - [mozharness: 2017-02-03 16:56:01.390720Z] Running run-tests step. 08:56:01 INFO - Running pre-action listener: _resource_record_pre_action 08:56:01 INFO - Running main action method: run_tests 08:56:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:01 INFO - 2017-02-03 08:56:01.405 screenresolution[1623:7265] starting screenresolution argv=screenresolution get 08:56:01 INFO - 2017-02-03 08:56:01.407 screenresolution[1623:7265] Display 0: 1600x1200x32@60 08:56:01 INFO - 2017-02-03 08:56:01.413 screenresolution[1624:7268] starting screenresolution argv=screenresolution list 08:56:01 INFO - Available Modes on Display 0 08:56:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:01 INFO - Intel Iris: 08:56:01 INFO - Chipset Model: Intel Iris 08:56:01 INFO - Type: GPU 08:56:01 INFO - Bus: Built-In 08:56:01 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:01 INFO - Vendor: Intel (0x8086) 08:56:01 INFO - Device ID: 0x0a2e 08:56:01 INFO - Revision ID: 0x0009 08:56:01 INFO - Displays: 08:56:01 INFO - Display: 08:56:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:01 INFO - Display Serial Number: 1600x1200 60 08:56:01 INFO - Main Display: Yes 08:56:01 INFO - Mirror: Off 08:56:01 INFO - Online: Yes 08:56:01 INFO - Rotation: Supported 08:56:01 INFO - Return code: 0 08:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:01 INFO - Python 2.7.3 08:56:01 INFO - Return code: 0 08:56:01 INFO - grabbing minidump binary from tooltool 08:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:01 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 0x109180d30>, '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 0x1090a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109175be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:56:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:56:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:56:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:01 INFO - Return code: 0 08:56:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:56:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:56:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.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 08:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.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 08:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SLQxpIkaIY/Render', 08:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:01 INFO - 'HOME': '/Users/cltbld', 08:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:01 INFO - 'LOGNAME': 'cltbld', 08:56:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:01 INFO - 'MOZ_NO_REMOTE': '1', 08:56:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:01 INFO - 'NO_EM_RESTART': '1', 08:56:01 INFO - 'PAGER': '/bin/cat', 08:56:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:01 INFO - 'PWD': '/builds/slave/test', 08:56:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:01 INFO - 'SHELL': '/bin/bash', 08:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GSFuDyE4h2/Listeners', 08:56:01 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 08:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:01 INFO - 'USER': 'cltbld', 08:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:01 INFO - 'XPC_FLAGS': '0x0', 08:56:01 INFO - 'XPC_SERVICE_NAME': '0', 08:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.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 08:56:01 INFO - mozversion application_buildid: 20170203071808 08:56:01 INFO - mozversion application_changeset: 38f8808782c3209051b97de2ae3ea8c6a535e01a 08:56:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:56:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:01 INFO - mozversion application_name: Firefox 08:56:01 INFO - mozversion application_remotingname: firefox-dev 08:56:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:56:01 INFO - mozversion application_vendor: Mozilla 08:56:01 INFO - mozversion application_version: 53.0a2 08:56:01 INFO - mozversion platform_buildid: 20170203071808 08:56:01 INFO - mozversion platform_changeset: 38f8808782c3209051b97de2ae3ea8c6a535e01a 08:56:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:56:01 INFO - mozversion platform_version: 53.0a2 08:56:01 INFO - using testdate: 1486140961 08:56:01 INFO - actual date: 1486140961 08:56:01 INFO - starting webserver on 'localhost:49241' 08:56:01 INFO - SUITE-START | Running 2 tests 08:56:01 INFO - TEST-START | dromaeo_css 08:56:01 INFO - operating with platform_type : mac_ 08:56:01 INFO - Initialising browser for dromaeo_css test... 08:56:02 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile http://localhost:49241/getInfo.html) 08:56:04 INFO - PROCESS | 1634 | 2017-02-03 08:56:04.856 plugin-container[1635:7443] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 08:56:04 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:04 INFO - PROCESS | 1634 | 2017-02-03 08:56:04.858 plugin-container[1635:7443] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 08:56:04 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:04 INFO - PROCESS | 1634 | 2017-02-03 08:56:04.858 plugin-container[1635:7443] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:04 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:56:04 INFO - PROCESS | 1634 | colorDepth:24 08:56:04 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:56:04 INFO - PROCESS | 1634 | __metrics 08:56:05 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:56:05 INFO - PROCESS | 1634 | 1486140965042 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:56:05 INFO - TEST-INFO | 1634: exit 0 08:56:05 INFO - Browser initialized. 08:56:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:05 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpw_DEXe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:08 INFO - PROCESS | 1637 | 2017-02-03 08:56:08.418 plugin-container[1638:7583] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 08:56:08 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:08 INFO - PROCESS | 1637 | 2017-02-03 08:56:08.419 plugin-container[1638:7583] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 08:56:08 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:08 INFO - PROCESS | 1637 | 2017-02-03 08:56:08.419 plugin-container[1638:7583] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:17 INFO - PROCESS | 1637 | RSS: Main: 218390528 08:56:17 INFO - PROCESS | 1637 | 08:59:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:59:22 INFO - PROCESS | 1637 | RSS: Main: 237641728 08:59:22 INFO - PROCESS | 1637 | 09:01:06 INFO - PROCESS | 1637 | ************************* 09:01:06 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 09:01:06 INFO - PROCESS | 1637 | 09:01:06 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:01:06 INFO - PROCESS | 1637 | Full stack: 09:01:06 INFO - PROCESS | 1637 | ************************* 09:02:24 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:02:25 INFO - PROCESS | 1637 | RSS: Main: 250535936 09:02:25 INFO - PROCESS | 1637 | 09:05:27 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:05:27 INFO - PROCESS | 1637 | RSS: Main: 256909312 09:05:27 INFO - PROCESS | 1637 | 09:08:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:08:30 INFO - PROCESS | 1637 | RSS: Main: 253243392 09:08:30 INFO - PROCESS | 1637 | 09:11:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:11:33 INFO - PROCESS | 1637 | RSS: Main: 257187840 09:11:33 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:14:36 INFO - PROCESS | 1637 | RSS: Main: 258830336 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | __start_tp_report 09:14:36 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:14:36 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:14:36 INFO - PROCESS | 1637 | |i|pagename|runs| 09:14:36 INFO - PROCESS | 1637 | |0;dojo.html;3337.2991671748932;3362.7309815214785;3407.02899673593;3409.7954122752635;3410.641882602328;5770.596058275917;5776.335721392036;5777.971110144444;5866.178734977107;5878.764849406019;5777.566682498808;5853.385394533566;5860.794872179475;5864.970675146629;5869.8826023479505;5237.319148510688;5313.814016509423;5318.723506358466;5336.946630533684;5369.489898459659;5319.813806516772;5348.224507446418;5367.624266301361;5370.785168593252;5377.0321342158395;5201.985612805504;5203.42762296149;5345.518903298703;5361.571074314065;5377.11277639189;5298.894022119555;5309.707966061885;5354.625176237665;5374.973125134388;5437.184422336642;5209.192575150858;5307.681539107666;5310.309659744247;5310.548603368718;5360.410354860962;5620.156976453523;5852.531797456193;5932.614380065282;5936.020556608154;5975.223220981288;5290.841274761763;6114.966544785233;6126.639818174547;6149.262088549358;6183.96908015457;6214.751409943642;6241.968790156066;6247.281562620311;6250.9062364064575;6281.654509002003;5950.256217972754;5986.07215881539;6001.729922153513;6011.428914253226;6037.879242415215;6120.325235636462;6127.739336776432;6197.659128747872;6231.22109736283;6232.719527621268;6139.246828488716;6142.6522545212965;6187.907181392283;6196.380361963767;6224.315325314212;6199.721012554446;6206.937930620727;6216.2540495140875;6216.937830621727;6223;6099.451049405486;6140.289530736369;6146.354632763496;6155.384461553898;6182.505399568024;5398.514133727984;5709.800156994568;5835.503982161564;6199.752009919643;6249.156363890907;4103.281925663056;4655.3947986761505;5062.772175252123;5064.46823083571;5072.771725272371;4114.074333274989;4114.156597897424;4409.096135292258;4493.573110554492;4510.639148868083;5829.941700583025;5918.792842250587;5932.228810254725;5956.642601443928;6016.217891674054;6103.542234332443;6244.12582238487;6250.937490625127;6252.3122456529745;6257.43683068526;5701.372848986608;5835.912461312999;5859.648421094748;5863.472287494146;5900.940990590125;5550.888982220333;5552.69460179694;5553.139263414178;5563.276774019351;5577.581681373913;6322.272938612118;6356.237251529846;6359.268684101387;6380.425761681286;6381.202349706286;6128.717018009172;6133.916185115316;6140.87237156979;6153.876922461615;6249.687515624291;6235.96882015587;6294.402031806971;6298.779542715983;6302.212223472066;6313.842153946188;6132.386761323832;6187.443130118311;6195.349488303663;6219.160413344322;6224.968875155776;6115.938840611537;6123.648682309606;6152.077188421594;6191.783287585093;6222;5136.30659860929;6162.476189523762;6193.102000210034;6194.287656919512;6200.3489633589625;6046.637201767908;6165.753369865155;6185.350538193425;6196.690165491617;6212.192414986023;5813.680247586254;5856.238688970407;5920.79277225295;6050.092486127116;6091.42131497507;6117.248930028793;6140.201773769381;6146.555559443438;6155.876882462415;6209.96895015522;6091.786787462417;6096.110295398481;6101.237345331833;6109.070667813169;6128.203333566607 09:14:36 INFO - PROCESS | 1637 | |1;ext.html;476.7806808867921;483.9443464001641;493.6026498668571;502.1714171616834;512.2404540403713;38711;42059.78970105153;42074;42218;42236.57763422365;42191.578084219145;42815.3577696334;42864.357034644425;42920.78539607306;42979.3553096703;8466.280366168883;8689.131086891291;9199.816003679922;9360.017198194193;9449.905500944971;10249.692509224735;11455.198136130473;11456.312621242752;11645.6506304811;11647.184697071209;11529.481173347178;11538.769224615544;11619.825702614467;11630.941845290761;11632.825507617392;11582.07343412525;11591.710207244801;11653.067754579613;11653.30080195191;11656.59201927937;9250.491222982733;10053.195744340435;11505.827412588735;11518.539258429653;11536.01943834775;40687;40990;41006;41024.1795164098;41296.174076518604;4051.7974101294817;4098.200850834089;4150.813213405404;4153.1486045360625;4198.895027624303;29575.260618484495;29588.40823183546;29665.555016674767;29753.702462975525;29993;2999.0552975812548;3130.9217269568217;3152.668969758165;3366.7474939379645;3404.489326601005;356126;356515;358409;359083;359098.9999999974;61017.694911525155;62681.373186268465;63127;63161.36838631647;63326.683366582874;58128;58394.70802645959;58569;58642.4135758637;58746.41253587495;16649;16754.916225418794;16780.328786848633;16784.412545561092;16806.915965420096;11672.766544669059;12005.399730013465;12720.872791272153;13018.218906865619;13114;14878.70242595142;16314.184290785413;16740.49778506647;16815.91592042032;16866.831331686528;5665.603407761417;5697.259356283656;5709.914351284734;5721.141828725725;5770.480656740913;879.8196369744315;897.438457084668;911.4121391702315;931.6599441203912;936.166811537732;29524.852375738414;30120;30642.69357306443;31091.533626995613;31240.687593124232;955.8996305387973;1010.9949450252701;1062.044160255776;1114.2367478277406;1202.2185579373477;13726.382312795948;13941.58175254744;14903.031302965273;16000.959937604019;16108.033517988959;578421;585312;585970;586410;587642;61723;61941.69029154826;62081;62135.689321554004;62301.065484017774;1434.8834586281996;1439.9136051836713;1461.400825661495;1482.547822914;1491.7165738509866;27477.17568472949;29897.850510747307;29993.850030749705;30443.2389190272;30656.233594160323;50075.49924500854;50481.49518504768;50694;50711.74644126903;50818.74590627023;529883.3505832446;530864;531761.3411933071;534355;534477;40243.597564025156;40786.9803254921;40913.795431022656;41004.79497602493;41138;41448.79275603723;46526.6334451744;47557.048859023314;50576;51463.97072058613;35510.28979420449;35602.64397356097;36683.81658091692;38668.80665596654;39309.606903930595;35426.64573354233;35807;36053.63946360503;36795.89612311635;36943.63056369509;35064.47403289004;35402.82298588491;35589.82205088958;35830.56677732861;35946.64053359433;28492.57261141126;30304.090877273717;32215.355692885543;32367.51448728318;32404.675953240167;21423.67864482065;22602.869856507437;22964.655530166725;24634.384140396633;25263.74736252614 09:14:36 INFO - PROCESS | 1637 | |2;jquery.html;391.63773509503704;392.6034704948002;394.17223829957095;403.3405382200103;425.9169461954918;17514.299428022863;19822.81063136211;20389.388318350473;21374.46563835903;21454.927253637336;20942.685859712117;21030.57938841222;21176.835274059922;21393.57212855742;21929.451763705874;5939.168516407695;6144.139820425144;6153.9384606154035;6207.3792620737795;6210.50315974721;5833.533317334624;6031.788887388942;6062.181605483247;6116.694165291739;6126.448619624233;5306.3632364116165;6001.66990815505;6002.069679199709;6005.399460054004;6009.87980240395;5617.634853734515;5895.233619629421;5936.376680448577;5966.612170208922;5976.940230597682;5835.44563266489;5836.9124463133085;5861.853453663693;5880.558958078162;5883;20031.699524507;24184.879075604684;25138;25326.36684082894;25399.492010159876;2575.433404650974;2737.055715778073;2943.8380889051095;2948.9557656635166;2953.2764472704325;10095.343802652878;10162.796744065152;10207.336523126047;10446.738831529272;10673.893261067446;1453.672923592194;1803.5941913069455;1812.28414776164;1824.644194382096;1837.6875931091747;98764.51853222208;126401;126540.36729816384;132786;132844.3357783205;9379.390339627902;10172.440515771556;11708.648740537797;12124.636260912186;12209.816852747215;14361.21013344276;14893.851061489464;15739.13434761099;15739.370425183093;15793.21033948298;8435.325173986066;8799.868001979976;8800.8679869802;8828.205461508494;8882.555872206363;7154.35610795031;8555.187257210555;8637.136286371438;8750.824983500293;8776.473411595325;4099.508059032935;4790.592799612003;4791.496892826272;4932;4933.975330123327;1794.2912549543119;2025.351887396019;2032.7255820464343;2053.856230063911;2066.6693329067275;391.14534741589716;399.7201958628971;410.09369293860306;1029.1714130057917;1055.2560444886337;11316.830247546293;11482.94258528702;11493.77012459746;11525.962663360338;11740.589079382351;433.18128736687686;947.3699989507038;1015.1168483419325;1053.6154303679255;1054.1988089052375;7046.189688185822;7128.394086502602;7193.604351760703;7211.098612673416;7500.212477689873;690215;766009;777280;778841.1057944674;782685;158686;160934.1953290226;165527;167083;168272;939.9389039712397;1075.8117329467311;1108.229780302698;1111.3609674437068;1112.8052590796578;12421.31682757457;12828.166169198972;12903.677408064874;13066.477340906258;13128.540501082416;58970;59487.1076933855;60025.39974600373;60927;61359.69320153371;63907;82337.76493352724;87779;88889.55555222182;90089.64865526892;6962.825929351604;7151.962965370096;7569.3566046886635;7736.92263077362;7800.804979875322;8085.474444161346;12089.335086570323;13578.185308881499;13639.659008524866;13685.657858553615;9853.408795472295;11372.658820235407;11395.943020284845;11442.885571144516;11949.820752688891;5441.891162176814;7450.627468626655;11071.892810718864;11241.775164496501;11694.356810375511;10761.437438291516;11478.94260528692;11586.131040171853;11674.824877627012;11898.583549575724;7431.219721929119;8327.125651806473;8545.352470948128;8645.438046526955;8755.474671519729;8280.751577452686;10452.738681533023;11580.305181689126;11583.189176757545;11825 09:14:36 INFO - PROCESS | 1637 | |3;mootools.html;1312.1930013041977;1447.3052934591396;1451.2743628185908;1461.1525315317117;1464.831544372397;7601.467897247195;7841;8107.554084525349;8556.486610803357;8565.657373705051;8101.027876654795;8272.586370681456;8298.045724741656;8390.706325278616;8411.621477033534;2158.9676154857652;2328.9767102329015;2339.3800642829665;2341.6019276722914;2342.379269493577;2084.9791502085013;2158.104386679526;2307.1809507624803;2347.929562113139;2373.5608912351186;2256.627656436686;2332.3935776698013;2336.0188720737247;2345.7536958619357;2352.3648614873973;2046.7748547659746;2325.976740232593;2338.0530884991604;2343.554724602337;2364.2670772060715;2321.257197696738;2341.379534423362;2367.4673198530195;2370.798482129021;2374.1097088591778;8470.788230294293;8510;8524.019737730116;8527.360447966428;8529.573521323971;5165.767540460688;5282.128448805943;5288;5293.206019097128;5308.283381743454;3103.7982531135403;3396.4056290149374;3483.3555792178277;3525.206828463575;3533.028417185269;1178.917475776696;1192.7793358228669;1224.7183147875949;1252.943617537213;1255.0210835548287;9756.024397560259;10816.026557609854;10922.29005114665;10941.179411544166;10963.451827408599;4046.4132700758223;4209.621134097946;4616.307553866947;4765.428148622187;4786.401699787527;9607.56765945534;9671.758206044906;9688.660896868576;9736;9739.610415583438;5209.479052094836;5279.944011197776;5303.124984377611;5328.387235467893;5330.093884039723;4067.633912947849;4628.375169352162;4792;4799.928001079987;4857.028594281158;3389.6610338966398;3932.9606703932595;3997.4403583498333;4007.779572123561;4039.3940908863906;1187.5724739093919;1208.7461633057158;1229.2010193374379;1232.2236990695803;1312.2848047813964;767.7389687506275;792.3621484704868;803.6182813163817;830.5556527257888;837.3217693668148;5503.587230957694;5647.943520564824;5655.943440565542;5705.1727499512335;5778.479936805707;993.1707024634367;1009.7980403919246;1021.7803172317987;1028.6913925822223;1050.9018076110483;3519.7856739424856;3591.9281614367565;3691.8892433227047;3741.8129093545213;3812.046988252937;7499.8500029999095;10106.848397274047;10134.23993200498;10138.898611013943;10148.188144948386;10002.899971000343;10003.549840257207;10006.349587276804;10016.29885907994;10019.849702254473;7539.547627142389;7839.412044096715;7945.9670242869215;7946.880796788053;8056.476329038594;5731.713414329351;5785.161151633074;5854.034084376201;5866.6186697864505;5868.354481007171;9016.729498115066;9103;9231.76920576991;9382.765430864283;9395.577199026196;9114.589843456928;9272.953635231781;9362.625494980397;9436.858447123435;9489.952550237205;7121.430285577245;7190.316919892602;7263.854722905618;7301.634918254173;7383.446241532014;7890.092639346549;7960.442769006114;7982.521048737094;7985.361171106181;7997.200279971957;7084.929150708427;7177.318154775288;7189.856202876018;7190.96404517974;7343.082114735658;7052.753153639598;7053.541519801196;7101;7109.075820143348;7203.135623725187;6433.485321174388;6444.420002199825;6530.67346632676;6535.57518761279;6542.149520562297;5026.52248036436;5034.219695947134;5085.7457127144235;5106.540411362995;5116.488351165002;5021.573166280907;5072.923906141337;5142.948570514397;5155.690658560498;5192.870178245574 09:14:36 INFO - PROCESS | 1637 | |4;prototype.html;350.56354838226406;357.99284014319716;369.61190749712796;371.7899386846432;372.73908264215055;4637.860864174072;4909.502601706483;5006.574441172495;5383.407825139231;5568.860778480535;4799.536141476849;4827.813642995624;5200.061964989778;5413;5474.39781624022;4133.834646614132;4257.489101307832;4263.765492897889;4292.248856450125;4304.634106100985;3641.47198656196;3752.9061773455746;4295.548967358429;4309.978450107761;4325.199838029959;3498.3762178366223;3760.3043436964113;4075.266452038632;4097.590240975894;4126.360414135799;3246.9837650811833;3778.263238668461;4073.2668119738437;4092.2224777292367;4134.297169481165;3360.663933606644;3543.85824567017;3569.250457403948;3574.946375804365;3589.6051434342203;5062.367204099488;5101.234814777776;5253.50091741284;5285.603579731535;5379;4107.383892416162;4682.578567928868;4705.494241842612;4787.904241915142;4792.7124372537755;4772.594329481998;5316.149416093445;5718;5764.8847023059725;5803;3860.1893602343544;3910.2570511602703;4103.117829666636;4166.7708276044805;4176.749395036308;5159.182205168148;5571.526420254283;6066.7249781332;6156.445919867234;6198.938010619926;3689.262147570497;4291;4305.225059489322;4338.74385319632;4382.452193475816;3762.0030691866677;4254.659627229814;4303.268444364466;4328.199283132631;4361.084172323847;4026.8187931543152;4226.957730422718;4932.309476673268;4937.851864444073;4971.130052240844;5401.675899446046;5693.743781529841;5722.54219662426;5766.711664416846;5781.057196097277;1261.438659796382;1338.9397477113553;1342.6576223063057;1345.3206130904027;1376.511338474847;971.8882328532309;974.3179774157976;1011.2769369900557;1012.1801340913884;1021.8671572695501;4362.825486980549;4701.694389864648;5010.774515146827;5148.3010606499765;5220.712860792617;4818.807247710122;5304.825021741068;5333.359996800409;5542.251796007568;5739.62692424991;4476.798544065525;4674.6026587740425;4922.114019476457;5148.227765835155;5163.457836927144;2665.65346504957;2684.3825920038503;2731.890724371043;2874.8275103493856;3034.8482575871117;5181.300524429229;5390.67655940637;5404.97329489525;5691.857703557362;5955.612885162451;4955.058538877602;5432.728363581805;5789.56578256624;5853.5317174625925;5917.792877249276;5353.732313384316;5915.378885217162;5934.495567876693;5945.791897283488;5954.46409823118;5283.788648454019;5638.464345887134;5717.714114294352;5718.285214348207;5737;5275.920861187008;5612.158176273429;5670.319561652628;5678.346990096192;5689.829305120687;4919.778609962632;5230.4694331325445;5313.495217954288;5922.911156332744;5953.493953013869;3583.6595523426276;4008.8797336079965;4036.829319497313;4118.5057793065025;4154.172164247721;4851.636127290538;5292.232626269247;5433.4566543345345;5721.369409718377;5733.655980641175;4649.674522783373;5424.589606702207;5425.348958125051;5636.633618814764;5819.6508209507565;5755.65466072037;5794.275715535558;5794.567156125483;5804.24544809189;5846;4341.891452713708;4449.7330160190495;5604.551635869039;5632.633878797865;5647.15292706081;4852.078105160008;5167.896642067213;5785.537157027344;5789.321096882026;5824.301083869963;5071.670341427795;5098.439171691037;5109;5663.348714897839;5668 09:14:36 INFO - PROCESS | 1637 | |5;yui.html;670.3229737964657;680.9250982391939;764.6559048428209;770.7841804294796;857.2499063319596;14858.554243372702;15704.450344237954;15707.450239241629;15724.921375393122;15770;14262.286885655702;14425.42298308069;14553.927230363859;14580.781288280685;14597.927010364934;748.6743266679013;787.1341524323255;810.9553974531399;882.8278485695292;888.0497867282011;737.9889301660453;782.5304817109745;867.7787164273133;876.8246350729879;882.192793593864;920.5029284186564;931.4690626342987;931.65063101337;934.1405906565975;934.22926085979;907.9001309855944;925.9305552083554;927.777333439973;927.8376284150247;929.2333824594668;679.5345188545813;691.920429150649;692.5636848785283;693.2443636436258;694.7672529702555;12491.500339986389;12552.937235313857;12562.30907300098;13011.86988130116;13703.862961370358;11744.354060526668;11826.408679565988;11862.703432414173;11943.34311612861;12331.691707707289;10362.533685984148;10668.466576671213;10689.679309620724;10749.677509674722;11104.44477776116;3590.066582688494;3621.2938476996997;3635;3641.289948460051;3644;101335;103142.96857031409;103193.4520982186;103277;103501.9299614011;8723.694670686495;8815.735527934172;8940.50827204497;8957.104289571122;9105.907291124975;18941.242350306107;18969.43091707251;18990.525236869187;19037.524061898563;19127.33054343091;7743.4966727162555;7848.607569621496;7857.803554911058;7902.802429939297;7956.323712484504;4196.454460920061;4221.134667393177;4231.640310573574;4310.288802347577;4474.082813023388;3310.371029504435;3540.8937731868086;3616.258666973264;3674.5590529136675;3706.05495598626;619.5198720991268;647.9254885688206;655.073071603685;657.8158115727604;658.8583454557197;674.7402250133733;703.3283214530112;719.3274288540127;727.4544091931052;764.144158542436;8885;10193.847092293621;10303.278770485995;10395.84406233907;10499.422531760674;667.2526770017612;697.3619138488226;698.4098436820879;699.5068476723898;701.9122609673791;4893.486183950705;4900.26496025599;5110.974445127825;5134.512221338967;5157.406898206679;90442;108433.45783271191;109708.90291096987;111982.44008780067;113688;71181.28818711746;74278;75633;79264.01839953932;87031.12968870357;71943;74063.62968185017;76384.61807691037;77993;79338;9071.773205669911;9303.488308142847;9750.902490974999;10904.34573925567;11315.547378104784;43001;43762.905927350796;44628;46773.53226467828;47840;61382.38617613767;64011.399715007494;64496.35503644904;65075.34924650882;65636.6718166406;11525.135614828754;11529.481173347052;11544.538218471167;11576.768464630828;11692.298462092302;12081;12210.023198144305;12245.204061735958;12589.118761686594;13036.413361398949;11445.942770286096;11574.594889178838;11958.58144964922;12394.81407778866;12404.19372740805;11733.88266117362;11890.167688262085;11923.463444144862;11993.220440671328;12436.440360183633;11551.844815518381;11585.768284634092;11836.46735896904;11853.822192666945;12350.3824808761;9938.950305248427;9956.950215248877;10122.8481572775;10140.340877842917;10323.174146068446;9723.902760972584;9738.163558106236;9761.853572196565;9822.950885245527;9829.459379734184 09:14:36 INFO - PROCESS | 1637 | __end_tp_report 09:14:36 INFO - PROCESS | 1637 | __start_cc_report 09:14:36 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,372 09:14:36 INFO - PROCESS | 1637 | __end_cc_report 09:14:36 INFO - PROCESS | 1637 | __startTimestamp1486142076617__endTimestamp 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:14:36 INFO - PROCESS | 1637 | Number of tests: 6 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5773.29 Median:6037.88 stddev:635.50 (10.5%) stddev-sans-first:608.04 09:14:36 INFO - PROCESS | 1637 | Values: 3337.3 3362.7 3407.0 3409.8 3410.6 5770.6 5776.3 5778.0 5866.2 5878.8 5777.6 5853.4 5860.8 5865.0 5869.9 5237.3 5313.8 5318.7 5336.9 5369.5 5319.8 5348.2 5367.6 5370.8 5377.0 5202.0 5203.4 5345.5 5361.6 5377.1 5298.9 5309.7 5354.6 5375.0 5437.2 5209.2 5307.7 5310.3 5310.5 5360.4 5620.2 5852.5 5932.6 5936.0 5975.2 5290.8 6115.0 6126.6 6149.3 6184.0 6214.8 6242.0 6247.3 6250.9 6281.7 5950.3 5986.1 6001.7 6011.4 6037.9 6120.3 6127.7 6197.7 6231.2 6232.7 6139.2 6142.7 6187.9 6196.4 6224.3 6199.7 6206.9 6216.3 6216.9 6223.0 6099.5 6140.3 6146.4 6155.4 6182.5 5398.5 5709.8 5835.5 6199.8 6249.2 4103.3 4655.4 5062.8 5064.5 5072.8 4114.1 4114.2 4409.1 4493.6 4510.6 5829.9 5918.8 5932.2 5956.6 6016.2 6103.5 6244.1 6250.9 6252.3 6257.4 5701.4 5835.9 5859.6 5863.5 5900.9 5550.9 5552.7 5553.1 5563.3 5577.6 6322.3 6356.2 6359.3 6380.4 6381.2 6128.7 6133.9 6140.9 6153.9 6249.7 6236.0 6294.4 6298.8 6302.2 6313.8 6132.4 6187.4 6195.3 6219.2 6225.0 6115.9 6123.6 6152.1 6191.8 6222.0 5136.3 6162.5 6193.1 6194.3 6200.3 6046.6 6165.8 6185.4 6196.7 6212.2 5813.7 5856.2 5920.8 6050.1 6091.4 6117.2 6140.2 6146.6 6155.9 6210.0 6091.8 6096.1 6101.2 6109.1 6128.2 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:64094.01 Median:197522.82 stddev:133507.81 (67.6%) stddev-sans-first:133796.90 09:14:36 INFO - PROCESS | 1637 | Values: 476.8 483.9 493.6 502.2 512.2 38711.0 42059.8 42074.0 42218.0 42236.6 42191.6 42815.4 42864.4 42920.8 42979.4 8466.3 8689.1 9199.8 9360.0 9449.9 10249.7 11455.2 11456.3 11645.7 11647.2 11529.5 11538.8 11619.8 11630.9 11632.8 11582.1 11591.7 11653.1 11653.3 11656.6 9250.5 10053.2 11505.8 11518.5 11536.0 40687.0 40990.0 41006.0 41024.2 41296.2 4051.8 4098.2 4150.8 4153.1 4198.9 29575.3 29588.4 29665.6 29753.7 29993.0 2999.1 3130.9 3152.7 3366.7 3404.5 356126.0 356515.0 358409.0 359083.0 359099.0 61017.7 62681.4 63127.0 63161.4 63326.7 58128.0 58394.7 58569.0 58642.4 58746.4 16649.0 16754.9 16780.3 16784.4 16806.9 11672.8 12005.4 12720.9 13018.2 13114.0 14878.7 16314.2 16740.5 16815.9 16866.8 5665.6 5697.3 5709.9 5721.1 5770.5 879.8 897.4 911.4 931.7 936.2 29524.9 30120.0 30642.7 31091.5 31240.7 955.9 1011.0 1062.0 1114.2 1202.2 13726.4 13941.6 14903.0 16001.0 16108.0 578421.0 585312.0 585970.0 586410.0 587642.0 61723.0 61941.7 62081.0 62135.7 62301.1 1434.9 1439.9 1461.4 1482.5 1491.7 27477.2 29897.9 29993.9 30443.2 30656.2 50075.5 50481.5 50694.0 50711.7 50818.7 529883.4 530864.0 531761.3 534355.0 534477.0 40243.6 40787.0 40913.8 41004.8 41138.0 41448.8 46526.6 47557.0 50576.0 51464.0 35510.3 35602.6 36683.8 38668.8 39309.6 35426.6 35807.0 36053.6 36795.9 36943.6 35064.5 35402.8 35589.8 35830.6 35946.6 28492.6 30304.1 32215.4 32367.5 32404.7 21423.7 22602.9 22964.7 24634.4 25263.7 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:40419.48 Median:2951.12 stddev:126705.55 (4293.5%) stddev-sans-first:127025.34 09:14:36 INFO - PROCESS | 1637 | Values: 391.6 392.6 394.2 403.3 425.9 17514.3 19822.8 20389.4 21374.5 21454.9 20942.7 21030.6 21176.8 21393.6 21929.5 5939.2 6144.1 6153.9 6207.4 6210.5 5833.5 6031.8 6062.2 6116.7 6126.4 5306.4 6001.7 6002.1 6005.4 6009.9 5617.6 5895.2 5936.4 5966.6 5976.9 5835.4 5836.9 5861.9 5880.6 5883.0 20031.7 24184.9 25138.0 25326.4 25399.5 2575.4 2737.1 2943.8 2949.0 2953.3 10095.3 10162.8 10207.3 10446.7 10673.9 1453.7 1803.6 1812.3 1824.6 1837.7 98764.5 126401.0 126540.4 132786.0 132844.3 9379.4 10172.4 11708.6 12124.6 12209.8 14361.2 14893.9 15739.1 15739.4 15793.2 8435.3 8799.9 8800.9 8828.2 8882.6 7154.4 8555.2 8637.1 8750.8 8776.5 4099.5 4790.6 4791.5 4932.0 4934.0 1794.3 2025.4 2032.7 2053.9 2066.7 391.1 399.7 410.1 1029.2 1055.3 11316.8 11482.9 11493.8 11526.0 11740.6 433.2 947.4 1015.1 1053.6 1054.2 7046.2 7128.4 7193.6 7211.1 7500.2 690215.0 766009.0 777280.0 778841.1 782685.0 158686.0 160934.2 165527.0 167083.0 168272.0 939.9 1075.8 1108.2 1111.4 1112.8 12421.3 12828.2 12903.7 13066.5 13128.5 58970.0 59487.1 60025.4 60927.0 61359.7 63907.0 82337.8 87779.0 88889.6 90089.6 6962.8 7152.0 7569.4 7736.9 7800.8 8085.5 12089.3 13578.2 13639.7 13685.7 9853.4 11372.7 11395.9 11442.9 11949.8 5441.9 7450.6 11071.9 11241.8 11694.4 10761.4 11478.9 11586.1 11674.8 11898.6 7431.2 8327.1 8545.4 8645.4 8755.5 8280.8 10452.7 11580.3 11583.2 11825.0 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5469.19 Median:5160.73 stddev:2971.11 (57.6%) stddev-sans-first:2963.01 09:14:36 INFO - PROCESS | 1637 | Values: 1312.2 1447.3 1451.3 1461.2 1464.8 7601.5 7841.0 8107.6 8556.5 8565.7 8101.0 8272.6 8298.0 8390.7 8411.6 2159.0 2329.0 2339.4 2341.6 2342.4 2085.0 2158.1 2307.2 2347.9 2373.6 2256.6 2332.4 2336.0 2345.8 2352.4 2046.8 2326.0 2338.1 2343.6 2364.3 2321.3 2341.4 2367.5 2370.8 2374.1 8470.8 8510.0 8524.0 8527.4 8529.6 5165.8 5282.1 5288.0 5293.2 5308.3 3103.8 3396.4 3483.4 3525.2 3533.0 1178.9 1192.8 1224.7 1252.9 1255.0 9756.0 10816.0 10922.3 10941.2 10963.5 4046.4 4209.6 4616.3 4765.4 4786.4 9607.6 9671.8 9688.7 9736.0 9739.6 5209.5 5279.9 5303.1 5328.4 5330.1 4067.6 4628.4 4792.0 4799.9 4857.0 3389.7 3933.0 3997.4 4007.8 4039.4 1187.6 1208.7 1229.2 1232.2 1312.3 767.7 792.4 803.6 830.6 837.3 5503.6 5647.9 5655.9 5705.2 5778.5 993.2 1009.8 1021.8 1028.7 1050.9 3519.8 3591.9 3691.9 3741.8 3812.0 7499.9 10106.8 10134.2 10138.9 10148.2 10002.9 10003.5 10006.3 10016.3 10019.8 7539.5 7839.4 7946.0 7946.9 8056.5 5731.7 5785.2 5854.0 5866.6 5868.4 9016.7 9103.0 9231.8 9382.8 9395.6 9114.6 9273.0 9362.6 9436.9 9490.0 7121.4 7190.3 7263.9 7301.6 7383.4 7890.1 7960.4 7982.5 7985.4 7997.2 7084.9 7177.3 7189.9 7191.0 7343.1 7052.8 7053.5 7101.0 7109.1 7203.1 6433.5 6444.4 6530.7 6535.6 6542.1 5026.5 5034.2 5085.7 5106.5 5116.5 5021.6 5072.9 5142.9 5155.7 5192.9 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4568.71 Median:4988.85 stddev:1365.02 (27.4%) stddev-sans-first:1331.63 09:14:36 INFO - PROCESS | 1637 | Values: 350.6 358.0 369.6 371.8 372.7 4637.9 4909.5 5006.6 5383.4 5568.9 4799.5 4827.8 5200.1 5413.0 5474.4 4133.8 4257.5 4263.8 4292.2 4304.6 3641.5 3752.9 4295.5 4310.0 4325.2 3498.4 3760.3 4075.3 4097.6 4126.4 3247.0 3778.3 4073.3 4092.2 4134.3 3360.7 3543.9 3569.3 3574.9 3589.6 5062.4 5101.2 5253.5 5285.6 5379.0 4107.4 4682.6 4705.5 4787.9 4792.7 4772.6 5316.1 5718.0 5764.9 5803.0 3860.2 3910.3 4103.1 4166.8 4176.7 5159.2 5571.5 6066.7 6156.4 6198.9 3689.3 4291.0 4305.2 4338.7 4382.5 3762.0 4254.7 4303.3 4328.2 4361.1 4026.8 4227.0 4932.3 4937.9 4971.1 5401.7 5693.7 5722.5 5766.7 5781.1 1261.4 1338.9 1342.7 1345.3 1376.5 971.9 974.3 1011.3 1012.2 1021.9 4362.8 4701.7 5010.8 5148.3 5220.7 4818.8 5304.8 5333.4 5542.3 5739.6 4476.8 4674.6 4922.1 5148.2 5163.5 2665.7 2684.4 2731.9 2874.8 3034.8 5181.3 5390.7 5405.0 5691.9 5955.6 4955.1 5432.7 5789.6 5853.5 5917.8 5353.7 5915.4 5934.5 5945.8 5954.5 5283.8 5638.5 5717.7 5718.3 5737.0 5275.9 5612.2 5670.3 5678.3 5689.8 4919.8 5230.5 5313.5 5922.9 5953.5 3583.7 4008.9 4036.8 4118.5 4154.2 4851.6 5292.2 5433.5 5721.4 5733.7 4649.7 5424.6 5425.3 5636.6 5819.7 5755.7 5794.3 5794.6 5804.2 5846.0 4341.9 4449.7 5604.6 5632.6 5647.2 4852.1 5167.9 5785.5 5789.3 5824.3 5071.7 5098.4 5109.0 5663.3 5668.0 09:14:36 INFO - PROCESS | 1637 | 09:14:36 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19365.07 Median:25623.81 stddev:28516.16 (111.3%) stddev-sans-first:28561.61 09:14:36 INFO - PROCESS | 1637 | Values: 670.3 680.9 764.7 770.8 857.2 14858.6 15704.5 15707.5 15724.9 15770.0 14262.3 14425.4 14553.9 14580.8 14597.9 748.7 787.1 811.0 882.8 888.0 738.0 782.5 867.8 876.8 882.2 920.5 931.5 931.7 934.1 934.2 907.9 925.9 927.8 927.8 929.2 679.5 691.9 692.6 693.2 694.8 12491.5 12552.9 12562.3 13011.9 13703.9 11744.4 11826.4 11862.7 11943.3 12331.7 10362.5 10668.5 10689.7 10749.7 11104.4 3590.1 3621.3 3635.0 3641.3 3644.0 101335.0 103143.0 103193.5 103277.0 103501.9 8723.7 8815.7 8940.5 8957.1 9105.9 18941.2 18969.4 18990.5 19037.5 19127.3 7743.5 7848.6 7857.8 7902.8 7956.3 4196.5 4221.1 4231.6 4310.3 4474.1 3310.4 3540.9 3616.3 3674.6 3706.1 619.5 647.9 655.1 657.8 658.9 674.7 703.3 719.3 727.5 764.1 8885.0 10193.8 10303.3 10395.8 10499.4 667.3 697.4 698.4 699.5 701.9 4893.5 4900.3 5111.0 5134.5 5157.4 90442.0 108433.5 109708.9 111982.4 113688.0 71181.3 74278.0 75633.0 79264.0 87031.1 71943.0 74063.6 76384.6 77993.0 79338.0 9071.8 9303.5 9750.9 10904.3 11315.5 43001.0 43762.9 44628.0 46773.5 47840.0 61382.4 64011.4 64496.4 65075.3 65636.7 11525.1 11529.5 11544.5 11576.8 11692.3 12081.0 12210.0 12245.2 12589.1 13036.4 11445.9 11574.6 11958.6 12394.8 12404.2 11733.9 11890.2 11923.5 11993.2 12436.4 11551.8 11585.8 11836.5 11853.8 12350.4 9939.0 9957.0 10122.8 10140.3 10323.2 9723.9 9738.2 9761.9 9823.0 9829.5 09:14:36 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:14:36 INFO - PROCESS | 1637 | 09:14:37 INFO - TEST-INFO | 1637: exit 0 09:14:37 INFO - TEST-OK | dromaeo_css | took 1115248ms 09:14:37 INFO - TEST-START | kraken 09:14:37 INFO - operating with platform_type : mac_ 09:14:37 INFO - Initialising browser for kraken test... 09:14:37 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile http://localhost:49241/getInfo.html) 09:14:39 INFO - PROCESS | 1648 | 2017-02-03 09:14:39.844 plugin-container[1649:9899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 09:14:39 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:14:39 INFO - PROCESS | 1648 | 2017-02-03 09:14:39.848 plugin-container[1649:9899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 09:14:39 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:14:39 INFO - PROCESS | 1648 | 2017-02-03 09:14:39.848 plugin-container[1649:9899] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:14:39 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:14:39 INFO - PROCESS | 1648 | colorDepth:24 09:14:39 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:14:39 INFO - PROCESS | 1648 | __metrics 09:14:39 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:14:39 INFO - PROCESS | 1648 | 1486142079993 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:14:40 INFO - TEST-INFO | 1648: exit 0 09:14:40 INFO - Browser initialized. 09:14:40 INFO - Running cycle 1/1 for kraken test... 09:14:40 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmptjMX13/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:43 INFO - PROCESS | 1650 | 2017-02-03 09:14:43.147 plugin-container[1651:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 09:14:43 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:14:43 INFO - PROCESS | 1650 | 2017-02-03 09:14:43.148 plugin-container[1651:10029] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 09:14:43 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:14:43 INFO - PROCESS | 1650 | 2017-02-03 09:14:43.148 plugin-container[1651:10029] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:14:52 INFO - PROCESS | 1650 | RSS: Main: 218939392 09:14:52 INFO - PROCESS | 1650 | 09:14:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:56 INFO - PROCESS | 1650 | RSS: Main: 233324544 09:14:56 INFO - PROCESS | 1650 | 09:14:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:15:00 INFO - PROCESS | 1650 | RSS: Main: 241012736 09:15:00 INFO - PROCESS | 1650 | 09:15:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:15:04 INFO - PROCESS | 1650 | RSS: Main: 242761728 09:15:04 INFO - PROCESS | 1650 | 09:15:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:15:06 INFO - PROCESS | 1650 | RSS: Main: 245395456 09:15:06 INFO - PROCESS | 1650 | 09:15:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:09 INFO - PROCESS | 1650 | RSS: Main: 246566912 09:15:09 INFO - PROCESS | 1650 | 09:15:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:13 INFO - PROCESS | 1650 | RSS: Main: 250560512 09:15:13 INFO - PROCESS | 1650 | 09:15:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:17 INFO - PROCESS | 1650 | RSS: Main: 249872384 09:15:17 INFO - PROCESS | 1650 | 09:15:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:15:20 INFO - PROCESS | 1650 | RSS: Main: 249282560 09:15:20 INFO - PROCESS | 1650 | 09:15:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:15:22 INFO - PROCESS | 1650 | RSS: Main: 248872960 09:15:22 INFO - PROCESS | 1650 | 09:15:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:15:25 INFO - PROCESS | 1650 | RSS: Main: 248905728 09:15:25 INFO - PROCESS | 1650 | 09:15:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:15:28 INFO - PROCESS | 1650 | RSS: Main: 248958976 09:15:28 INFO - PROCESS | 1650 | 09:15:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:15:31 INFO - PROCESS | 1650 | RSS: Main: 249323520 09:15:31 INFO - PROCESS | 1650 | 09:15:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:15:35 INFO - PROCESS | 1650 | RSS: Main: 249090048 09:15:35 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:15:37 INFO - PROCESS | 1650 | RSS: Main: 251023360 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | __start_tp_report 09:15:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:15:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:15:37 INFO - PROCESS | 1650 | |i|pagename|runs| 09:15:37 INFO - PROCESS | 1650 | |0;ai-astar;103;119;118;122;118;120;122;120;119;99 09:15:37 INFO - PROCESS | 1650 | |1;audio-beat-detection;145;114;111;144;142;115;117;112;162;128 09:15:37 INFO - PROCESS | 1650 | |2;audio-dft;229;205;222;270;193;240;192;248;183;265 09:15:37 INFO - PROCESS | 1650 | |3;audio-fft;82;63;78;74;76;73;70;50;82;75 09:15:37 INFO - PROCESS | 1650 | |4;audio-oscillator;79;71;83;94;93;97;96;73;71;81 09:15:37 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;93;85;87;85;114;75;124;119;87;84 09:15:37 INFO - PROCESS | 1650 | |6;imaging-darkroom;99;99;162;160;131;112;104;156;161;127 09:15:37 INFO - PROCESS | 1650 | |7;imaging-desaturate;95;96;91;92;94;106;90;134;86;142 09:15:37 INFO - PROCESS | 1650 | |8;json-parse-financial;62;61;61;63;65;63;63;65;63;62 09:15:37 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;68;89;104;107;102;70;72;71;60;96 09:15:37 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;86;85;84;87;88;88;86;84;89 09:15:37 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;150;139;140;138;145;138;145;151;202;153 09:15:37 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;167;174;165;214;216;167;169;170;167;182 09:15:37 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;68;68;66;67;67;67;66;67;67;68 09:15:37 INFO - PROCESS | 1650 | __end_tp_report 09:15:37 INFO - PROCESS | 1650 | __start_cc_report 09:15:37 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,946 09:15:37 INFO - PROCESS | 1650 | __end_cc_report 09:15:37 INFO - PROCESS | 1650 | __startTimestamp1486142137449__endTimestamp 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:15:37 INFO - PROCESS | 1650 | Number of tests: 14 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:116.00 Median:120.00 stddev:8.08 (6.7%) stddev-sans-first:7.07 09:15:37 INFO - PROCESS | 1650 | Values: 103.0 119.0 118.0 122.0 118.0 120.0 122.0 120.0 119.0 99.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:135.00 stddev:18.01 (13.3%) stddev-sans-first:18.14 09:15:37 INFO - PROCESS | 1650 | Values: 145.0 114.0 111.0 144.0 142.0 115.0 117.0 112.0 162.0 128.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:224.70 Median:234.50 stddev:31.06 (13.2%) stddev-sans-first:32.90 09:15:37 INFO - PROCESS | 1650 | Values: 229.0 205.0 222.0 270.0 193.0 240.0 192.0 248.0 183.0 265.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:72.30 Median:75.50 stddev:9.63 (12.8%) stddev-sans-first:9.55 09:15:37 INFO - PROCESS | 1650 | Values: 82.0 63.0 78.0 74.0 76.0 73.0 70.0 50.0 82.0 75.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:88.00 stddev:10.48 (11.9%) stddev-sans-first:10.97 09:15:37 INFO - PROCESS | 1650 | Values: 79.0 71.0 83.0 94.0 93.0 97.0 96.0 73.0 71.0 81.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:85.00 stddev:17.09 (20.1%) stddev-sans-first:18.11 09:15:37 INFO - PROCESS | 1650 | Values: 93.0 85.0 87.0 85.0 114.0 75.0 124.0 119.0 87.0 84.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:131.10 Median:160.50 stddev:26.83 (16.7%) stddev-sans-first:25.83 09:15:37 INFO - PROCESS | 1650 | Values: 99.0 99.0 162.0 160.0 131.0 112.0 104.0 156.0 161.0 127.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:91.50 stddev:19.45 (21.3%) stddev-sans-first:20.44 09:15:37 INFO - PROCESS | 1650 | Values: 95.0 96.0 91.0 92.0 94.0 106.0 90.0 134.0 86.0 142.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.40 (2.2%) stddev-sans-first:1.45 09:15:37 INFO - PROCESS | 1650 | Values: 62.0 61.0 61.0 63.0 65.0 63.0 63.0 65.0 63.0 62.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:83.90 Median:70.50 stddev:17.52 (24.9%) stddev-sans-first:17.61 09:15:37 INFO - PROCESS | 1650 | Values: 68.0 89.0 104.0 107.0 102.0 70.0 72.0 71.0 60.0 96.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:2.18 (2.5%) stddev-sans-first:1.80 09:15:37 INFO - PROCESS | 1650 | Values: 82.0 86.0 85.0 84.0 87.0 88.0 88.0 86.0 84.0 89.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:147.50 stddev:19.07 (12.9%) stddev-sans-first:20.23 09:15:37 INFO - PROCESS | 1650 | Values: 150.0 139.0 140.0 138.0 145.0 138.0 145.0 151.0 202.0 153.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:172.00 stddev:19.54 (11.4%) stddev-sans-first:20.23 09:15:37 INFO - PROCESS | 1650 | Values: 167.0 174.0 165.0 214.0 216.0 167.0 169.0 170.0 167.0 182.0 09:15:37 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 09:15:37 INFO - PROCESS | 1650 | Values: 68.0 68.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 68.0 09:15:37 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:15:37 INFO - PROCESS | 1650 | 09:15:38 INFO - TEST-INFO | 1650: exit 0 09:15:38 INFO - TEST-OK | kraken | took 61245ms 09:15:38 INFO - SUITE-END | took 1176s 09:15:38 INFO - Completed test suite (00:19:36) 09:15:38 INFO - javascript benchmark 09:15:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7223.925795083389, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.2991671748932, 3362.7309815214785, 3407.02899673593, 3409.7954122752635, 3410.641882602328, 5770.596058275917, 5776.335721392036, 5777.971110144444, 5866.178734977107, 5878.764849406019, 5777.566682498808, 5853.385394533566, 5860.794872179475, 5864.970675146629, 5869.8826023479505, 5237.319148510688, 5313.814016509423, 5318.723506358466, 5336.946630533684, 5369.489898459659, 5319.813806516772, 5348.224507446418, 5367.624266301361, 5370.785168593252, 5377.0321342158395, 5201.985612805504, 5203.42762296149, 5345.518903298703, 5361.571074314065, 5377.11277639189, 5298.894022119555, 5309.707966061885, 5354.625176237665, 5374.973125134388, 5437.184422336642, 5209.192575150858, 5307.681539107666, 5310.309659744247, 5310.548603368718, 5360.410354860962, 5620.156976453523, 5852.531797456193, 5932.614380065282, 5936.020556608154, 5975.223220981288, 5290.841274761763, 6114.966544785233, 6126.639818174547, 6149.262088549358, 6183.96908015457, 6214.751409943642, 6241.968790156066, 6247.281562620311, 6250.9062364064575, 6281.654509002003, 5950.256217972754, 5986.07215881539, 6001.729922153513, 6011.428914253226, 6037.879242415215, 6120.325235636462, 6127.739336776432, 6197.659128747872, 6231.22109736283, 6232.719527621268, 6139.246828488716, 6142.6522545212965, 6187.907181392283, 6196.380361963767, 6224.315325314212, 6199.721012554446, 6206.937930620727, 6216.2540495140875, 6216.937830621727, 6223.0, 6099.451049405486, 6140.289530736369, 6146.354632763496, 6155.384461553898, 6182.505399568024, 5398.514133727984, 5709.800156994568, 5835.503982161564, 6199.752009919643, 6249.156363890907, 4103.281925663056, 4655.3947986761505, 5062.772175252123, 5064.46823083571, 5072.771725272371, 4114.074333274989, 4114.156597897424, 4409.096135292258, 4493.573110554492, 4510.639148868083, 5829.941700583025, 5918.792842250587, 5932.228810254725, 5956.642601443928, 6016.217891674054, 6103.542234332443, 6244.12582238487, 6250.937490625127, 6252.3122456529745, 6257.43683068526, 5701.372848986608, 5835.912461312999, 5859.648421094748, 5863.472287494146, 5900.940990590125, 5550.888982220333, 5552.69460179694, 5553.139263414178, 5563.276774019351, 5577.581681373913, 6322.272938612118, 6356.237251529846, 6359.268684101387, 6380.425761681286, 6381.202349706286, 6128.717018009172, 6133.916185115316, 6140.87237156979, 6153.876922461615, 6249.687515624291, 6235.96882015587, 6294.402031806971, 6298.779542715983, 6302.212223472066, 6313.842153946188, 6132.386761323832, 6187.443130118311, 6195.349488303663, 6219.160413344322, 6224.968875155776, 6115.938840611537, 6123.648682309606, 6152.077188421594, 6191.783287585093, 6222.0, 5136.30659860929, 6162.476189523762, 6193.102000210034, 6194.287656919512, 6200.3489633589625, 6046.637201767908, 6165.753369865155, 6185.350538193425, 6196.690165491617, 6212.192414986023, 5813.680247586254, 5856.238688970407, 5920.79277225295, 6050.092486127116, 6091.42131497507, 6117.248930028793, 6140.201773769381, 6146.555559443438, 6155.876882462415, 6209.96895015522, 6091.786787462417, 6096.110295398481, 6101.237345331833, 6109.070667813169, 6128.203333566607], "value": 5733.035426655597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.7806808867921, 483.9443464001641, 493.6026498668571, 502.1714171616834, 512.2404540403713, 38711.0, 42059.78970105153, 42074.0, 42218.0, 42236.57763422365, 42191.578084219145, 42815.3577696334, 42864.357034644425, 42920.78539607306, 42979.3553096703, 8466.280366168883, 8689.131086891291, 9199.816003679922, 9360.017198194193, 9449.905500944971, 10249.692509224735, 11455.198136130473, 11456.312621242752, 11645.6506304811, 11647.184697071209, 11529.481173347178, 11538.769224615544, 11619.825702614467, 11630.941845290761, 11632.825507617392, 11582.07343412525, 11591.710207244801, 11653.067754579613, 11653.30080195191, 11656.59201927937, 9250.491222982733, 10053.195744340435, 11505.827412588735, 11518.539258429653, 11536.01943834775, 40687.0, 40990.0, 41006.0, 41024.1795164098, 41296.174076518604, 4051.7974101294817, 4098.200850834089, 4150.813213405404, 4153.1486045360625, 4198.895027624303, 29575.260618484495, 29588.40823183546, 29665.555016674767, 29753.702462975525, 29993.0, 2999.0552975812548, 3130.9217269568217, 3152.668969758165, 3366.7474939379645, 3404.489326601005, 356126.0, 356515.0, 358409.0, 359083.0, 359098.9999999974, 61017.694911525155, 62681.373186268465, 63127.0, 63161.36838631647, 63326.683366582874, 58128.0, 58394.70802645959, 58569.0, 58642.4135758637, 58746.41253587495, 16649.0, 16754.916225418794, 16780.328786848633, 16784.412545561092, 16806.915965420096, 11672.766544669059, 12005.399730013465, 12720.872791272153, 13018.218906865619, 13114.0, 14878.70242595142, 16314.184290785413, 16740.49778506647, 16815.91592042032, 16866.831331686528, 5665.603407761417, 5697.259356283656, 5709.914351284734, 5721.141828725725, 5770.480656740913, 879.8196369744315, 897.438457084668, 911.4121391702315, 931.6599441203912, 936.166811537732, 29524.852375738414, 30120.0, 30642.69357306443, 31091.533626995613, 31240.687593124232, 955.8996305387973, 1010.9949450252701, 1062.044160255776, 1114.2367478277406, 1202.2185579373477, 13726.382312795948, 13941.58175254744, 14903.031302965273, 16000.959937604019, 16108.033517988959, 578421.0, 585312.0, 585970.0, 586410.0, 587642.0, 61723.0, 61941.69029154826, 62081.0, 62135.689321554004, 62301.065484017774, 1434.8834586281996, 1439.9136051836713, 1461.400825661495, 1482.547822914, 1491.7165738509866, 27477.17568472949, 29897.850510747307, 29993.850030749705, 30443.2389190272, 30656.233594160323, 50075.49924500854, 50481.49518504768, 50694.0, 50711.74644126903, 50818.74590627023, 529883.3505832446, 530864.0, 531761.3411933071, 534355.0, 534477.0, 40243.597564025156, 40786.9803254921, 40913.795431022656, 41004.79497602493, 41138.0, 41448.79275603723, 46526.6334451744, 47557.048859023314, 50576.0, 51463.97072058613, 35510.28979420449, 35602.64397356097, 36683.81658091692, 38668.80665596654, 39309.606903930595, 35426.64573354233, 35807.0, 36053.63946360503, 36795.89612311635, 36943.63056369509, 35064.47403289004, 35402.82298588491, 35589.82205088958, 35830.56677732861, 35946.64053359433, 28492.57261141126, 30304.090877273717, 32215.355692885543, 32367.51448728318, 32404.675953240167, 21423.67864482065, 22602.869856507437, 22964.655530166725, 24634.384140396633, 25263.74736252614], "value": 19999.153655532795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.63773509503704, 392.6034704948002, 394.17223829957095, 403.3405382200103, 425.9169461954918, 17514.299428022863, 19822.81063136211, 20389.388318350473, 21374.46563835903, 21454.927253637336, 20942.685859712117, 21030.57938841222, 21176.835274059922, 21393.57212855742, 21929.451763705874, 5939.168516407695, 6144.139820425144, 6153.9384606154035, 6207.3792620737795, 6210.50315974721, 5833.533317334624, 6031.788887388942, 6062.181605483247, 6116.694165291739, 6126.448619624233, 5306.3632364116165, 6001.66990815505, 6002.069679199709, 6005.399460054004, 6009.87980240395, 5617.634853734515, 5895.233619629421, 5936.376680448577, 5966.612170208922, 5976.940230597682, 5835.44563266489, 5836.9124463133085, 5861.853453663693, 5880.558958078162, 5883.0, 20031.699524507, 24184.879075604684, 25138.0, 25326.36684082894, 25399.492010159876, 2575.433404650974, 2737.055715778073, 2943.8380889051095, 2948.9557656635166, 2953.2764472704325, 10095.343802652878, 10162.796744065152, 10207.336523126047, 10446.738831529272, 10673.893261067446, 1453.672923592194, 1803.5941913069455, 1812.28414776164, 1824.644194382096, 1837.6875931091747, 98764.51853222208, 126401.0, 126540.36729816384, 132786.0, 132844.3357783205, 9379.390339627902, 10172.440515771556, 11708.648740537797, 12124.636260912186, 12209.816852747215, 14361.21013344276, 14893.851061489464, 15739.13434761099, 15739.370425183093, 15793.21033948298, 8435.325173986066, 8799.868001979976, 8800.8679869802, 8828.205461508494, 8882.555872206363, 7154.35610795031, 8555.187257210555, 8637.136286371438, 8750.824983500293, 8776.473411595325, 4099.508059032935, 4790.592799612003, 4791.496892826272, 4932.0, 4933.975330123327, 1794.2912549543119, 2025.351887396019, 2032.7255820464343, 2053.856230063911, 2066.6693329067275, 391.14534741589716, 399.7201958628971, 410.09369293860306, 1029.1714130057917, 1055.2560444886337, 11316.830247546293, 11482.94258528702, 11493.77012459746, 11525.962663360338, 11740.589079382351, 433.18128736687686, 947.3699989507038, 1015.1168483419325, 1053.6154303679255, 1054.1988089052375, 7046.189688185822, 7128.394086502602, 7193.604351760703, 7211.098612673416, 7500.212477689873, 690215.0, 766009.0, 777280.0, 778841.1057944674, 782685.0, 158686.0, 160934.1953290226, 165527.0, 167083.0, 168272.0, 939.9389039712397, 1075.8117329467311, 1108.229780302698, 1111.3609674437068, 1112.8052590796578, 12421.31682757457, 12828.166169198972, 12903.677408064874, 13066.477340906258, 13128.540501082416, 58970.0, 59487.1076933855, 60025.39974600373, 60927.0, 61359.69320153371, 63907.0, 82337.76493352724, 87779.0, 88889.55555222182, 90089.64865526892, 6962.825929351604, 7151.962965370096, 7569.3566046886635, 7736.92263077362, 7800.804979875322, 8085.474444161346, 12089.335086570323, 13578.185308881499, 13639.659008524866, 13685.657858553615, 9853.408795472295, 11372.658820235407, 11395.943020284845, 11442.885571144516, 11949.820752688891, 5441.891162176814, 7450.627468626655, 11071.892810718864, 11241.775164496501, 11694.356810375511, 10761.437438291516, 11478.94260528692, 11586.131040171853, 11674.824877627012, 11898.583549575724, 7431.219721929119, 8327.125651806473, 8545.352470948128, 8645.438046526955, 8755.474671519729, 8280.751577452686, 10452.738681533023, 11580.305181689126, 11583.189176757545, 11825.0], "value": 9365.374310428591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.1930013041977, 1447.3052934591396, 1451.2743628185908, 1461.1525315317117, 1464.831544372397, 7601.467897247195, 7841.0, 8107.554084525349, 8556.486610803357, 8565.657373705051, 8101.027876654795, 8272.586370681456, 8298.045724741656, 8390.706325278616, 8411.621477033534, 2158.9676154857652, 2328.9767102329015, 2339.3800642829665, 2341.6019276722914, 2342.379269493577, 2084.9791502085013, 2158.104386679526, 2307.1809507624803, 2347.929562113139, 2373.5608912351186, 2256.627656436686, 2332.3935776698013, 2336.0188720737247, 2345.7536958619357, 2352.3648614873973, 2046.7748547659746, 2325.976740232593, 2338.0530884991604, 2343.554724602337, 2364.2670772060715, 2321.257197696738, 2341.379534423362, 2367.4673198530195, 2370.798482129021, 2374.1097088591778, 8470.788230294293, 8510.0, 8524.019737730116, 8527.360447966428, 8529.573521323971, 5165.767540460688, 5282.128448805943, 5288.0, 5293.206019097128, 5308.283381743454, 3103.7982531135403, 3396.4056290149374, 3483.3555792178277, 3525.206828463575, 3533.028417185269, 1178.917475776696, 1192.7793358228669, 1224.7183147875949, 1252.943617537213, 1255.0210835548287, 9756.024397560259, 10816.026557609854, 10922.29005114665, 10941.179411544166, 10963.451827408599, 4046.4132700758223, 4209.621134097946, 4616.307553866947, 4765.428148622187, 4786.401699787527, 9607.56765945534, 9671.758206044906, 9688.660896868576, 9736.0, 9739.610415583438, 5209.479052094836, 5279.944011197776, 5303.124984377611, 5328.387235467893, 5330.093884039723, 4067.633912947849, 4628.375169352162, 4792.0, 4799.928001079987, 4857.028594281158, 3389.6610338966398, 3932.9606703932595, 3997.4403583498333, 4007.779572123561, 4039.3940908863906, 1187.5724739093919, 1208.7461633057158, 1229.2010193374379, 1232.2236990695803, 1312.2848047813964, 767.7389687506275, 792.3621484704868, 803.6182813163817, 830.5556527257888, 837.3217693668148, 5503.587230957694, 5647.943520564824, 5655.943440565542, 5705.1727499512335, 5778.479936805707, 993.1707024634367, 1009.7980403919246, 1021.7803172317987, 1028.6913925822223, 1050.9018076110483, 3519.7856739424856, 3591.9281614367565, 3691.8892433227047, 3741.8129093545213, 3812.046988252937, 7499.8500029999095, 10106.848397274047, 10134.23993200498, 10138.898611013943, 10148.188144948386, 10002.899971000343, 10003.549840257207, 10006.349587276804, 10016.29885907994, 10019.849702254473, 7539.547627142389, 7839.412044096715, 7945.9670242869215, 7946.880796788053, 8056.476329038594, 5731.713414329351, 5785.161151633074, 5854.034084376201, 5866.6186697864505, 5868.354481007171, 9016.729498115066, 9103.0, 9231.76920576991, 9382.765430864283, 9395.577199026196, 9114.589843456928, 9272.953635231781, 9362.625494980397, 9436.858447123435, 9489.952550237205, 7121.430285577245, 7190.316919892602, 7263.854722905618, 7301.634918254173, 7383.446241532014, 7890.092639346549, 7960.442769006114, 7982.521048737094, 7985.361171106181, 7997.200279971957, 7084.929150708427, 7177.318154775288, 7189.856202876018, 7190.96404517974, 7343.082114735658, 7052.753153639598, 7053.541519801196, 7101.0, 7109.075820143348, 7203.135623725187, 6433.485321174388, 6444.420002199825, 6530.67346632676, 6535.57518761279, 6542.149520562297, 5026.52248036436, 5034.219695947134, 5085.7457127144235, 5106.540411362995, 5116.488351165002, 5021.573166280907, 5072.923906141337, 5142.948570514397, 5155.690658560498, 5192.870178245574], "value": 4441.770357565829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.56354838226406, 357.99284014319716, 369.61190749712796, 371.7899386846432, 372.73908264215055, 4637.860864174072, 4909.502601706483, 5006.574441172495, 5383.407825139231, 5568.860778480535, 4799.536141476849, 4827.813642995624, 5200.061964989778, 5413.0, 5474.39781624022, 4133.834646614132, 4257.489101307832, 4263.765492897889, 4292.248856450125, 4304.634106100985, 3641.47198656196, 3752.9061773455746, 4295.548967358429, 4309.978450107761, 4325.199838029959, 3498.3762178366223, 3760.3043436964113, 4075.266452038632, 4097.590240975894, 4126.360414135799, 3246.9837650811833, 3778.263238668461, 4073.2668119738437, 4092.2224777292367, 4134.297169481165, 3360.663933606644, 3543.85824567017, 3569.250457403948, 3574.946375804365, 3589.6051434342203, 5062.367204099488, 5101.234814777776, 5253.50091741284, 5285.603579731535, 5379.0, 4107.383892416162, 4682.578567928868, 4705.494241842612, 4787.904241915142, 4792.7124372537755, 4772.594329481998, 5316.149416093445, 5718.0, 5764.8847023059725, 5803.0, 3860.1893602343544, 3910.2570511602703, 4103.117829666636, 4166.7708276044805, 4176.749395036308, 5159.182205168148, 5571.526420254283, 6066.7249781332, 6156.445919867234, 6198.938010619926, 3689.262147570497, 4291.0, 4305.225059489322, 4338.74385319632, 4382.452193475816, 3762.0030691866677, 4254.659627229814, 4303.268444364466, 4328.199283132631, 4361.084172323847, 4026.8187931543152, 4226.957730422718, 4932.309476673268, 4937.851864444073, 4971.130052240844, 5401.675899446046, 5693.743781529841, 5722.54219662426, 5766.711664416846, 5781.057196097277, 1261.438659796382, 1338.9397477113553, 1342.6576223063057, 1345.3206130904027, 1376.511338474847, 971.8882328532309, 974.3179774157976, 1011.2769369900557, 1012.1801340913884, 1021.8671572695501, 4362.825486980549, 4701.694389864648, 5010.774515146827, 5148.3010606499765, 5220.712860792617, 4818.807247710122, 5304.825021741068, 5333.359996800409, 5542.251796007568, 5739.62692424991, 4476.798544065525, 4674.6026587740425, 4922.114019476457, 5148.227765835155, 5163.457836927144, 2665.65346504957, 2684.3825920038503, 2731.890724371043, 2874.8275103493856, 3034.8482575871117, 5181.300524429229, 5390.67655940637, 5404.97329489525, 5691.857703557362, 5955.612885162451, 4955.058538877602, 5432.728363581805, 5789.56578256624, 5853.5317174625925, 5917.792877249276, 5353.732313384316, 5915.378885217162, 5934.495567876693, 5945.791897283488, 5954.46409823118, 5283.788648454019, 5638.464345887134, 5717.714114294352, 5718.285214348207, 5737.0, 5275.920861187008, 5612.158176273429, 5670.319561652628, 5678.346990096192, 5689.829305120687, 4919.778609962632, 5230.4694331325445, 5313.495217954288, 5922.911156332744, 5953.493953013869, 3583.6595523426276, 4008.8797336079965, 4036.829319497313, 4118.5057793065025, 4154.172164247721, 4851.636127290538, 5292.232626269247, 5433.4566543345345, 5721.369409718377, 5733.655980641175, 4649.674522783373, 5424.589606702207, 5425.348958125051, 5636.633618814764, 5819.6508209507565, 5755.65466072037, 5794.275715535558, 5794.567156125483, 5804.24544809189, 5846.0, 4341.891452713708, 4449.7330160190495, 5604.551635869039, 5632.633878797865, 5647.15292706081, 4852.078105160008, 5167.896642067213, 5785.537157027344, 5789.321096882026, 5824.301083869963, 5071.670341427795, 5098.439171691037, 5109.0, 5663.348714897839, 5668.0], "value": 4156.251243940155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3229737964657, 680.9250982391939, 764.6559048428209, 770.7841804294796, 857.2499063319596, 14858.554243372702, 15704.450344237954, 15707.450239241629, 15724.921375393122, 15770.0, 14262.286885655702, 14425.42298308069, 14553.927230363859, 14580.781288280685, 14597.927010364934, 748.6743266679013, 787.1341524323255, 810.9553974531399, 882.8278485695292, 888.0497867282011, 737.9889301660453, 782.5304817109745, 867.7787164273133, 876.8246350729879, 882.192793593864, 920.5029284186564, 931.4690626342987, 931.65063101337, 934.1405906565975, 934.22926085979, 907.9001309855944, 925.9305552083554, 927.777333439973, 927.8376284150247, 929.2333824594668, 679.5345188545813, 691.920429150649, 692.5636848785283, 693.2443636436258, 694.7672529702555, 12491.500339986389, 12552.937235313857, 12562.30907300098, 13011.86988130116, 13703.862961370358, 11744.354060526668, 11826.408679565988, 11862.703432414173, 11943.34311612861, 12331.691707707289, 10362.533685984148, 10668.466576671213, 10689.679309620724, 10749.677509674722, 11104.44477776116, 3590.066582688494, 3621.2938476996997, 3635.0, 3641.289948460051, 3644.0, 101335.0, 103142.96857031409, 103193.4520982186, 103277.0, 103501.9299614011, 8723.694670686495, 8815.735527934172, 8940.50827204497, 8957.104289571122, 9105.907291124975, 18941.242350306107, 18969.43091707251, 18990.525236869187, 19037.524061898563, 19127.33054343091, 7743.4966727162555, 7848.607569621496, 7857.803554911058, 7902.802429939297, 7956.323712484504, 4196.454460920061, 4221.134667393177, 4231.640310573574, 4310.288802347577, 4474.082813023388, 3310.371029504435, 3540.8937731868086, 3616.258666973264, 3674.5590529136675, 3706.05495598626, 619.5198720991268, 647.9254885688206, 655.073071603685, 657.8158115727604, 658.8583454557197, 674.7402250133733, 703.3283214530112, 719.3274288540127, 727.4544091931052, 764.144158542436, 8885.0, 10193.847092293621, 10303.278770485995, 10395.84406233907, 10499.422531760674, 667.2526770017612, 697.3619138488226, 698.4098436820879, 699.5068476723898, 701.9122609673791, 4893.486183950705, 4900.26496025599, 5110.974445127825, 5134.512221338967, 5157.406898206679, 90442.0, 108433.45783271191, 109708.90291096987, 111982.44008780067, 113688.0, 71181.28818711746, 74278.0, 75633.0, 79264.01839953932, 87031.12968870357, 71943.0, 74063.62968185017, 76384.61807691037, 77993.0, 79338.0, 9071.773205669911, 9303.488308142847, 9750.902490974999, 10904.34573925567, 11315.547378104784, 43001.0, 43762.905927350796, 44628.0, 46773.53226467828, 47840.0, 61382.38617613767, 64011.399715007494, 64496.35503644904, 65075.34924650882, 65636.6718166406, 11525.135614828754, 11529.481173347052, 11544.538218471167, 11576.768464630828, 11692.298462092302, 12081.0, 12210.023198144305, 12245.204061735958, 12589.118761686594, 13036.413361398949, 11445.942770286096, 11574.594889178838, 11958.58144964922, 12394.81407778866, 12404.19372740805, 11733.88266117362, 11890.167688262085, 11923.463444144862, 11993.220440671328, 12436.440360183633, 11551.844815518381, 11585.768284634092, 11836.46735896904, 11853.822192666945, 12350.3824808761, 9938.950305248427, 9956.950215248877, 10122.8481572775, 10140.340877842917, 10323.174146068446, 9723.902760972584, 9738.163558106236, 9761.853572196565, 9822.950885245527, 9829.459379734184], "value": 7168.270957449013, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 119.0, 118.0, 122.0, 118.0, 120.0, 122.0, 120.0, 119.0, 99.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 111.0, 144.0, 142.0, 115.0, 117.0, 112.0, 162.0, 128.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 205.0, 222.0, 270.0, 193.0, 240.0, 192.0, 248.0, 183.0, 265.0], "value": 224.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 63.0, 78.0, 74.0, 76.0, 73.0, 70.0, 50.0, 82.0, 75.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 83.0, 94.0, 93.0, 97.0, 96.0, 73.0, 71.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 87.0, 85.0, 114.0, 75.0, 124.0, 119.0, 87.0, 84.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 162.0, 160.0, 131.0, 112.0, 104.0, 156.0, 161.0, 127.0], "value": 131.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 91.0, 92.0, 94.0, 106.0, 90.0, 134.0, 86.0, 142.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 65.0, 63.0, 63.0, 65.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 89.0, 104.0, 107.0, 102.0, 70.0, 72.0, 71.0, 60.0, 96.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 85.0, 84.0, 87.0, 88.0, 88.0, 86.0, 84.0, 89.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 139.0, 140.0, 138.0, 145.0, 138.0, 145.0, 151.0, 202.0, 153.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 165.0, 214.0, 216.0, 167.0, 169.0, 170.0, 167.0, 182.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0], "value": 67.1, "unit": "score"}]}]} 09:15:38 INFO - Return code: 0 09:15:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:15:38 ERROR - # TBPL SUCCESS # 09:15:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:15:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:15:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:15:38 INFO - 2017-02-03 09:15:38.794 screenresolution[1655:10408] starting screenresolution argv=screenresolution get 09:15:38 INFO - 2017-02-03 09:15:38.799 screenresolution[1655:10408] Display 0: 1600x1200x32@60 09:15:38 INFO - 2017-02-03 09:15:38.805 screenresolution[1656:10411] starting screenresolution argv=screenresolution list 09:15:38 INFO - Available Modes on Display 0 09:15:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:15:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:15:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:15:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:15:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:15:39 INFO - Intel Iris: 09:15:39 INFO - Chipset Model: Intel Iris 09:15:39 INFO - Type: GPU 09:15:39 INFO - Bus: Built-In 09:15:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:15:39 INFO - Vendor: Intel (0x8086) 09:15:39 INFO - Device ID: 0x0a2e 09:15:39 INFO - Revision ID: 0x0009 09:15:39 INFO - Displays: 09:15:39 INFO - Display: 09:15:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:15:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:15:39 INFO - Display Serial Number: 1600x1200 60 09:15:39 INFO - Main Display: Yes 09:15:39 INFO - Mirror: Off 09:15:39 INFO - Online: Yes 09:15:39 INFO - Rotation: Supported 09:15:39 INFO - Return code: 0 09:15:39 INFO - Running post-action listener: _resource_record_post_action 09:15:39 INFO - [mozharness: 2017-02-03 17:15:39.051653Z] Finished run-tests step (success) 09:15:39 INFO - Running post-run listener: _resource_record_post_run 09:15:39 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 37620224; Write bytes: 507970560; Read time: 379; Write time: 1606 09:15:39 INFO - TinderboxPrint: CPU usage
54.7% 09:15:39 INFO - TinderboxPrint: I/O read bytes / time
37,620,224 / 379 09:15:39 INFO - TinderboxPrint: I/O write bytes / time
507,970,560 / 1,606 09:15:39 INFO - TinderboxPrint: CPU idle
2,171.7 (45.3%) 09:15:39 INFO - TinderboxPrint: CPU system
971.0 (20.3%) 09:15:39 INFO - TinderboxPrint: CPU user
1,647.0 (34.4%) 09:15:39 INFO - TinderboxPrint: Swap in / out
245,403,648 / 0 09:15:39 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205371904; Write bytes: 198742016; Read time: 15757; Write time: 357 09:15:39 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 35523072; Write bytes: 298271744; Read time: 355; Write time: 1219 09:15:39 INFO - Running post-run listener: _upload_blobber_files 09:15:39 INFO - Blob upload gear active. 09:15:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:15:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:41 INFO - (blobuploader) - INFO - Done attempting. 09:15:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:15:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:15:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:42 INFO - (blobuploader) - INFO - Done attempting. 09:15:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:15:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:15:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:42 INFO - (blobuploader) - INFO - Done attempting. 09:15:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:15:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:45 INFO - (blobuploader) - INFO - Done attempting. 09:15:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:45 INFO - Return code: 0 09:15:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b58b683030665faae90d2c355e6652f09866c13f6abb1ffc86aecab9feb73fdbc79e2439a6b10ed85303a24f2ba650e29655f1fd57453309fa67a852ce25", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5fb1200a7f9a0ae5e6bbe493a230e1c77c36ed22cb2975cb107b60559a5d64db5c3e04dbe7f2e8d45a74b0f8f9025b62bbc2dbea09aa680811e23c8cd9b7ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39550fe2326227482df74a890d7c65f78dc782b5f397a08d2c49ebe4b9c5c6400104ba92db0b8320ca443830c3e8c483e4d41399a15f888672d56c48c656c9cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9de8857f11c5c3b2004b5f1746f7912edea5eaec293d185aecc13342dc53abefa157bce0cc20732bd75f871dc04c1a5a59acfc49a01b9f04ef931d16b00f2ccf"} 09:15:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:45 INFO - Contents: 09:15:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b58b683030665faae90d2c355e6652f09866c13f6abb1ffc86aecab9feb73fdbc79e2439a6b10ed85303a24f2ba650e29655f1fd57453309fa67a852ce25", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5fb1200a7f9a0ae5e6bbe493a230e1c77c36ed22cb2975cb107b60559a5d64db5c3e04dbe7f2e8d45a74b0f8f9025b62bbc2dbea09aa680811e23c8cd9b7ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39550fe2326227482df74a890d7c65f78dc782b5f397a08d2c49ebe4b9c5c6400104ba92db0b8320ca443830c3e8c483e4d41399a15f888672d56c48c656c9cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9de8857f11c5c3b2004b5f1746f7912edea5eaec293d185aecc13342dc53abefa157bce0cc20732bd75f871dc04c1a5a59acfc49a01b9f04ef931d16b00f2ccf"} 09:15:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:15:45 INFO - Copying logs to upload dir... 09:15:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:15:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.574007 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 09:15:45.439535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 09:15:45.442707) ========= 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.SLQxpIkaIY/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.GSFuDyE4h2/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/Mozilla-Aurora/sha512/df08b58b683030665faae90d2c355e6652f09866c13f6abb1ffc86aecab9feb73fdbc79e2439a6b10ed85303a24f2ba650e29655f1fd57453309fa67a852ce25", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5fb1200a7f9a0ae5e6bbe493a230e1c77c36ed22cb2975cb107b60559a5d64db5c3e04dbe7f2e8d45a74b0f8f9025b62bbc2dbea09aa680811e23c8cd9b7ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39550fe2326227482df74a890d7c65f78dc782b5f397a08d2c49ebe4b9c5c6400104ba92db0b8320ca443830c3e8c483e4d41399a15f888672d56c48c656c9cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9de8857f11c5c3b2004b5f1746f7912edea5eaec293d185aecc13342dc53abefa157bce0cc20732bd75f871dc04c1a5a59acfc49a01b9f04ef931d16b00f2ccf"} build_url:https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/INP2z2pfSuyuAuGzNbBCvA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b58b683030665faae90d2c355e6652f09866c13f6abb1ffc86aecab9feb73fdbc79e2439a6b10ed85303a24f2ba650e29655f1fd57453309fa67a852ce25", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c5fb1200a7f9a0ae5e6bbe493a230e1c77c36ed22cb2975cb107b60559a5d64db5c3e04dbe7f2e8d45a74b0f8f9025b62bbc2dbea09aa680811e23c8cd9b7ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39550fe2326227482df74a890d7c65f78dc782b5f397a08d2c49ebe4b9c5c6400104ba92db0b8320ca443830c3e8c483e4d41399a15f888672d56c48c656c9cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9de8857f11c5c3b2004b5f1746f7912edea5eaec293d185aecc13342dc53abefa157bce0cc20732bd75f871dc04c1a5a59acfc49a01b9f04ef931d16b00f2ccf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 09:15:45.476458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:15:45.476793) ========= 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.SLQxpIkaIY/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.GSFuDyE4h2/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.005070 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:15:45.525206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 09:15:45.525532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 09:15:45.525856) ========= ========= Total master_lag: 0.18 =========