builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0352 starttime: 1471282476.74 results: success (0) buildid: 20160815090617 builduid: d037a83799964237a4bf8b4d13a9b1ba revision: e88a4b19b2d189e21d779326c9de56c52f7377f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.737301) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.737748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.738127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.844750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.845087) ========= 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.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-15 10:34:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.8M=0s 2016-08-15 10:34:36 (56.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122343 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:36.999487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:37.000007) ========= 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.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.020282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:37.053381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 10:34:37.053766) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e88a4b19b2d189e21d779326c9de56c52f7377f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e88a4b19b2d189e21d779326c9de56c52f7377f9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-15 10:34:37,135 truncating revision to first 12 chars 2016-08-15 10:34:37,135 Setting DEBUG logging. 2016-08-15 10:34:37,135 attempt 1/10 2016-08-15 10:34:37,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e88a4b19b2d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 10:34:38,636 unpacking tar archive at: autoland-e88a4b19b2d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 10:34:38.835541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:38.835886) ========= script_repo_revision: e88a4b19b2d189e21d779326c9de56c52f7377f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:38.836307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:38.836638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 10:34:38.854456) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-15 10:34:38.854806) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:34:39 INFO - MultiFileLogger online at 20160815 10:34:39 in /builds/slave/test 10:34:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:34:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:39 INFO - {'append_to_log': False, 10:34:39 INFO - 'base_work_dir': '/builds/slave/test', 10:34:39 INFO - 'blob_upload_branch': 'Autoland', 10:34:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:39 INFO - 'branch': 'Autoland', 10:34:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:39 INFO - 'config_files': ('talos/mac_config.py',), 10:34:39 INFO - 'default_actions': ('clobber', 10:34:39 INFO - 'read-buildbot-config', 10:34:39 INFO - 'download-and-extract', 10:34:39 INFO - 'populate-webroot', 10:34:39 INFO - 'create-virtualenv', 10:34:39 INFO - 'install', 10:34:39 INFO - 'run-tests'), 10:34:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:39 INFO - 'download_minidump_stackwalk': True, 10:34:39 INFO - 'download_symbols': 'ondemand', 10:34:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:39 INFO - 'installer_path': 'installer.exe', 10:34:39 INFO - 'log_level': 'info', 10:34:39 INFO - 'log_name': 'talos', 10:34:39 INFO - 'log_to_console': True, 10:34:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:34:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:34:39 INFO - 'opt_config_files': (), 10:34:39 INFO - 'pip_index': False, 10:34:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:39 INFO - 'cmd': ('bash', 10:34:39 INFO - '-c', 10:34:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:39 INFO - 'enabled': True, 10:34:39 INFO - 'halt_on_failure': False, 10:34:39 INFO - 'name': 'check_screen_resolution'},), 10:34:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:39 INFO - 'cmd': ('bash', 10:34:39 INFO - '-c', 10:34:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:39 INFO - 'enabled': True, 10:34:39 INFO - 'halt_on_failure': False, 10:34:39 INFO - 'name': 'check_screen_resolution'},), 10:34:39 INFO - 'run_cmd_checks_enabled': True, 10:34:39 INFO - 'sps_profile': False, 10:34:39 INFO - 'sps_profile_interval': 0, 10:34:39 INFO - 'suite': 'dromaeojs', 10:34:39 INFO - 'system_bits': '32', 10:34:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:39 INFO - 'title': 't-yosemite-r7-0352', 10:34:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:39 INFO - 'use_talos_json': True, 10:34:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:39 INFO - 'work_dir': 'build'} 10:34:39 INFO - [mozharness: 2016-08-15 17:34:39.046908Z] Running clobber step. 10:34:39 INFO - Running pre-action listener: _resource_record_pre_action 10:34:39 INFO - Running main action method: clobber 10:34:39 INFO - rmtree: /builds/slave/test/build 10:34:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:39 INFO - Running post-action listener: _resource_record_post_action 10:34:39 INFO - [mozharness: 2016-08-15 17:34:39.923651Z] Finished clobber step (success) 10:34:39 INFO - [mozharness: 2016-08-15 17:34:39.923788Z] Running read-buildbot-config step. 10:34:39 INFO - Running pre-action listener: _resource_record_pre_action 10:34:39 INFO - Running main action method: read_buildbot_config 10:34:39 INFO - Using buildbot properties: 10:34:39 INFO - { 10:34:39 INFO - "project": "", 10:34:39 INFO - "product": "firefox", 10:34:39 INFO - "script_repo_revision": "production", 10:34:39 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 10:34:39 INFO - "repository": "", 10:34:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 10:34:39 INFO - "buildid": "20160815090617", 10:34:39 INFO - "pgo_build": "False", 10:34:39 INFO - "basedir": "/builds/slave/test", 10:34:39 INFO - "buildnumber": 114, 10:34:39 INFO - "slavename": "t-yosemite-r7-0352", 10:34:39 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:34:39 INFO - "platform": "yosemite_r7", 10:34:39 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:34:39 INFO - "branch": "autoland", 10:34:39 INFO - "repo_path": "integration/autoland", 10:34:39 INFO - "revision": "e88a4b19b2d189e21d779326c9de56c52f7377f9", 10:34:39 INFO - "stage_platform": "macosx64", 10:34:39 INFO - "builduid": "d037a83799964237a4bf8b4d13a9b1ba", 10:34:39 INFO - "slavebuilddir": "test" 10:34:39 INFO - } 10:34:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:34:39 INFO - Running post-action listener: _resource_record_post_action 10:34:39 INFO - [mozharness: 2016-08-15 17:34:39.927081Z] Finished read-buildbot-config step (success) 10:34:39 INFO - [mozharness: 2016-08-15 17:34:39.927204Z] Running download-and-extract step. 10:34:39 INFO - Running pre-action listener: _resource_record_pre_action 10:34:39 INFO - Running main action method: download_and_extract 10:34:39 INFO - mkdir: /builds/slave/test/build/tests 10:34: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')]} 10:34:39 INFO - trying https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:34:39 INFO - Downloading https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:34:40 INFO - Downloaded 1199 bytes. 10:34:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:34:40 INFO - Using the following test package requirements: 10:34:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:34:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:34:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:34:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'jsshell-mac.zip'], 10:34:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:34:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:34:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:34:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:34:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:34:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:34:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:34:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:34: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')]} 10:34:40 INFO - trying https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:34:40 INFO - Downloading https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:34:41 INFO - Downloaded 16331657 bytes. 10:34:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:34:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:34:48 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')]} 10:34:48 INFO - trying https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:34:48 INFO - Downloading https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:34:49 INFO - Downloaded 16331657 bytes. 10:34:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:56 INFO - trying https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:34:58 INFO - Downloaded 14413719 bytes. 10:34:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:59 INFO - trying https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:34:59 INFO - Downloading https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:35:02 INFO - Downloaded 111030973 bytes. 10:35:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:35:02 INFO - mkdir: /builds/slave/test/properties 10:35:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:02 INFO - Contents: 10:35:02 INFO - build_url:https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:35:02 INFO - Running post-action listener: _resource_record_post_action 10:35:02 INFO - Running post-action listener: set_extra_try_arguments 10:35:02 INFO - [mozharness: 2016-08-15 17:35:02.993377Z] Finished download-and-extract step (success) 10:35:02 INFO - [mozharness: 2016-08-15 17:35:02.993478Z] Running populate-webroot step. 10:35:02 INFO - Running pre-action listener: _resource_record_pre_action 10:35:02 INFO - Running main action method: populate_webroot 10:35:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:03 INFO - '--tppagecycles', 10:35:03 INFO - '7'], 10:35:03 INFO - 'tests': ['tsvgm']}}, 10:35:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['damp', 'tps']}, 10:35:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'tests': ['damp', 'tps']}, 10:35:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['dromaeo_dom']}, 10:35:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['basic_compositor_video']}, 10:35:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:35:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['a11yr', 10:35:03 INFO - 'ts_paint', 10:35:03 INFO - 'tpaint', 10:35:03 INFO - 'sessionrestore', 10:35:03 INFO - 'sessionrestore_no_auto_restore', 10:35:03 INFO - 'tabpaint']}, 10:35:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['tsvgx', 10:35:03 INFO - 'tsvgr_opacity', 10:35:03 INFO - 'tart', 10:35:03 INFO - 'tscrollx', 10:35:03 INFO - 'cart']}, 10:35:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:03 INFO - 'tsvgr_opacity', 10:35:03 INFO - 'tart', 10:35:03 INFO - 'tscrollx', 10:35:03 INFO - 'cart']}, 10:35:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'talos_options': ['--disable-e10s'], 10:35:03 INFO - 'tests': ['tp5o']}, 10:35:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'tests': ['tp5o']}, 10:35:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'talos_options': ['--disable-e10s', 10:35:03 INFO - '--xperf_path', 10:35:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:03 INFO - 'tests': ['tp5n']}, 10:35:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:03 INFO - 'talos_options': ['--xperf_path', 10:35:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:03 INFO - 'tests': ['tp5n']}}, 10:35:03 INFO - 'talos.zip': {'path': '', 10:35:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:03 INFO - Running post-action listener: _resource_record_post_action 10:35:03 INFO - [mozharness: 2016-08-15 17:35:03.012451Z] Finished populate-webroot step (success) 10:35:03 INFO - [mozharness: 2016-08-15 17:35:03.012594Z] Running create-virtualenv step. 10:35:03 INFO - Running pre-action listener: _resource_record_pre_action 10:35:03 INFO - Running main action method: create_virtualenv 10:35:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:03 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 10:35:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:03 INFO - Using real prefix '/tools/python27' 10:35:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:06 INFO - Installing pip.................done. 10:35:06 INFO - Return code: 0 10:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:06 INFO - 'HOME': '/Users/cltbld', 10:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:06 INFO - 'LOGNAME': 'cltbld', 10:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:06 INFO - 'MOZ_NO_REMOTE': '1', 10:35:06 INFO - 'NO_EM_RESTART': '1', 10:35:06 INFO - 'PAGER': '/bin/cat', 10:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:06 INFO - 'PWD': '/builds/slave/test', 10:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:06 INFO - 'SHELL': '/bin/bash', 10:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:06 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:06 INFO - 'USER': 'cltbld', 10:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:06 INFO - 'XPC_FLAGS': '0x0', 10:35:06 INFO - 'XPC_SERVICE_NAME': '0', 10:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:35:06 INFO - Cleaning up... 10:35:07 INFO - Return code: 0 10:35:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:07 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:07 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 10:35:07 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 10:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:07 INFO - 'HOME': '/Users/cltbld', 10:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:07 INFO - 'LOGNAME': 'cltbld', 10:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:07 INFO - 'MOZ_NO_REMOTE': '1', 10:35:07 INFO - 'NO_EM_RESTART': '1', 10:35:07 INFO - 'PAGER': '/bin/cat', 10:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:07 INFO - 'PWD': '/builds/slave/test', 10:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:07 INFO - 'SHELL': '/bin/bash', 10:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:07 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:07 INFO - 'USER': 'cltbld', 10:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:07 INFO - 'XPC_FLAGS': '0x0', 10:35:07 INFO - 'XPC_SERVICE_NAME': '0', 10:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:07 INFO - Downloading/unpacking psutil>=3.1.1 10:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:11 INFO - Installing collected packages: psutil 10:35:11 INFO - Running setup.py install for psutil 10:35:11 INFO - building 'psutil._psutil_osx' extension 10:35:11 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 10:35:11 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 10:35:11 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 10:35:11 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 10:35:11 INFO - building 'psutil._psutil_posix' extension 10:35:11 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 10:35:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:35:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:35:11 INFO - ^ 10:35:11 INFO - 1 warning generated. 10:35:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:35:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:11 INFO - Successfully installed psutil 10:35:11 INFO - Cleaning up... 10:35:12 INFO - Return code: 0 10:35:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:12 INFO - 'HOME': '/Users/cltbld', 10:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:12 INFO - 'LOGNAME': 'cltbld', 10:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:12 INFO - 'MOZ_NO_REMOTE': '1', 10:35:12 INFO - 'NO_EM_RESTART': '1', 10:35:12 INFO - 'PAGER': '/bin/cat', 10:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:12 INFO - 'PWD': '/builds/slave/test', 10:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:12 INFO - 'SHELL': '/bin/bash', 10:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:12 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:12 INFO - 'USER': 'cltbld', 10:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:12 INFO - 'XPC_FLAGS': '0x0', 10:35:12 INFO - 'XPC_SERVICE_NAME': '0', 10:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:14 INFO - Installing collected packages: mozsystemmonitor 10:35:14 INFO - Running setup.py install for mozsystemmonitor 10:35:14 INFO - Successfully installed mozsystemmonitor 10:35:14 INFO - Cleaning up... 10:35:15 INFO - Return code: 0 10:35:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:15 INFO - 'HOME': '/Users/cltbld', 10:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:15 INFO - 'LOGNAME': 'cltbld', 10:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:15 INFO - 'MOZ_NO_REMOTE': '1', 10:35:15 INFO - 'NO_EM_RESTART': '1', 10:35:15 INFO - 'PAGER': '/bin/cat', 10:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:15 INFO - 'PWD': '/builds/slave/test', 10:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:15 INFO - 'SHELL': '/bin/bash', 10:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:15 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:15 INFO - 'USER': 'cltbld', 10:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:15 INFO - 'XPC_FLAGS': '0x0', 10:35:15 INFO - 'XPC_SERVICE_NAME': '0', 10:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:18 INFO - warning: no files found matching '*.txt' 10:35:18 INFO - no previously-included directories found matching 'build' 10:35:18 INFO - no previously-included directories found matching 'dist' 10:35:18 INFO - no previously-included directories found matching '.git*' 10:35:18 INFO - Installing collected packages: jsonschema, functools32 10:35:18 INFO - Running setup.py install for functools32 10:35:18 INFO - warning: no files found matching '*.txt' 10:35:18 INFO - no previously-included directories found matching 'build' 10:35:18 INFO - no previously-included directories found matching 'dist' 10:35:18 INFO - no previously-included directories found matching '.git*' 10:35:18 INFO - Successfully installed jsonschema functools32 10:35:18 INFO - Cleaning up... 10:35:18 INFO - Return code: 0 10:35:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:35:18 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')]} 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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')]} 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:18 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 10:35:18 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 10:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:18 INFO - 'HOME': '/Users/cltbld', 10:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:18 INFO - 'LOGNAME': 'cltbld', 10:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:18 INFO - 'MOZ_NO_REMOTE': '1', 10:35:18 INFO - 'NO_EM_RESTART': '1', 10:35:18 INFO - 'PAGER': '/bin/cat', 10:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:18 INFO - 'PWD': '/builds/slave/test', 10:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:18 INFO - 'SHELL': '/bin/bash', 10:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:18 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:18 INFO - 'USER': 'cltbld', 10:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:18 INFO - 'XPC_FLAGS': '0x0', 10:35:18 INFO - 'XPC_SERVICE_NAME': '0', 10:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:35:18 INFO - Cleaning up... 10:35:18 INFO - Return code: 0 10:35:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:18 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')]} 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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')]} 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:18 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:18 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 10:35:18 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 10:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:18 INFO - 'HOME': '/Users/cltbld', 10:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:18 INFO - 'LOGNAME': 'cltbld', 10:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:18 INFO - 'MOZ_NO_REMOTE': '1', 10:35:18 INFO - 'NO_EM_RESTART': '1', 10:35:18 INFO - 'PAGER': '/bin/cat', 10:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:18 INFO - 'PWD': '/builds/slave/test', 10:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:18 INFO - 'SHELL': '/bin/bash', 10:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:18 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:18 INFO - 'USER': 'cltbld', 10:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:18 INFO - 'XPC_FLAGS': '0x0', 10:35:18 INFO - 'XPC_SERVICE_NAME': '0', 10:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:21 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 10:35:21 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 10:35:21 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 10:35:21 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 10:35:21 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 10:35:21 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 10:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:22 INFO - Downloading docopt-0.6.1.tar.gz 10:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:22 INFO - Running setup.py install for blobuploader 10:35:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:22 INFO - Running setup.py install for requests 10:35:23 INFO - Running setup.py install for docopt 10:35:23 INFO - Successfully installed blobuploader requests docopt 10:35:23 INFO - Cleaning up... 10:35:23 INFO - Return code: 0 10:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:23 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:23 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 10:35:23 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 10:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:23 INFO - 'HOME': '/Users/cltbld', 10:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:23 INFO - 'LOGNAME': 'cltbld', 10:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:23 INFO - 'MOZ_NO_REMOTE': '1', 10:35:23 INFO - 'NO_EM_RESTART': '1', 10:35:23 INFO - 'PAGER': '/bin/cat', 10:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:23 INFO - 'PWD': '/builds/slave/test', 10:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:23 INFO - 'SHELL': '/bin/bash', 10:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:23 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:23 INFO - 'USER': 'cltbld', 10:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:23 INFO - 'XPC_FLAGS': '0x0', 10:35:23 INFO - 'XPC_SERVICE_NAME': '0', 10:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:23 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-zDmJ_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:23 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-fBHUlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:23 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-cJaj9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-nUfyEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-FBK6Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-P8yOWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-PEfIQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-HCnQZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Ip9tLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ni3ZQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ffu4SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Qj67IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-MJFcPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-lZfWsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-xmbIww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-aRd3oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-NSWEEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:25 INFO - Running setup.py install for manifestparser 10:35:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:25 INFO - Running setup.py install for mozcrash 10:35:25 INFO - Running setup.py install for mozdebug 10:35:25 INFO - Running setup.py install for mozdevice 10:35:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Running setup.py install for mozfile 10:35:26 INFO - Running setup.py install for mozhttpd 10:35:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Running setup.py install for mozinfo 10:35:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Running setup.py install for mozInstall 10:35:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:26 INFO - Running setup.py install for mozleak 10:35:26 INFO - Running setup.py install for mozlog 10:35:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Running setup.py install for moznetwork 10:35:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Running setup.py install for mozprocess 10:35:27 INFO - Running setup.py install for mozprofile 10:35:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Running setup.py install for mozrunner 10:35:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:27 INFO - Running setup.py install for mozscreenshot 10:35:27 INFO - Running setup.py install for moztest 10:35:27 INFO - Running setup.py install for mozversion 10:35:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:28 INFO - Cleaning up... 10:35:28 INFO - Return code: 0 10:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:28 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:28 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 10:35:28 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 10:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:28 INFO - 'HOME': '/Users/cltbld', 10:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:28 INFO - 'LOGNAME': 'cltbld', 10:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:28 INFO - 'MOZ_NO_REMOTE': '1', 10:35:28 INFO - 'NO_EM_RESTART': '1', 10:35:28 INFO - 'PAGER': '/bin/cat', 10:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:28 INFO - 'PWD': '/builds/slave/test', 10:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:28 INFO - 'SHELL': '/bin/bash', 10:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:28 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:28 INFO - 'USER': 'cltbld', 10:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:28 INFO - 'XPC_FLAGS': '0x0', 10:35:28 INFO - 'XPC_SERVICE_NAME': '0', 10:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-_nYaNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:28 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)) 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-YtDaVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-u6I7dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:28 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)) 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Y11mzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-9KrRCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:28 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)) 10:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-lpckoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-B9xeYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Ncmzzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-9BwaQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-YwFQuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-bJIEtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-rRklUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-gh7CIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-bvKMrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-7ArAeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:29 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)) 10:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-_Cd_BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-5TInRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:30 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)) 10:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:35:30 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)) 10:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:35:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:30 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 10:35:30 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 10:35:30 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 10:35:30 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 10:35:30 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 10:35:30 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 10:35:32 INFO - Downloading blessings-1.6.tar.gz 10:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:32 INFO - Installing collected packages: blessings 10:35:32 INFO - Running setup.py install for blessings 10:35:32 INFO - Successfully installed blessings 10:35:32 INFO - Cleaning up... 10:35:33 INFO - Return code: 0 10:35:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:33 INFO - Reading from file tmpfile_stdout 10:35:33 INFO - Current package versions: 10:35:33 INFO - blessings == 1.6 10:35:33 INFO - blobuploader == 1.2.4 10:35:33 INFO - docopt == 0.6.1 10:35:33 INFO - functools32 == 3.2.3-2 10:35:33 INFO - jsonschema == 2.5.1 10:35:33 INFO - manifestparser == 1.1 10:35:33 INFO - mozInstall == 1.12 10:35:33 INFO - mozcrash == 0.17 10:35:33 INFO - mozdebug == 0.1 10:35:33 INFO - mozdevice == 0.48 10:35:33 INFO - mozfile == 1.2 10:35:33 INFO - mozhttpd == 0.7 10:35:33 INFO - mozinfo == 0.9 10:35:33 INFO - mozleak == 0.1 10:35:33 INFO - mozlog == 3.3 10:35:33 INFO - moznetwork == 0.27 10:35:33 INFO - mozprocess == 0.23 10:35:33 INFO - mozprofile == 0.28 10:35:33 INFO - mozrunner == 6.12 10:35:33 INFO - mozscreenshot == 0.1 10:35:33 INFO - mozsystemmonitor == 0.3 10:35:33 INFO - moztest == 0.7 10:35:33 INFO - mozversion == 1.4 10:35:33 INFO - psutil == 3.1.1 10:35:33 INFO - requests == 1.2.3 10:35:33 INFO - wsgiref == 0.1.2 10:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:33 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:33 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 10:35:33 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 10:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:33 INFO - 'HOME': '/Users/cltbld', 10:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:33 INFO - 'LOGNAME': 'cltbld', 10:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:33 INFO - 'MOZ_NO_REMOTE': '1', 10:35:33 INFO - 'NO_EM_RESTART': '1', 10:35:33 INFO - 'PAGER': '/bin/cat', 10:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:33 INFO - 'PWD': '/builds/slave/test', 10:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:33 INFO - 'SHELL': '/bin/bash', 10:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:33 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:33 INFO - 'USER': 'cltbld', 10:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:33 INFO - 'XPC_FLAGS': '0x0', 10:35:33 INFO - 'XPC_SERVICE_NAME': '0', 10:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 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)) 10:35:33 INFO - Cleaning up... 10:35:33 INFO - Return code: 0 10:35:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:33 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 0x10a698a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a72d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9158d7fc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, '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.iOh6twaM8p/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.BJIiljwMta/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 10:35:33 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 10:35:33 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 10:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:33 INFO - 'HOME': '/Users/cltbld', 10:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:33 INFO - 'LOGNAME': 'cltbld', 10:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:33 INFO - 'MOZ_NO_REMOTE': '1', 10:35:33 INFO - 'NO_EM_RESTART': '1', 10:35:33 INFO - 'PAGER': '/bin/cat', 10:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:33 INFO - 'PWD': '/builds/slave/test', 10:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:33 INFO - 'SHELL': '/bin/bash', 10:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:35:33 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:33 INFO - 'USER': 'cltbld', 10:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:33 INFO - 'XPC_FLAGS': '0x0', 10:35:33 INFO - 'XPC_SERVICE_NAME': '0', 10:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:33 INFO - Cleaning up... 10:35:33 INFO - Return code: 0 10:35:33 INFO - Running post-action listener: _resource_record_post_action 10:35:33 INFO - Running post-action listener: _start_resource_monitoring 10:35:33 INFO - Starting resource monitoring. 10:35:33 INFO - [mozharness: 2016-08-15 17:35:33.873516Z] Finished create-virtualenv step (success) 10:35:33 INFO - [mozharness: 2016-08-15 17:35:33.874490Z] Running install step. 10:35:33 INFO - Running pre-action listener: _resource_record_pre_action 10:35:33 INFO - Running main action method: install 10:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:34 INFO - Reading from file tmpfile_stdout 10:35:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:34 INFO - Reading from file tmpfile_stdout 10:35:34 INFO - Output received: 10:35:34 INFO - Usage: mozinstall [options] installer 10:35:34 INFO - Options: 10:35:34 INFO - -h, --help show this help message and exit 10:35:34 INFO - -d DEST, --destination=DEST 10:35:34 INFO - Directory to install application into. [default: 10:35:34 INFO - "/builds/slave/test"] 10:35:34 INFO - --app=APP Application being installed. [default: firefox] 10:35:34 INFO - mkdir: /builds/slave/test/build/application 10:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:36:07 INFO - Reading from file tmpfile_stdout 10:36:07 INFO - Output received: 10:36:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:36:07 INFO - Running post-action listener: _resource_record_post_action 10:36:07 INFO - [mozharness: 2016-08-15 17:36:07.765258Z] Finished install step (success) 10:36:07 INFO - [mozharness: 2016-08-15 17:36:07.765404Z] Running run-tests step. 10:36:07 INFO - Running pre-action listener: _resource_record_pre_action 10:36:07 INFO - Running main action method: run_tests 10:36:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:36:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:36:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:36:07 INFO - 2016-08-15 10:36:07.779 screenresolution[1978:14306] starting screenresolution argv=screenresolution get 10:36:07 INFO - 2016-08-15 10:36:07.782 screenresolution[1978:14306] Display 0: 1600x1200x32@60 10:36:07 INFO - 2016-08-15 10:36:07.788 screenresolution[1979:14308] starting screenresolution argv=screenresolution list 10:36:07 INFO - Available Modes on Display 0 10:36:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:36:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:36:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:36:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:36:08 INFO - Intel Iris: 10:36:08 INFO - Chipset Model: Intel Iris 10:36:08 INFO - Type: GPU 10:36:08 INFO - Bus: Built-In 10:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:36:08 INFO - Vendor: Intel (0x8086) 10:36:08 INFO - Device ID: 0x0a2e 10:36:08 INFO - Revision ID: 0x0009 10:36:08 INFO - Displays: 10:36:08 INFO - Display: 10:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:36:08 INFO - Display Serial Number: 1600x1200 60 10:36:08 INFO - Main Display: Yes 10:36:08 INFO - Mirror: Off 10:36:08 INFO - Online: Yes 10:36:08 INFO - Rotation: Supported 10:36:08 INFO - Return code: 0 10:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:08 INFO - Python 2.7.3 10:36:08 INFO - Return code: 0 10:36:08 INFO - grabbing minidump binary from tooltool 10:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:08 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 0x10a5fcd30>, '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 0x10a361db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:08 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 10:36:08 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 10:36:08 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 10:36:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:08 INFO - Return code: 0 10:36:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:36:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iOh6twaM8p/Render', 10:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:08 INFO - 'HOME': '/Users/cltbld', 10:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:08 INFO - 'LOGNAME': 'cltbld', 10:36:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:36:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:08 INFO - 'MOZ_NO_REMOTE': '1', 10:36:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:36:08 INFO - 'NO_EM_RESTART': '1', 10:36:08 INFO - 'PAGER': '/bin/cat', 10:36:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:08 INFO - 'PWD': '/builds/slave/test', 10:36:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:08 INFO - 'SHELL': '/bin/bash', 10:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BJIiljwMta/Listeners', 10:36:08 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 10:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:08 INFO - 'USER': 'cltbld', 10:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:08 INFO - 'XPC_FLAGS': '0x0', 10:36:08 INFO - 'XPC_SERVICE_NAME': '0', 10:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:36:08 INFO - mozversion application_buildid: 20160815090617 10:36:08 INFO - mozversion application_changeset: e88a4b19b2d189e21d779326c9de56c52f7377f9 10:36:08 INFO - mozversion application_display_name: Nightly 10:36:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:36:08 INFO - mozversion application_name: Firefox 10:36:08 INFO - mozversion application_remotingname: firefox 10:36:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:36:08 INFO - mozversion application_vendor: Mozilla 10:36:08 INFO - mozversion application_version: 51.0a1 10:36:08 INFO - mozversion platform_buildid: 20160815090617 10:36:08 INFO - mozversion platform_changeset: e88a4b19b2d189e21d779326c9de56c52f7377f9 10:36:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:36:08 INFO - mozversion platform_version: 51.0a1 10:36:08 INFO - using testdate: 1471282568 10:36:08 INFO - actual date: 1471282568 10:36:08 INFO - starting webserver on 'localhost:49696' 10:36:08 INFO - SUITE-START | Running 2 tests 10:36:08 INFO - TEST-START | dromaeo_css 10:36:08 INFO - operating with platform_type : mac_ 10:36:08 INFO - Initialising browser for dromaeo_css test... 10:36:08 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpWWFCOk/profile http://localhost:49696/getInfo.html) 10:36:10 INFO - PROCESS | 1989 | __metrics Screen width/height:1600/1200 10:36:10 INFO - PROCESS | 1989 | colorDepth:24 10:36:10 INFO - PROCESS | 1989 | Browser inner width/height: 1024/689 10:36:10 INFO - PROCESS | 1989 | __metrics 10:36:10 INFO - PROCESS | 1989 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:36:10 INFO - PROCESS | 1989 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:11 INFO - PROCESS | 1989 | ************************* 10:36:11 INFO - PROCESS | 1989 | A coding exception was thrown in a Promise resolution callback. 10:36:11 INFO - PROCESS | 1989 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 10:36:11 INFO - PROCESS | 1989 | 10:36:11 ERROR - PROCESS | 1989 | Full message: TypeError: win is null 10:36:11 INFO - PROCESS | 1989 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:756:17 10:36:11 INFO - PROCESS | 1989 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 10:36:11 INFO - PROCESS | 1989 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:36:11 INFO - PROCESS | 1989 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:36:11 INFO - PROCESS | 1989 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:36:11 INFO - PROCESS | 1989 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:36:11 INFO - PROCESS | 1989 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 10:36:11 INFO - PROCESS | 1989 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 10:36:11 INFO - PROCESS | 1989 | 10:36:11 INFO - PROCESS | 1989 | ************************* 10:36:11 INFO - TEST-INFO | 1989: exit 0 10:36:11 INFO - Browser initialized. 10:36:11 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:11 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpWWFCOk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:23 INFO - PROCESS | 1991 | RSS: Main: 247463936 10:36:23 INFO - PROCESS | 1991 | 10:37:14 INFO - PROCESS | 1991 | 1471282634622 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:39:26 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49696/tests/dromaeo/cssquery-ext.html) 10:39:27 INFO - PROCESS | 1991 | RSS: Main: 386711552 10:39:27 INFO - PROCESS | 1991 | 10:42:30 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-ext.html (next: http://localhost:49696/tests/dromaeo/cssquery-jquery.html) 10:42:31 INFO - PROCESS | 1991 | RSS: Main: 389042176 10:42:31 INFO - PROCESS | 1991 | 10:45:33 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49696/tests/dromaeo/cssquery-mootools.html) 10:45:34 INFO - PROCESS | 1991 | RSS: Main: 355528704 10:45:34 INFO - PROCESS | 1991 | 10:48:37 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49696/tests/dromaeo/cssquery-prototype.html) 10:48:37 INFO - PROCESS | 1991 | RSS: Main: 354697216 10:48:37 INFO - PROCESS | 1991 | 10:51:40 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49696/tests/dromaeo/cssquery-yui.html) 10:51:41 INFO - PROCESS | 1991 | RSS: Main: 349593600 10:51:41 INFO - PROCESS | 1991 | 10:54:44 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:49696/tests/dromaeo/cssquery-yui.html (next: http://localhost:49696/tests/dromaeo/cssquery-dojo.html) 10:54:45 INFO - PROCESS | 1991 | RSS: Main: 499896320 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | __start_tp_report 10:54:45 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 10:54:45 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 10:54:45 INFO - PROCESS | 1991 | |i|pagename|runs| 10:54:45 INFO - PROCESS | 1991 | |0;dojo.html;3285.113019484738;3286.0963235110344;3297.1592243977784;3325.2019515316333;3340.4989251612255;5560.916586251209;5572.470615291546;5634.267545219121;5681.602287839853;5702.372738998707;5638.774449022034;5657.886842263162;5741.827745167651;5743.052396354597;5764.711764411783;4317.784110794463;5070.31550740649;5129.487051294859;5196.68819870809;5345.4387289334645;5272.367315922075;5301.787928482856;5312.73436328184;5317.069512835258;5329.653572517774;4837.105135549917;5129.204973229155;5130;5181.663191892515;5188.066148093341;5193.091209038404;5207.973960130213;5214.296070030536;5219.895602087975;5300.125479295912;5195.636305458619;5213.374395072616;5239.895202095975;5251.212318152269;5296.443873393316;4814.325994360793;5592.944070559323;5644.238027866268;5738.741756620921;5807.738651760638;6112.047575716891;6160.784372546939;6167.198264225622;6187;6215.782447614311;5695.917775622618;6179.66011869347;6274;6310.87378252437;6321.810345689637;5648.378678345461;5711.857203569861;5775.855603609902;5812.854678633068;5840;6203.038529028008;6329.177206963065;6352.333005034405;6363.395477429637;6371.044343348535;6094.146819445281;6098.0852872069545;6115.969420152871;6125.571210015256;6133.694354383515;5045.974770126126;6202.44178023971;6256.155419018465;6285.057241413824;6285.59143655661;6016.639001659914;6051.092336149525;6081.513478921675;6082.2093127893095;6125.357545073132;6151.907721384183;6157.9384206158265;6164.198654175018;6174.845628859314;6176.907346389808;4912.263160525949;4920.114379411741;4920.75396230187;4927.605791536668;4949.950500494949;4377.277749171351;4442.222611043119;4447.221736196153;4479.70881892676;4495.617872480811;5603.10350343943;5679.375268720438;5693.4021927696995;5696.572757043238;5717.37108918027;6236.314005459396;6301.779437719658;6302.527310451735;6311.0217916223055;6317.96841015792;5210.869728256824;5288.7091209983055;5525.419830917776;5540.806071787468;5672.744726487318;5355.0896347621;5422.8915421691345;5432.994895944263;5437.673739575638;5468.617196796186;6303.054541818764;6324.3991820776955;6329.651869147241;6338.080978258219;6342.682865856688;6136.754529818936;6255.687215639291;6280.9685951569945;6289.0252010938375;6289.308176100717;6235.625862448086;6246.906296405648;6306.369363063657;6310.842228944313;6342.682865856781;4988.650794444354;6143.96928015357;6148.985417406078;6194.442500175006;6195.31851496326;6251.624902505864;6260.624362538262;6263.874722505433;6273.247210334789;6291.6539590321145;6082.543809214415;6098.420650038239;6100.420460056288;6103.542234332354;6116;5746.9712651436475;5793.652380857162;5955.583109182316;6084.513238940963;6090.939090609215;5939.584229104094;5941.405859414024;5959.046552551571;5981.820545383645;5994.340622531431;6078.848616835177;6108.450239478469;6112.602680825732;6123.877522449615;6131.110988906495;5190.351206099238;5748.568857335633;5865.354810970875;5867.442592953663;6019.6990150493175 10:54:45 INFO - PROCESS | 1991 | |1;ext.html;469.4859129253466;507.5330695759903;520.6667732651102;554.3874019208776;558.5978095771048;31932.84033579832;32791.50812737808;42785.57214427855;43554.564454355444;43757.34363984543;44816.551834481645;45045.549544504625;45096.87257818556;45257;45257.77371113148;9687.564059617334;9887.406755594651;9894;9906.702798916043;9909.256805739562;9708.66019689311;9837.360571562825;9837.852432213522;9843.950780246125;9874.555644995957;9814.06766357195;9850.261230407748;9873.358231714916;9876.90123098767;9900.20798336135;9760.511974401286;9794.118529332358;9832.557534910946;9835.754106147331;9851.605935762562;9756.07317304855;9823.165030972375;9823.410595364301;9825.066618671215;9841.409515429097;42433;42663.57336426627;42812;42858.78570607158;42870.57129428697;3386.4412371958597;3402.8638854445794;3405.1146701857447;3418.3505134024454;3534.6995505382074;31479.37041259185;32818.6718132818;32868.178295542566;32887.342253154806;32971.83514082438;3138.6778096668445;3312.9006129815903;3318.5354050432957;3382.594088709346;3420.0765793235687;443851;526580;531446;532178;532340.676593233;60180;60580.394196058354;60593.78812423727;60665.69667151636;60695.69652151711;66313;66348.33651663519;66367.33632663611;66379.33620663731;66452.66773666101;16474.670506589802;16667.49997500077;16688.582785430463;16703.415380461625;16705.582360441087;12821.935890320488;12860.935695321463;12886.355682215852;12886.548970786165;12892.097553171376;18049.54876128081;18064.18711158001;18093.366732164573;18102.637947240983;18301.7254741179;5504.9449505504435;6177.660228687465;6197.225346831646;6224.470919971853;6331.810045698637;863;863.2403484933219;879.7815026188774;970.7961328121173;1045.6758404894506;28907.56638650422;30110.397792044474;30261.848690756404;30568.77724891024;30995.225119371746;978.4862946952765;1042.921780866438;1079.4926384599225;1113.3208742666966;1116.8268918317674;15427.92286038585;15780.92109539445;15831.920840395955;16294.755578666329;16313.939593926358;658433;830544;874501;881864;884408.3575403286;61322.0801687975;62000.68999654973;62023;62024.68987655033;62025;1233.7779199743952;1284.640300715801;1360.143109840794;1390.881775049132;1402.2638114989509;25682.8715856427;28552.286192845346;31637.050888473383;31908.680913190572;32537.02388928336;58191;58858.351374187405;58953.82092358043;58957.11564326625;58996.70501647636;562924;565505;565734;566237;567798;26421.471570568865;26923.92304307806;27467.055929932005;27601.723982759915;28653.570196447487;48437.27344089771;49118.87776272349;49150.75424622854;49390.75304623454;49472.25791613201;34500.654993449745;40188.79905600454;40759.592404076764;40872.68517363395;40906.59093409028;40010.599894001854;40733.981650458976;40900;40928.590714092476;42287.788561057;28339.858300708365;34256.314873701886;39909.401358979056;40164.995875103356;40372;35189.64810351966;35450.29099418049;35481.82259088688;36236.91289261326;36327.636723633485;23546.293611191693;25693.61459578145;25760.742392575834;26117.085901993338;26337.341566460225 10:54:45 INFO - PROCESS | 1991 | |2;jquery.html;367.28929521376136;382.7894657938134;389.9200663863907;396.0534322968105;408.79560219890055;19016.619667606657;21064.789352106476;21224.151033958642;21225.893870530665;21499.92500374981;20243;20537.897310513465;21045.26341578045;21170.78829211711;21328;5597.188407680884;5648.181013753004;5813.389594092601;5903.173555702184;5903.911441328383;4159.417681524589;4387.517373088957;5775.826725198251;5881.382454842244;6326.936730632704;6596.538242323039;6634;6645.102911106987;6671.332866713338;6677.799666010027;6348.84127896804;6537.313582073862;6596.175478065242;6617.536772425932;6631.237407698129;5621.156826476021;5640.097584386478;5726.68503232322;5728.598998070137;5737.569682273846;26212.475750484882;26295;26296.474070518674;26335.868320658465;26593.069242576417;1929.0644037641732;2156.1159924431063;2171.8588291761143;2204.9448763780874;2403.3510952043025;14697.55907322782;15140.621484462867;15259.923700381538;15786.447474338458;15817.54294768303;1869.9158537865828;1879.8684092113558;1892.8769629974145;1939.185542072333;1948.2888745607752;101943.49028254811;105240.47379763129;105298;105797.47101264521;106582;10475.42385168823;10505.474726263656;10519.158467322595;10602.681919542427;10829.891701083046;13468.461261549428;13500.392482338319;13528.120672156278;13536.120152190077;13578.660533486543;8377.581120943929;8518.275946544489;8555.443896146731;8596.269317108116;8682.348823838238;8634.827303453896;8645;8680.8697869532;8781.912180878237;8832.91167088321;5566.638168519034;6339.683015849189;6468.288488266287;6484.675766211671;6486.708098135501;1687.2913376381948;1806.4761219246273;1815.1468809659439;1836.40316897009;1885.632301701155;822.7367242482468;878.0692465985948;973.3138137612966;1011.5043628622069;1022.4785359466725;20848;22242.443938901335;22493.887530562242;22509.54980900373;22516.32451026472;916.6470908700065;926.6571368593663;939.2251392601131;978.0708327089294;1044.2272718188485;9295.302852286106;11339.902118108177;11617.477213525412;11866.406679665983;11896.405179740977;594723;607607;619382.9339386286;622553;628188;118926.97614071945;122363.38818306029;123550;126533.10200347002;127123;976.6825781621002;1006.6124542051363;1007.9697609071886;1021.6219998600417;1026.1534234256767;18631.347902823338;19291.4212573623;19370.903145484182;19394.515137121685;19451.805481945565;51859;52391.95216095733;52666.57667251617;53562.73218633882;54176.72911635417;75727.62136189285;77033;77620;78054.609726951;83302.5834870846;7102.147742270754;7289.39522050659;7491.513051651626;7908.248716371935;8371.916280837357;9329;12159.45282462309;12920;13332.466701332227;13425.127366721132;11153;11199.776004480027;11645.88354116448;11723.41382930867;11754.353510557;11312.547498099984;11342.886571134182;11513.50219803209;11526.135539834713;11817;10084.84872726895;11462.541498339973;11771.587994420153;11883.524659013889;11908.702282443008;7411.851762964603;7537.924620753723;7593.1647518774;7674;7680.116786569392;7965;9448.905510944802;11539.653810385702;11631.941840290745;11726.599286206905 10:54:45 INFO - PROCESS | 1991 | |3;mootools.html;1289.9161554498958;1355.1056302840127;1531.2956040221495;1652.0087947231661;1847.7690288713902;7638.541687498754;8561.529115898624;8779.912200877989;8807.779805504857;8907.510086945216;8704.91295087049;8786.253168480687;8792.51641159736;8796.07641197673;8827.426217295872;2361.504084142332;2379.762023797624;2381.416552944531;2381.7975472084895;2385.844920080198;2325.4418939454577;2357.5874222011166;2379.4170428245106;2389.163792672568;2390.7011623547055;2345.7419683834764;2358.7523310052457;2364.1725396111397;2377.679013333195;2382.1305223593436;2309.4803669174303;2339.263132113379;2348.2250857217077;2356.3873392917794;2364.9172278970154;2310.353101131669;2338.9298321050396;2345.319857241398;2346.0263990443946;2352.2472808701223;8728.956355218246;8762.518061506615;8838.469691818511;8845.4250473719;8852.690155844579;5207.557357624606;5398.48714372138;5399.298091248152;5400.621956463049;5444.020076386249;3534.1341371363924;3582.8566857325677;3651.434027725707;3652.945205821915;3673.2837096766143;1088.3252383522267;1098.4233277529281;1102.5314241447434;1111.5276007696777;1124.3310230412892;9622.951885240598;11344.886551134548;11390.430478476126;11492.885071149265;11497.712557186054;4552.908941821145;4634;4817.5182481752245;4852.126617208865;4853.9029219415415;8459.830803383898;9826.213902887752;9837.655682051094;9839.508024598741;9846.310758246997;5309.33633295838;5319.760610772524;5320.654157479751;5329.333833270841;5331.653442526223;3808.920210842972;4394.890127746832;4531.637469002472;4823.131836269435;4896;3463.8960831175104;3883.9901625577554;3973.2450834341385;3990.461287726178;4055.5538890721996;1274.3946625352883;1282;1287.5300515311844;1290.348374071088;1292.0761655416422;766.2069757800649;847.7922908887363;865.7272959018015;924.2790623313826;982.8476586129161;5743.971280143573;5802.970985145047;5946.464818166386;6012.368701286302;6037.879242415215;753.4424525850831;854.7093988044095;904.4980036079908;906.428949761646;977.193815102529;3758.624137586274;3848.5189351331082;3865.1303456722576;3900;3969.3053715599654;9063.274938004944;10240.897591024144;10712.78574428507;10717.464126793786;10719.678409647722;10652.89347106519;10653.84019239712;10671.413072280944;10672.413017284123;10674.199435042403;8057.194280571896;8159.143289954588;8177.591120443954;8185.181481851886;8191.098979112293;5715.828525144252;5830.679312637845;5849.298084229919;6025.548083893813;6267.310595834546;9714.417134971924;9744;9789.265805064791;9975;10051.396916185053;9306.953465232631;9815.969323221245;10077.09306162449;10096.545655445376;10182.541785619516;6981.406580440719;7388.224236455095;7572.356349710336;7607.277308655669;7691.57696326685;8198.590070496331;8315.417920745489;8359.832803344021;8381.203785640355;8409.83180336402;7417.517861338995;7424.071991001125;7504.849903002018;7568.129665088585;7574.621268936421;7264.527805692613;7286.307800758919;7303.211563418156;7345.595992220479;7462.813429664302;6863.6568171590225;6935.826604334932;6999.755008574675;7018.227994920452;7057.117860267466;4089.550149483495;4978.153713868579;4995.225740010304;5022.070916880389;5153.793848246178;4625.236835922035;4892.2661600760175;5008.200010900368;5083.5678967288195;5184.688918664892 10:54:45 INFO - PROCESS | 1991 | |4;prototype.html;222.18568944817255;303.17385125532917;310.4706475459341;314.7104663709387;315.0516943998565;4363.716358436704;5211.296474975882;5244.737763111843;5264.6051546134;5265.210218467232;4872.344572208146;4935.506449355063;5059.544640982311;5174.4825517448335;5178.352705911761;3505.5968563615256;3981.9601803982023;3988.302047141746;3992.3412636914873;4003.499562554681;3499.91250218744;3984.1434091670285;3984.86052988144;3991.580884007181;3995.960040399588;3632.691221246197;3719.2561487702433;3965.9206815863668;3969.0672691917375;3973.662238709713;3134.7962382445066;3417.923354143437;3871.477350557667;3887.5334959804864;4017.834827899891;3466.9826650866585;3478.3043391321585;3479.6172421033666;3483.8432270547887;3486.5530804716013;4852.878678033042;5126.538611524943;5131.204663277198;5133.996611981995;5156.679494227613;4540.636749060067;4574.542545745432;4586.4266966629175;4609.700369475973;4617.906002977979;5414.810481633124;5445.346558412976;5463.235147079412;5484.396716361197;5533.557315414757;3244.6917542833394;3263.902082937516;3510.9297814043575;3646.08847788053;3866.6520013198947;4756.3816703828625;5594.237815088234;5668.801591944345;5736.598438109334;5748.770049198027;3887.686826338324;3904.90237744053;3907.5701672815967;3909.58949310324;3923.2153569286256;3318.8340582970754;3953.8418463261146;3966.6231707987695;3968.265870813909;3983.1635356574866;4306.440162778818;4526.78598195285;4561.954380456219;4585.633149348044;4603.355530225771;4570.920231294753;5493.862653433696;5499.422560631157;5524.1989911462615;5554.972225138848;1187.1215300677436;1308.9541866034642;1317.7035167087329;1351.6348488026968;1355.66786137395;747.5888261456178;794.2057942057942;859.4671303791689;901.8061116859907;914.410205417502;4680.321353403806;4801.567858892717;4912.508749125131;4989.002199560103;5019.088928421506;5528.738044553733;5550.777968881281;5559.72201389937;5564.554835613141;5576.33084029919;4052.230076285496;4640.930386044212;4844.927326090112;4901.558859702573;4998.500149985045;2135.9814974848928;2423.6122220444645;2744.1767469758993;2824.3645179834375;2900.6664233612983;5002.399712034507;5726.455986681259;5739.827805165852;5750.482456578928;5758.539316854642;4956.430010548833;5334.359876814729;5623.750499800112;5679.574031947538;5687.971560142256;5188.870278242998;5687.800926967537;5709.714514274269;5710.571707122065;5730.046268075015;4190.476190476191;4814;5272.2882410874045;5498.3127109111365;5540.778368865362;4525.932111018403;5260.266309722421;5464.316960379952;5467.430307755349;5506.724663766716;4723.551262630044;4968.826091086795;5435.619506634498;5691.78414195978;5723.656580605177;3564.1267889367273;3752.343339915449;3863.8261278241985;3868.3037053330672;3881.243157584244;5415.864603384947;5461.563074954073;5510.8071217507195;5556.361018482926;5563.58273129525;4673.9298910517045;4766.833160839354;5348.753523520209;5357.223202635674;5407.567394608501;4476.925537870822;5114.872128196825;5161.509656582619;5348.759305831325;5374.274472946102;4484.641228701761;5162;5188.584913206859;5256.290400795997;5257.8159764408065;4656.743879086683;5359.866003349947;5361.90081033395;5366.490183432567;5367.490088441592;4425.446819147606;4620.5379462053525;4938.925651226422;5264.552513036435;5364.3830959440165 10:54:45 INFO - PROCESS | 1991 | |5;yui.html;706.6113637499374;721.5958369470945;763.2405756272507;796.3072127249293;803.7990502374408;14857.40570377185;16275.59311017225;16293.837061629394;16312.02127872327;16329.18354082297;14637.634059148526;14669.779953300682;14803.851961480408;14818.184999825005;14838.406463741438;681.4854784637591;704.2148004974442;707.745211723779;715.1311156944312;840.705752986456;705.6154395854272;710.6872975890617;831.5966756123275;847.4576271186446;853.8975322961253;910.544727636182;917.7659696777313;920.9447433153998;924.8011677489338;927.5408672707019;920.2086205863019;920.8066306075732;921.3366376209152;923.3628796130648;923.9399439036441;532.7922110376957;673.5554534007531;678.4335080208032;680.4420375292262;680.5032326401705;12293.262404255773;12508.81236781449;12514.18657787241;12514.436850341757;14787.482438114723;13726.970477214149;14138;14399.92800035993;14584.343704533321;14859.331330090172;12926.612201633967;13469.595912122651;13483.17950294843;13511.459541618324;13682.452701891913;4699.436067671867;4759.952400475986;4792.329073929653;4839.201531747258;4915.262710593403;119810;121145.39427302896;121966;123634.76365236413;123792.76207237902;9251.352405331561;11121.943415375526;11437.71405714847;11696.649100526998;11831.545133952686;19532.609347812962;22621.547569048525;22789.886050569974;22791.772082278963;23333.300000999996;8122.959385203154;8146.389020823462;8197.549134797524;8346.874796878052;8371.079181290175;4313.525512193656;4373.737575745466;4453.109378124388;4498;4551;3463.255400088993;3578;3585.032041348821;3591.2278860045217;3591.28174365128;556.2323992889867;659.3011407907537;666.6000399760202;667.1293961380348;667.1693741292122;614.1984709953464;621.1800423441105;622.3185611755121;644.7807745366504;665.5108495255982;9113.68102116436;9226.723198304062;9312.100638977581;9328.626854925862;9395.248380129573;540.235566673161;580.3760956971273;592.520058752412;603.1495591216363;628.6950828848005;3882.165334453106;3892.7858967757047;4043.6765058795227;4079.1433798902563;4109.630133288018;96616;97034.02965970391;97223.51388243014;97581.0241897572;98128.50935745276;78042;113567.43216283865;121310.57378852373;129144.35427822989;141961.87057194152;103057;106929.930700692;107195.46402268094;110989;111894;9748.171405430618;9836.950815245878;10011.949940250252;10046.588406099843;10121.139703125316;58830.823383532945;59098.203706572574;59099.113513298194;61270;62065;93933;98404.50797745965;99338.50992234978;100055;105186.42220366548;13128.343582821011;13197.802032969705;13435.865641343462;13614.727705446034;13734.313284335944;14942.103473791607;15042.097474151586;15203.315850786963;15223;15841.366345346058;13845.930770346487;13891.652708682364;14099.013069085066;14316;14580.1980891052;13632.250226237653;13932;14204.573862784133;14228.075175113585;14349.56951291463;11304;13634.250116243702;13766.862331376558;13974.860251397356;14217.21805300677;10252.43611601369;10547.683569492927;11225.887741122811;11478.311301321948;11487.13846461502;11273.154513411362;11397.544098235978;11637.825677044197;11699.473523691284;11768.411579420823 10:54:45 INFO - PROCESS | 1991 | __end_tp_report 10:54:45 INFO - PROCESS | 1991 | __start_cc_report 10:54:45 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,1256 10:54:45 INFO - PROCESS | 1991 | __end_cc_report 10:54:45 INFO - PROCESS | 1991 | __startTimestamp1471283685245__endTimestamp 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | ------- Summary: start ------- 10:54:45 INFO - PROCESS | 1991 | Number of tests: 6 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#0] dojo.html Cycles:165 Average:5695.44 Median:5865.35 stddev:656.38 (11.2%) stddev-sans-first:630.57 10:54:45 INFO - PROCESS | 1991 | Values: 3285.1 3286.1 3297.2 3325.2 3340.5 5560.9 5572.5 5634.3 5681.6 5702.4 5638.8 5657.9 5741.8 5743.1 5764.7 4317.8 5070.3 5129.5 5196.7 5345.4 5272.4 5301.8 5312.7 5317.1 5329.7 4837.1 5129.2 5130.0 5181.7 5188.1 5193.1 5208.0 5214.3 5219.9 5300.1 5195.6 5213.4 5239.9 5251.2 5296.4 4814.3 5592.9 5644.2 5738.7 5807.7 6112.0 6160.8 6167.2 6187.0 6215.8 5695.9 6179.7 6274.0 6310.9 6321.8 5648.4 5711.9 5775.9 5812.9 5840.0 6203.0 6329.2 6352.3 6363.4 6371.0 6094.1 6098.1 6116.0 6125.6 6133.7 5046.0 6202.4 6256.2 6285.1 6285.6 6016.6 6051.1 6081.5 6082.2 6125.4 6151.9 6157.9 6164.2 6174.8 6176.9 4912.3 4920.1 4920.8 4927.6 4950.0 4377.3 4442.2 4447.2 4479.7 4495.6 5603.1 5679.4 5693.4 5696.6 5717.4 6236.3 6301.8 6302.5 6311.0 6318.0 5210.9 5288.7 5525.4 5540.8 5672.7 5355.1 5422.9 5433.0 5437.7 5468.6 6303.1 6324.4 6329.7 6338.1 6342.7 6136.8 6255.7 6281.0 6289.0 6289.3 6235.6 6246.9 6306.4 6310.8 6342.7 4988.7 6144.0 6149.0 6194.4 6195.3 6251.6 6260.6 6263.9 6273.2 6291.7 6082.5 6098.4 6100.4 6103.5 6116.0 5747.0 5793.7 5955.6 6084.5 6090.9 5939.6 5941.4 5959.0 5981.8 5994.3 6078.8 6108.5 6112.6 6123.9 6131.1 5190.4 5748.6 5865.4 5867.4 6019.7 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#1] ext.html Cycles:180 Average:76563.28 Median:42835.39 stddev:175137.05 (408.9%) stddev-sans-first:175535.17 10:54:45 INFO - PROCESS | 1991 | Values: 469.5 507.5 520.7 554.4 558.6 31932.8 32791.5 42785.6 43554.6 43757.3 44816.6 45045.5 45096.9 45257.0 45257.8 9687.6 9887.4 9894.0 9906.7 9909.3 9708.7 9837.4 9837.9 9844.0 9874.6 9814.1 9850.3 9873.4 9876.9 9900.2 9760.5 9794.1 9832.6 9835.8 9851.6 9756.1 9823.2 9823.4 9825.1 9841.4 42433.0 42663.6 42812.0 42858.8 42870.6 3386.4 3402.9 3405.1 3418.4 3534.7 31479.4 32818.7 32868.2 32887.3 32971.8 3138.7 3312.9 3318.5 3382.6 3420.1 443851.0 526580.0 531446.0 532178.0 532340.7 60180.0 60580.4 60593.8 60665.7 60695.7 66313.0 66348.3 66367.3 66379.3 66452.7 16474.7 16667.5 16688.6 16703.4 16705.6 12821.9 12860.9 12886.4 12886.5 12892.1 18049.5 18064.2 18093.4 18102.6 18301.7 5504.9 6177.7 6197.2 6224.5 6331.8 863.0 863.2 879.8 970.8 1045.7 28907.6 30110.4 30261.8 30568.8 30995.2 978.5 1042.9 1079.5 1113.3 1116.8 15427.9 15780.9 15831.9 16294.8 16313.9 658433.0 830544.0 874501.0 881864.0 884408.4 61322.1 62000.7 62023.0 62024.7 62025.0 1233.8 1284.6 1360.1 1390.9 1402.3 25682.9 28552.3 31637.1 31908.7 32537.0 58191.0 58858.4 58953.8 58957.1 58996.7 562924.0 565505.0 565734.0 566237.0 567798.0 26421.5 26923.9 27467.1 27601.7 28653.6 48437.3 49118.9 49150.8 49390.8 49472.3 34500.7 40188.8 40759.6 40872.7 40906.6 40010.6 40734.0 40900.0 40928.6 42287.8 28339.9 34256.3 39909.4 40165.0 40372.0 35189.6 35450.3 35481.8 36236.9 36327.6 23546.3 25693.6 25760.7 26117.1 26337.3 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#2] jquery.html Cycles:180 Average:35262.93 Median:22512.94 stddev:102004.51 (453.1%) stddev-sans-first:102257.01 10:54:45 INFO - PROCESS | 1991 | Values: 367.3 382.8 389.9 396.1 408.8 19016.6 21064.8 21224.2 21225.9 21499.9 20243.0 20537.9 21045.3 21170.8 21328.0 5597.2 5648.2 5813.4 5903.2 5903.9 4159.4 4387.5 5775.8 5881.4 6326.9 6596.5 6634.0 6645.1 6671.3 6677.8 6348.8 6537.3 6596.2 6617.5 6631.2 5621.2 5640.1 5726.7 5728.6 5737.6 26212.5 26295.0 26296.5 26335.9 26593.1 1929.1 2156.1 2171.9 2204.9 2403.4 14697.6 15140.6 15259.9 15786.4 15817.5 1869.9 1879.9 1892.9 1939.2 1948.3 101943.5 105240.5 105298.0 105797.5 106582.0 10475.4 10505.5 10519.2 10602.7 10829.9 13468.5 13500.4 13528.1 13536.1 13578.7 8377.6 8518.3 8555.4 8596.3 8682.3 8634.8 8645.0 8680.9 8781.9 8832.9 5566.6 6339.7 6468.3 6484.7 6486.7 1687.3 1806.5 1815.1 1836.4 1885.6 822.7 878.1 973.3 1011.5 1022.5 20848.0 22242.4 22493.9 22509.5 22516.3 916.6 926.7 939.2 978.1 1044.2 9295.3 11339.9 11617.5 11866.4 11896.4 594723.0 607607.0 619382.9 622553.0 628188.0 118927.0 122363.4 123550.0 126533.1 127123.0 976.7 1006.6 1008.0 1021.6 1026.2 18631.3 19291.4 19370.9 19394.5 19451.8 51859.0 52392.0 52666.6 53562.7 54176.7 75727.6 77033.0 77620.0 78054.6 83302.6 7102.1 7289.4 7491.5 7908.2 8371.9 9329.0 12159.5 12920.0 13332.5 13425.1 11153.0 11199.8 11645.9 11723.4 11754.4 11312.5 11342.9 11513.5 11526.1 11817.0 10084.8 11462.5 11771.6 11883.5 11908.7 7411.9 7537.9 7593.2 7674.0 7680.1 7965.0 9448.9 11539.7 11631.9 11726.6 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#3] mootools.html Cycles:180 Average:5656.11 Median:5169.24 stddev:3137.80 (60.7%) stddev-sans-first:3129.44 10:54:45 INFO - PROCESS | 1991 | Values: 1289.9 1355.1 1531.3 1652.0 1847.8 7638.5 8561.5 8779.9 8807.8 8907.5 8704.9 8786.3 8792.5 8796.1 8827.4 2361.5 2379.8 2381.4 2381.8 2385.8 2325.4 2357.6 2379.4 2389.2 2390.7 2345.7 2358.8 2364.2 2377.7 2382.1 2309.5 2339.3 2348.2 2356.4 2364.9 2310.4 2338.9 2345.3 2346.0 2352.2 8729.0 8762.5 8838.5 8845.4 8852.7 5207.6 5398.5 5399.3 5400.6 5444.0 3534.1 3582.9 3651.4 3652.9 3673.3 1088.3 1098.4 1102.5 1111.5 1124.3 9623.0 11344.9 11390.4 11492.9 11497.7 4552.9 4634.0 4817.5 4852.1 4853.9 8459.8 9826.2 9837.7 9839.5 9846.3 5309.3 5319.8 5320.7 5329.3 5331.7 3808.9 4394.9 4531.6 4823.1 4896.0 3463.9 3884.0 3973.2 3990.5 4055.6 1274.4 1282.0 1287.5 1290.3 1292.1 766.2 847.8 865.7 924.3 982.8 5744.0 5803.0 5946.5 6012.4 6037.9 753.4 854.7 904.5 906.4 977.2 3758.6 3848.5 3865.1 3900.0 3969.3 9063.3 10240.9 10712.8 10717.5 10719.7 10652.9 10653.8 10671.4 10672.4 10674.2 8057.2 8159.1 8177.6 8185.2 8191.1 5715.8 5830.7 5849.3 6025.5 6267.3 9714.4 9744.0 9789.3 9975.0 10051.4 9307.0 9816.0 10077.1 10096.5 10182.5 6981.4 7388.2 7572.4 7607.3 7691.6 8198.6 8315.4 8359.8 8381.2 8409.8 7417.5 7424.1 7504.8 7568.1 7574.6 7264.5 7286.3 7303.2 7345.6 7462.8 6863.7 6935.8 6999.8 7018.2 7057.1 4089.6 4978.2 4995.2 5022.1 5153.8 4625.2 4892.3 5008.2 5083.6 5184.7 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#4] prototype.html Cycles:180 Average:4382.85 Median:4886.95 stddev:1340.77 (27.4%) stddev-sans-first:1307.66 10:54:45 INFO - PROCESS | 1991 | Values: 222.2 303.2 310.5 314.7 315.1 4363.7 5211.3 5244.7 5264.6 5265.2 4872.3 4935.5 5059.5 5174.5 5178.4 3505.6 3982.0 3988.3 3992.3 4003.5 3499.9 3984.1 3984.9 3991.6 3996.0 3632.7 3719.3 3965.9 3969.1 3973.7 3134.8 3417.9 3871.5 3887.5 4017.8 3467.0 3478.3 3479.6 3483.8 3486.6 4852.9 5126.5 5131.2 5134.0 5156.7 4540.6 4574.5 4586.4 4609.7 4617.9 5414.8 5445.3 5463.2 5484.4 5533.6 3244.7 3263.9 3510.9 3646.1 3866.7 4756.4 5594.2 5668.8 5736.6 5748.8 3887.7 3904.9 3907.6 3909.6 3923.2 3318.8 3953.8 3966.6 3968.3 3983.2 4306.4 4526.8 4562.0 4585.6 4603.4 4570.9 5493.9 5499.4 5524.2 5555.0 1187.1 1309.0 1317.7 1351.6 1355.7 747.6 794.2 859.5 901.8 914.4 4680.3 4801.6 4912.5 4989.0 5019.1 5528.7 5550.8 5559.7 5564.6 5576.3 4052.2 4640.9 4844.9 4901.6 4998.5 2136.0 2423.6 2744.2 2824.4 2900.7 5002.4 5726.5 5739.8 5750.5 5758.5 4956.4 5334.4 5623.8 5679.6 5688.0 5188.9 5687.8 5709.7 5710.6 5730.0 4190.5 4814.0 5272.3 5498.3 5540.8 4525.9 5260.3 5464.3 5467.4 5506.7 4723.6 4968.8 5435.6 5691.8 5723.7 3564.1 3752.3 3863.8 3868.3 3881.2 5415.9 5461.6 5510.8 5556.4 5563.6 4673.9 4766.8 5348.8 5357.2 5407.6 4476.9 5114.9 5161.5 5348.8 5374.3 4484.6 5162.0 5188.6 5256.3 5257.8 4656.7 5359.9 5361.9 5366.5 5367.5 4425.4 4620.5 4938.9 5264.6 5364.4 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - PROCESS | 1991 | [#5] yui.html Cycles:180 Average:23669.83 Median:3588.13 stddev:36121.94 (1006.7%) stddev-sans-first:36182.12 10:54:45 INFO - PROCESS | 1991 | Values: 706.6 721.6 763.2 796.3 803.8 14857.4 16275.6 16293.8 16312.0 16329.2 14637.6 14669.8 14803.9 14818.2 14838.4 681.5 704.2 707.7 715.1 840.7 705.6 710.7 831.6 847.5 853.9 910.5 917.8 920.9 924.8 927.5 920.2 920.8 921.3 923.4 923.9 532.8 673.6 678.4 680.4 680.5 12293.3 12508.8 12514.2 12514.4 14787.5 13727.0 14138.0 14399.9 14584.3 14859.3 12926.6 13469.6 13483.2 13511.5 13682.5 4699.4 4760.0 4792.3 4839.2 4915.3 119810.0 121145.4 121966.0 123634.8 123792.8 9251.4 11121.9 11437.7 11696.6 11831.5 19532.6 22621.5 22789.9 22791.8 23333.3 8123.0 8146.4 8197.5 8346.9 8371.1 4313.5 4373.7 4453.1 4498.0 4551.0 3463.3 3578.0 3585.0 3591.2 3591.3 556.2 659.3 666.6 667.1 667.2 614.2 621.2 622.3 644.8 665.5 9113.7 9226.7 9312.1 9328.6 9395.2 540.2 580.4 592.5 603.1 628.7 3882.2 3892.8 4043.7 4079.1 4109.6 96616.0 97034.0 97223.5 97581.0 98128.5 78042.0 113567.4 121310.6 129144.4 141961.9 103057.0 106929.9 107195.5 110989.0 111894.0 9748.2 9837.0 10011.9 10046.6 10121.1 58830.8 59098.2 59099.1 61270.0 62065.0 93933.0 98404.5 99338.5 100055.0 105186.4 13128.3 13197.8 13435.9 13614.7 13734.3 14942.1 15042.1 15203.3 15223.0 15841.4 13845.9 13891.7 14099.0 14316.0 14580.2 13632.3 13932.0 14204.6 14228.1 14349.6 11304.0 13634.3 13766.9 13974.9 14217.2 10252.4 10547.7 11225.9 11478.3 11487.1 11273.2 11397.5 11637.8 11699.5 11768.4 10:54:45 INFO - PROCESS | 1991 | -------- Summary: end -------- 10:54:45 INFO - PROCESS | 1991 | 10:54:45 INFO - TEST-INFO | 1991: exit 0 10:54:45 INFO - TEST-OK | dromaeo_css | took 1117505ms 10:54:45 INFO - TEST-START | kraken 10:54:45 INFO - operating with platform_type : mac_ 10:54:45 INFO - Initialising browser for kraken test... 10:54:45 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpuCu9yJ/profile http://localhost:49696/getInfo.html) 10:54:48 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 10:54:48 INFO - PROCESS | 1994 | colorDepth:24 10:54:48 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 10:54:48 INFO - PROCESS | 1994 | __metrics 10:54:48 INFO - PROCESS | 1994 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:54:48 INFO - PROCESS | 1994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:48 INFO - PROCESS | 1994 | ************************* 10:54:48 INFO - PROCESS | 1994 | A coding exception was thrown in a Promise resolution callback. 10:54:48 INFO - PROCESS | 1994 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 10:54:48 INFO - PROCESS | 1994 | 10:54:48 ERROR - PROCESS | 1994 | Full message: TypeError: win is null 10:54:48 INFO - PROCESS | 1994 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:756:17 10:54:48 INFO - PROCESS | 1994 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 10:54:48 INFO - PROCESS | 1994 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:54:48 INFO - PROCESS | 1994 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:54:48 INFO - PROCESS | 1994 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:54:48 INFO - PROCESS | 1994 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:54:48 INFO - PROCESS | 1994 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 10:54:48 INFO - PROCESS | 1994 | EventHandlerNonNull*get _worker@resource://gre/modules/PromiseWorker.jsm:217:5 10:54:48 INFO - PROCESS | 1994 | postMessage@resource://gre/modules/PromiseWorker.jsm:291:9 10:54:48 INFO - PROCESS | 1994 | TaskImpl_run@resource://gre/modules/Task.jsm:319:40 10:54:48 INFO - PROCESS | 1994 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 10:54:48 INFO - PROCESS | 1994 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:54:48 INFO - PROCESS | 1994 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:54:48 INFO - PROCESS | 1994 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:54:48 INFO - PROCESS | 1994 | Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:454:5 10:54:48 INFO - PROCESS | 1994 | this.DeferredSave.prototype._deferredSave@resource://gre/modules/DeferredSave.jsm:220:5 10:54:48 INFO - PROCESS | 1994 | this.DeferredSave.prototype._startTimer/<@resource://gre/modules/DeferredSave.jsm:175:40 10:54:48 INFO - PROCESS | 1994 | syncLoadManifestFromFile@resource://gre/modules/addons/XPIProvider.jsm:1537:5 10:54:48 INFO - PROCESS | 1994 | addMetadata@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:1654:21 10:54:48 INFO - PROCESS | 1994 | processFileChanges@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2018:23 10:54:48 INFO - PROCESS | 1994 | this.XPIProvider.checkForChanges@resource://gre/modules/addons/XPIProvider.jsm:3793:34 10:54:48 INFO - PROCESS | 1994 | this.XPIProvider.startup@resource://gre/modules/addons/XPIProvider.jsm:2778:25 10:54:48 INFO - PROCESS | 1994 | callProvider@resource://gre/modules/AddonManager.jsm:236:12 10:54:48 INFO - PROCESS | 1994 | _startProvider@resource://gre/modules/AddonManager.jsm:788:5 10:54:48 INFO - PROCESS | 1994 | AddonManagerInternal.startup@resource://gre/modules/AddonManager.jsm:972:9 10:54:48 INFO - PROCESS | 1994 | this.AddonManagerPrivate.startup@resource://gre/modules/AddonManager.jsm:3016:5 10:54:48 INFO - PROCESS | 1994 | amManager.prototype.observe@resource://gre/components/addonManager.js:71:9 10:54:48 INFO - PROCESS | 1994 | 10:54:48 INFO - PROCESS | 1994 | ************************* 10:54:49 INFO - TEST-INFO | 1994: exit 0 10:54:49 INFO - Browser initialized. 10:54:49 INFO - Running cycle 1/1 for kraken test... 10:54:49 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpuCu9yJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:01 INFO - PROCESS | 1995 | RSS: Main: 248745984 10:55:01 INFO - PROCESS | 1995 | 10:55:03 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49696/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:04 INFO - PROCESS | 1995 | RSS: Main: 303980544 10:55:04 INFO - PROCESS | 1995 | 10:55:07 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49696/tests/kraken/driver.html?testName=audio-dft) 10:55:07 INFO - PROCESS | 1995 | RSS: Main: 310849536 10:55:07 INFO - PROCESS | 1995 | 10:55:11 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49696/tests/kraken/driver.html?testName=audio-fft) 10:55:12 INFO - PROCESS | 1995 | RSS: Main: 401522688 10:55:12 INFO - PROCESS | 1995 | 10:55:14 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49696/tests/kraken/driver.html?testName=audio-oscillator) 10:55:14 INFO - PROCESS | 1995 | RSS: Main: 303976448 10:55:14 INFO - PROCESS | 1995 | 10:55:16 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49696/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:17 INFO - PROCESS | 1995 | RSS: Main: 307990528 10:55:17 INFO - PROCESS | 1995 | 10:55:20 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49696/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:20 INFO - PROCESS | 1995 | RSS: Main: 347082752 10:55:20 INFO - PROCESS | 1995 | 10:55:23 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49696/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:24 INFO - PROCESS | 1995 | RSS: Main: 346685440 10:55:24 INFO - PROCESS | 1995 | 10:55:27 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49696/tests/kraken/driver.html?testName=json-parse-financial) 10:55:27 INFO - PROCESS | 1995 | RSS: Main: 346615808 10:55:27 INFO - PROCESS | 1995 | 10:55:29 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49696/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:30 INFO - PROCESS | 1995 | RSS: Main: 315224064 10:55:30 INFO - PROCESS | 1995 | 10:55:31 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:32 INFO - PROCESS | 1995 | RSS: Main: 321708032 10:55:32 INFO - PROCESS | 1995 | 10:55:34 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:35 INFO - PROCESS | 1995 | RSS: Main: 320069632 10:55:35 INFO - PROCESS | 1995 | 10:55:38 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:39 INFO - PROCESS | 1995 | RSS: Main: 326483968 10:55:39 INFO - PROCESS | 1995 | 10:55:41 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:42 INFO - PROCESS | 1995 | RSS: Main: 327622656 10:55:42 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49696/tests/kraken/driver.html?testName=ai-astar) 10:55:44 INFO - PROCESS | 1995 | RSS: Main: 370716672 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | __start_tp_report 10:55:44 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 10:55:44 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 10:55:44 INFO - PROCESS | 1995 | |i|pagename|runs| 10:55:44 INFO - PROCESS | 1995 | |0;ai-astar;103;113;114;114;108;112;112;112;113;112 10:55:44 INFO - PROCESS | 1995 | |1;audio-beat-detection;143;113;107;163;106;112;131;90;160;136 10:55:44 INFO - PROCESS | 1995 | |2;audio-dft;183;187;185;181;226;216;173;181;181;179 10:55:44 INFO - PROCESS | 1995 | |3;audio-fft;78;58;59;87;57;57;65;63;84;56 10:55:44 INFO - PROCESS | 1995 | |4;audio-oscillator;86;70;97;58;94;98;126;97;68;104 10:55:44 INFO - PROCESS | 1995 | |5;imaging-gaussian-blur;86;83;86;83;85;83;86;82;92;130 10:55:44 INFO - PROCESS | 1995 | |6;imaging-darkroom;108;149;92;92;92;92;92;92;91;92 10:55:44 INFO - PROCESS | 1995 | |7;imaging-desaturate;85;85;88;84;85;83;86;87;84;85 10:55:44 INFO - PROCESS | 1995 | |8;json-parse-financial;57;54;55;52;52;56;55;54;54;53 10:55:44 INFO - PROCESS | 1995 | |9;json-stringify-tinderbox;63;73;67;68;74;69;69;71;70;70 10:55:44 INFO - PROCESS | 1995 | |10;stanford-crypto-aes;88;85;102;103;102;104;87;85;85;86 10:55:44 INFO - PROCESS | 1995 | |11;stanford-crypto-ccm;147;152;151;139;138;136;137;139;156;140 10:55:44 INFO - PROCESS | 1995 | |12;stanford-crypto-pbkdf2;169;173;169;169;172;168;169;168;167;168 10:55:44 INFO - PROCESS | 1995 | |13;stanford-crypto-sha256-iterative;67;67;69;67;66;66;67;66;68;66 10:55:44 INFO - PROCESS | 1995 | __end_tp_report 10:55:44 INFO - PROCESS | 1995 | __start_cc_report 10:55:44 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,2067 10:55:44 INFO - PROCESS | 1995 | __end_cc_report 10:55:44 INFO - PROCESS | 1995 | __startTimestamp1471283744573__endTimestamp 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | ------- Summary: start ------- 10:55:44 INFO - PROCESS | 1995 | Number of tests: 14 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.37 (3.0%) stddev-sans-first:1.79 10:55:44 INFO - PROCESS | 1995 | Values: 103.0 113.0 114.0 114.0 108.0 112.0 112.0 112.0 113.0 112.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:139.50 stddev:24.41 (17.5%) stddev-sans-first:25.11 10:55:44 INFO - PROCESS | 1995 | Values: 143.0 113.0 107.0 163.0 106.0 112.0 131.0 90.0 160.0 136.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#2] audio-dft Cycles:10 Average:189.20 Median:184.00 stddev:17.33 (9.4%) stddev-sans-first:18.23 10:55:44 INFO - PROCESS | 1995 | Values: 183.0 187.0 185.0 181.0 226.0 216.0 173.0 181.0 181.0 179.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#3] audio-fft Cycles:10 Average:66.40 Median:64.00 stddev:11.98 (18.7%) stddev-sans-first:11.95 10:55:44 INFO - PROCESS | 1995 | Values: 78.0 58.0 59.0 87.0 57.0 57.0 65.0 63.0 84.0 56.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:90.00 stddev:19.98 (22.2%) stddev-sans-first:21.15 10:55:44 INFO - PROCESS | 1995 | Values: 86.0 70.0 97.0 58.0 94.0 98.0 126.0 97.0 68.0 104.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:85.50 stddev:14.48 (16.9%) stddev-sans-first:15.30 10:55:44 INFO - PROCESS | 1995 | Values: 86.0 83.0 86.0 83.0 85.0 83.0 86.0 82.0 92.0 130.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:92.00 stddev:18.22 (19.8%) stddev-sans-first:19.04 10:55:44 INFO - PROCESS | 1995 | Values: 108.0 149.0 92.0 92.0 92.0 92.0 92.0 92.0 91.0 92.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 10:55:44 INFO - PROCESS | 1995 | Values: 85.0 85.0 88.0 84.0 85.0 83.0 86.0 87.0 84.0 85.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.62 (3.0%) stddev-sans-first:1.36 10:55:44 INFO - PROCESS | 1995 | Values: 57.0 54.0 55.0 52.0 52.0 56.0 55.0 54.0 54.0 53.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:3.10 (4.4%) stddev-sans-first:2.26 10:55:44 INFO - PROCESS | 1995 | Values: 63.0 73.0 67.0 68.0 74.0 69.0 69.0 71.0 70.0 70.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:85.00 stddev:8.72 (10.3%) stddev-sans-first:9.08 10:55:44 INFO - PROCESS | 1995 | Values: 88.0 85.0 102.0 103.0 102.0 104.0 87.0 85.0 85.0 86.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:143.50 stddev:7.29 (5.1%) stddev-sans-first:7.62 10:55:44 INFO - PROCESS | 1995 | Values: 147.0 152.0 151.0 139.0 138.0 136.0 137.0 139.0 156.0 140.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 10:55:44 INFO - PROCESS | 1995 | Values: 169.0 173.0 169.0 169.0 172.0 168.0 169.0 168.0 167.0 168.0 10:55:44 INFO - PROCESS | 1995 | 10:55:44 INFO - PROCESS | 1995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 10:55:44 INFO - PROCESS | 1995 | Values: 67.0 67.0 69.0 67.0 66.0 66.0 67.0 66.0 68.0 66.0 10:55:44 INFO - PROCESS | 1995 | -------- Summary: end -------- 10:55:44 INFO - PROCESS | 1995 | 10:55:45 INFO - TEST-INFO | 1995: exit 0 10:55:45 INFO - TEST-OK | kraken | took 59521ms 10:55:45 INFO - SUITE-END | took 1177s 10:55:45 INFO - Completed test suite (00:19:37) 10:55:45 INFO - javascript benchmark 10:55:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.113019484738, 3286.0963235110344, 3297.1592243977784, 3325.2019515316333, 3340.4989251612255, 5560.916586251209, 5572.470615291546, 5634.267545219121, 5681.602287839853, 5702.372738998707, 5638.774449022034, 5657.886842263162, 5741.827745167651, 5743.052396354597, 5764.711764411783, 4317.784110794463, 5070.31550740649, 5129.487051294859, 5196.68819870809, 5345.4387289334645, 5272.367315922075, 5301.787928482856, 5312.73436328184, 5317.069512835258, 5329.653572517774, 4837.105135549917, 5129.204973229155, 5130.0, 5181.663191892515, 5188.066148093341, 5193.091209038404, 5207.973960130213, 5214.296070030536, 5219.895602087975, 5300.125479295912, 5195.636305458619, 5213.374395072616, 5239.895202095975, 5251.212318152269, 5296.443873393316, 4814.325994360793, 5592.944070559323, 5644.238027866268, 5738.741756620921, 5807.738651760638, 6112.047575716891, 6160.784372546939, 6167.198264225622, 6187.0, 6215.782447614311, 5695.917775622618, 6179.66011869347, 6274.0, 6310.87378252437, 6321.810345689637, 5648.378678345461, 5711.857203569861, 5775.855603609902, 5812.854678633068, 5840.0, 6203.038529028008, 6329.177206963065, 6352.333005034405, 6363.395477429637, 6371.044343348535, 6094.146819445281, 6098.0852872069545, 6115.969420152871, 6125.571210015256, 6133.694354383515, 5045.974770126126, 6202.44178023971, 6256.155419018465, 6285.057241413824, 6285.59143655661, 6016.639001659914, 6051.092336149525, 6081.513478921675, 6082.2093127893095, 6125.357545073132, 6151.907721384183, 6157.9384206158265, 6164.198654175018, 6174.845628859314, 6176.907346389808, 4912.263160525949, 4920.114379411741, 4920.75396230187, 4927.605791536668, 4949.950500494949, 4377.277749171351, 4442.222611043119, 4447.221736196153, 4479.70881892676, 4495.617872480811, 5603.10350343943, 5679.375268720438, 5693.4021927696995, 5696.572757043238, 5717.37108918027, 6236.314005459396, 6301.779437719658, 6302.527310451735, 6311.0217916223055, 6317.96841015792, 5210.869728256824, 5288.7091209983055, 5525.419830917776, 5540.806071787468, 5672.744726487318, 5355.0896347621, 5422.8915421691345, 5432.994895944263, 5437.673739575638, 5468.617196796186, 6303.054541818764, 6324.3991820776955, 6329.651869147241, 6338.080978258219, 6342.682865856688, 6136.754529818936, 6255.687215639291, 6280.9685951569945, 6289.0252010938375, 6289.308176100717, 6235.625862448086, 6246.906296405648, 6306.369363063657, 6310.842228944313, 6342.682865856781, 4988.650794444354, 6143.96928015357, 6148.985417406078, 6194.442500175006, 6195.31851496326, 6251.624902505864, 6260.624362538262, 6263.874722505433, 6273.247210334789, 6291.6539590321145, 6082.543809214415, 6098.420650038239, 6100.420460056288, 6103.542234332354, 6116.0, 5746.9712651436475, 5793.652380857162, 5955.583109182316, 6084.513238940963, 6090.939090609215, 5939.584229104094, 5941.405859414024, 5959.046552551571, 5981.820545383645, 5994.340622531431, 6078.848616835177, 6108.450239478469, 6112.602680825732, 6123.877522449615, 6131.110988906495, 5190.351206099238, 5748.568857335633, 5865.354810970875, 5867.442592953663, 6019.6990150493175], "value": 5653.675968168059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.4859129253466, 507.5330695759903, 520.6667732651102, 554.3874019208776, 558.5978095771048, 31932.84033579832, 32791.50812737808, 42785.57214427855, 43554.564454355444, 43757.34363984543, 44816.551834481645, 45045.549544504625, 45096.87257818556, 45257.0, 45257.77371113148, 9687.564059617334, 9887.406755594651, 9894.0, 9906.702798916043, 9909.256805739562, 9708.66019689311, 9837.360571562825, 9837.852432213522, 9843.950780246125, 9874.555644995957, 9814.06766357195, 9850.261230407748, 9873.358231714916, 9876.90123098767, 9900.20798336135, 9760.511974401286, 9794.118529332358, 9832.557534910946, 9835.754106147331, 9851.605935762562, 9756.07317304855, 9823.165030972375, 9823.410595364301, 9825.066618671215, 9841.409515429097, 42433.0, 42663.57336426627, 42812.0, 42858.78570607158, 42870.57129428697, 3386.4412371958597, 3402.8638854445794, 3405.1146701857447, 3418.3505134024454, 3534.6995505382074, 31479.37041259185, 32818.6718132818, 32868.178295542566, 32887.342253154806, 32971.83514082438, 3138.6778096668445, 3312.9006129815903, 3318.5354050432957, 3382.594088709346, 3420.0765793235687, 443851.0, 526580.0, 531446.0, 532178.0, 532340.676593233, 60180.0, 60580.394196058354, 60593.78812423727, 60665.69667151636, 60695.69652151711, 66313.0, 66348.33651663519, 66367.33632663611, 66379.33620663731, 66452.66773666101, 16474.670506589802, 16667.49997500077, 16688.582785430463, 16703.415380461625, 16705.582360441087, 12821.935890320488, 12860.935695321463, 12886.355682215852, 12886.548970786165, 12892.097553171376, 18049.54876128081, 18064.18711158001, 18093.366732164573, 18102.637947240983, 18301.7254741179, 5504.9449505504435, 6177.660228687465, 6197.225346831646, 6224.470919971853, 6331.810045698637, 863.0, 863.2403484933219, 879.7815026188774, 970.7961328121173, 1045.6758404894506, 28907.56638650422, 30110.397792044474, 30261.848690756404, 30568.77724891024, 30995.225119371746, 978.4862946952765, 1042.921780866438, 1079.4926384599225, 1113.3208742666966, 1116.8268918317674, 15427.92286038585, 15780.92109539445, 15831.920840395955, 16294.755578666329, 16313.939593926358, 658433.0, 830544.0, 874501.0, 881864.0, 884408.3575403286, 61322.0801687975, 62000.68999654973, 62023.0, 62024.68987655033, 62025.0, 1233.7779199743952, 1284.640300715801, 1360.143109840794, 1390.881775049132, 1402.2638114989509, 25682.8715856427, 28552.286192845346, 31637.050888473383, 31908.680913190572, 32537.02388928336, 58191.0, 58858.351374187405, 58953.82092358043, 58957.11564326625, 58996.70501647636, 562924.0, 565505.0, 565734.0, 566237.0, 567798.0, 26421.471570568865, 26923.92304307806, 27467.055929932005, 27601.723982759915, 28653.570196447487, 48437.27344089771, 49118.87776272349, 49150.75424622854, 49390.75304623454, 49472.25791613201, 34500.654993449745, 40188.79905600454, 40759.592404076764, 40872.68517363395, 40906.59093409028, 40010.599894001854, 40733.981650458976, 40900.0, 40928.590714092476, 42287.788561057, 28339.858300708365, 34256.314873701886, 39909.401358979056, 40164.995875103356, 40372.0, 35189.64810351966, 35450.29099418049, 35481.82259088688, 36236.91289261326, 36327.636723633485, 23546.293611191693, 25693.61459578145, 25760.742392575834, 26117.085901993338, 26337.341566460225], "value": 20451.15547668226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.28929521376136, 382.7894657938134, 389.9200663863907, 396.0534322968105, 408.79560219890055, 19016.619667606657, 21064.789352106476, 21224.151033958642, 21225.893870530665, 21499.92500374981, 20243.0, 20537.897310513465, 21045.26341578045, 21170.78829211711, 21328.0, 5597.188407680884, 5648.181013753004, 5813.389594092601, 5903.173555702184, 5903.911441328383, 4159.417681524589, 4387.517373088957, 5775.826725198251, 5881.382454842244, 6326.936730632704, 6596.538242323039, 6634.0, 6645.102911106987, 6671.332866713338, 6677.799666010027, 6348.84127896804, 6537.313582073862, 6596.175478065242, 6617.536772425932, 6631.237407698129, 5621.156826476021, 5640.097584386478, 5726.68503232322, 5728.598998070137, 5737.569682273846, 26212.475750484882, 26295.0, 26296.474070518674, 26335.868320658465, 26593.069242576417, 1929.0644037641732, 2156.1159924431063, 2171.8588291761143, 2204.9448763780874, 2403.3510952043025, 14697.55907322782, 15140.621484462867, 15259.923700381538, 15786.447474338458, 15817.54294768303, 1869.9158537865828, 1879.8684092113558, 1892.8769629974145, 1939.185542072333, 1948.2888745607752, 101943.49028254811, 105240.47379763129, 105298.0, 105797.47101264521, 106582.0, 10475.42385168823, 10505.474726263656, 10519.158467322595, 10602.681919542427, 10829.891701083046, 13468.461261549428, 13500.392482338319, 13528.120672156278, 13536.120152190077, 13578.660533486543, 8377.581120943929, 8518.275946544489, 8555.443896146731, 8596.269317108116, 8682.348823838238, 8634.827303453896, 8645.0, 8680.8697869532, 8781.912180878237, 8832.91167088321, 5566.638168519034, 6339.683015849189, 6468.288488266287, 6484.675766211671, 6486.708098135501, 1687.2913376381948, 1806.4761219246273, 1815.1468809659439, 1836.40316897009, 1885.632301701155, 822.7367242482468, 878.0692465985948, 973.3138137612966, 1011.5043628622069, 1022.4785359466725, 20848.0, 22242.443938901335, 22493.887530562242, 22509.54980900373, 22516.32451026472, 916.6470908700065, 926.6571368593663, 939.2251392601131, 978.0708327089294, 1044.2272718188485, 9295.302852286106, 11339.902118108177, 11617.477213525412, 11866.406679665983, 11896.405179740977, 594723.0, 607607.0, 619382.9339386286, 622553.0, 628188.0, 118926.97614071945, 122363.38818306029, 123550.0, 126533.10200347002, 127123.0, 976.6825781621002, 1006.6124542051363, 1007.9697609071886, 1021.6219998600417, 1026.1534234256767, 18631.347902823338, 19291.4212573623, 19370.903145484182, 19394.515137121685, 19451.805481945565, 51859.0, 52391.95216095733, 52666.57667251617, 53562.73218633882, 54176.72911635417, 75727.62136189285, 77033.0, 77620.0, 78054.609726951, 83302.5834870846, 7102.147742270754, 7289.39522050659, 7491.513051651626, 7908.248716371935, 8371.916280837357, 9329.0, 12159.45282462309, 12920.0, 13332.466701332227, 13425.127366721132, 11153.0, 11199.776004480027, 11645.88354116448, 11723.41382930867, 11754.353510557, 11312.547498099984, 11342.886571134182, 11513.50219803209, 11526.135539834713, 11817.0, 10084.84872726895, 11462.541498339973, 11771.587994420153, 11883.524659013889, 11908.702282443008, 7411.851762964603, 7537.924620753723, 7593.1647518774, 7674.0, 7680.116786569392, 7965.0, 9448.905510944802, 11539.653810385702, 11631.941840290745, 11726.599286206905], "value": 9761.059096854719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.9161554498958, 1355.1056302840127, 1531.2956040221495, 1652.0087947231661, 1847.7690288713902, 7638.541687498754, 8561.529115898624, 8779.912200877989, 8807.779805504857, 8907.510086945216, 8704.91295087049, 8786.253168480687, 8792.51641159736, 8796.07641197673, 8827.426217295872, 2361.504084142332, 2379.762023797624, 2381.416552944531, 2381.7975472084895, 2385.844920080198, 2325.4418939454577, 2357.5874222011166, 2379.4170428245106, 2389.163792672568, 2390.7011623547055, 2345.7419683834764, 2358.7523310052457, 2364.1725396111397, 2377.679013333195, 2382.1305223593436, 2309.4803669174303, 2339.263132113379, 2348.2250857217077, 2356.3873392917794, 2364.9172278970154, 2310.353101131669, 2338.9298321050396, 2345.319857241398, 2346.0263990443946, 2352.2472808701223, 8728.956355218246, 8762.518061506615, 8838.469691818511, 8845.4250473719, 8852.690155844579, 5207.557357624606, 5398.48714372138, 5399.298091248152, 5400.621956463049, 5444.020076386249, 3534.1341371363924, 3582.8566857325677, 3651.434027725707, 3652.945205821915, 3673.2837096766143, 1088.3252383522267, 1098.4233277529281, 1102.5314241447434, 1111.5276007696777, 1124.3310230412892, 9622.951885240598, 11344.886551134548, 11390.430478476126, 11492.885071149265, 11497.712557186054, 4552.908941821145, 4634.0, 4817.5182481752245, 4852.126617208865, 4853.9029219415415, 8459.830803383898, 9826.213902887752, 9837.655682051094, 9839.508024598741, 9846.310758246997, 5309.33633295838, 5319.760610772524, 5320.654157479751, 5329.333833270841, 5331.653442526223, 3808.920210842972, 4394.890127746832, 4531.637469002472, 4823.131836269435, 4896.0, 3463.8960831175104, 3883.9901625577554, 3973.2450834341385, 3990.461287726178, 4055.5538890721996, 1274.3946625352883, 1282.0, 1287.5300515311844, 1290.348374071088, 1292.0761655416422, 766.2069757800649, 847.7922908887363, 865.7272959018015, 924.2790623313826, 982.8476586129161, 5743.971280143573, 5802.970985145047, 5946.464818166386, 6012.368701286302, 6037.879242415215, 753.4424525850831, 854.7093988044095, 904.4980036079908, 906.428949761646, 977.193815102529, 3758.624137586274, 3848.5189351331082, 3865.1303456722576, 3900.0, 3969.3053715599654, 9063.274938004944, 10240.897591024144, 10712.78574428507, 10717.464126793786, 10719.678409647722, 10652.89347106519, 10653.84019239712, 10671.413072280944, 10672.413017284123, 10674.199435042403, 8057.194280571896, 8159.143289954588, 8177.591120443954, 8185.181481851886, 8191.098979112293, 5715.828525144252, 5830.679312637845, 5849.298084229919, 6025.548083893813, 6267.310595834546, 9714.417134971924, 9744.0, 9789.265805064791, 9975.0, 10051.396916185053, 9306.953465232631, 9815.969323221245, 10077.09306162449, 10096.545655445376, 10182.541785619516, 6981.406580440719, 7388.224236455095, 7572.356349710336, 7607.277308655669, 7691.57696326685, 8198.590070496331, 8315.417920745489, 8359.832803344021, 8381.203785640355, 8409.83180336402, 7417.517861338995, 7424.071991001125, 7504.849903002018, 7568.129665088585, 7574.621268936421, 7264.527805692613, 7286.307800758919, 7303.211563418156, 7345.595992220479, 7462.813429664302, 6863.6568171590225, 6935.826604334932, 6999.755008574675, 7018.227994920452, 7057.117860267466, 4089.550149483495, 4978.153713868579, 4995.225740010304, 5022.070916880389, 5153.793848246178, 4625.236835922035, 4892.2661600760175, 5008.200010900368, 5083.5678967288195, 5184.688918664892], "value": 4552.516981482665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [222.18568944817255, 303.17385125532917, 310.4706475459341, 314.7104663709387, 315.0516943998565, 4363.716358436704, 5211.296474975882, 5244.737763111843, 5264.6051546134, 5265.210218467232, 4872.344572208146, 4935.506449355063, 5059.544640982311, 5174.4825517448335, 5178.352705911761, 3505.5968563615256, 3981.9601803982023, 3988.302047141746, 3992.3412636914873, 4003.499562554681, 3499.91250218744, 3984.1434091670285, 3984.86052988144, 3991.580884007181, 3995.960040399588, 3632.691221246197, 3719.2561487702433, 3965.9206815863668, 3969.0672691917375, 3973.662238709713, 3134.7962382445066, 3417.923354143437, 3871.477350557667, 3887.5334959804864, 4017.834827899891, 3466.9826650866585, 3478.3043391321585, 3479.6172421033666, 3483.8432270547887, 3486.5530804716013, 4852.878678033042, 5126.538611524943, 5131.204663277198, 5133.996611981995, 5156.679494227613, 4540.636749060067, 4574.542545745432, 4586.4266966629175, 4609.700369475973, 4617.906002977979, 5414.810481633124, 5445.346558412976, 5463.235147079412, 5484.396716361197, 5533.557315414757, 3244.6917542833394, 3263.902082937516, 3510.9297814043575, 3646.08847788053, 3866.6520013198947, 4756.3816703828625, 5594.237815088234, 5668.801591944345, 5736.598438109334, 5748.770049198027, 3887.686826338324, 3904.90237744053, 3907.5701672815967, 3909.58949310324, 3923.2153569286256, 3318.8340582970754, 3953.8418463261146, 3966.6231707987695, 3968.265870813909, 3983.1635356574866, 4306.440162778818, 4526.78598195285, 4561.954380456219, 4585.633149348044, 4603.355530225771, 4570.920231294753, 5493.862653433696, 5499.422560631157, 5524.1989911462615, 5554.972225138848, 1187.1215300677436, 1308.9541866034642, 1317.7035167087329, 1351.6348488026968, 1355.66786137395, 747.5888261456178, 794.2057942057942, 859.4671303791689, 901.8061116859907, 914.410205417502, 4680.321353403806, 4801.567858892717, 4912.508749125131, 4989.002199560103, 5019.088928421506, 5528.738044553733, 5550.777968881281, 5559.72201389937, 5564.554835613141, 5576.33084029919, 4052.230076285496, 4640.930386044212, 4844.927326090112, 4901.558859702573, 4998.500149985045, 2135.9814974848928, 2423.6122220444645, 2744.1767469758993, 2824.3645179834375, 2900.6664233612983, 5002.399712034507, 5726.455986681259, 5739.827805165852, 5750.482456578928, 5758.539316854642, 4956.430010548833, 5334.359876814729, 5623.750499800112, 5679.574031947538, 5687.971560142256, 5188.870278242998, 5687.800926967537, 5709.714514274269, 5710.571707122065, 5730.046268075015, 4190.476190476191, 4814.0, 5272.2882410874045, 5498.3127109111365, 5540.778368865362, 4525.932111018403, 5260.266309722421, 5464.316960379952, 5467.430307755349, 5506.724663766716, 4723.551262630044, 4968.826091086795, 5435.619506634498, 5691.78414195978, 5723.656580605177, 3564.1267889367273, 3752.343339915449, 3863.8261278241985, 3868.3037053330672, 3881.243157584244, 5415.864603384947, 5461.563074954073, 5510.8071217507195, 5556.361018482926, 5563.58273129525, 4673.9298910517045, 4766.833160839354, 5348.753523520209, 5357.223202635674, 5407.567394608501, 4476.925537870822, 5114.872128196825, 5161.509656582619, 5348.759305831325, 5374.274472946102, 4484.641228701761, 5162.0, 5188.584913206859, 5256.290400795997, 5257.8159764408065, 4656.743879086683, 5359.866003349947, 5361.90081033395, 5366.490183432567, 5367.490088441592, 4425.446819147606, 4620.5379462053525, 4938.925651226422, 5264.552513036435, 5364.3830959440165], "value": 3953.038286967042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.6113637499374, 721.5958369470945, 763.2405756272507, 796.3072127249293, 803.7990502374408, 14857.40570377185, 16275.59311017225, 16293.837061629394, 16312.02127872327, 16329.18354082297, 14637.634059148526, 14669.779953300682, 14803.851961480408, 14818.184999825005, 14838.406463741438, 681.4854784637591, 704.2148004974442, 707.745211723779, 715.1311156944312, 840.705752986456, 705.6154395854272, 710.6872975890617, 831.5966756123275, 847.4576271186446, 853.8975322961253, 910.544727636182, 917.7659696777313, 920.9447433153998, 924.8011677489338, 927.5408672707019, 920.2086205863019, 920.8066306075732, 921.3366376209152, 923.3628796130648, 923.9399439036441, 532.7922110376957, 673.5554534007531, 678.4335080208032, 680.4420375292262, 680.5032326401705, 12293.262404255773, 12508.81236781449, 12514.18657787241, 12514.436850341757, 14787.482438114723, 13726.970477214149, 14138.0, 14399.92800035993, 14584.343704533321, 14859.331330090172, 12926.612201633967, 13469.595912122651, 13483.17950294843, 13511.459541618324, 13682.452701891913, 4699.436067671867, 4759.952400475986, 4792.329073929653, 4839.201531747258, 4915.262710593403, 119810.0, 121145.39427302896, 121966.0, 123634.76365236413, 123792.76207237902, 9251.352405331561, 11121.943415375526, 11437.71405714847, 11696.649100526998, 11831.545133952686, 19532.609347812962, 22621.547569048525, 22789.886050569974, 22791.772082278963, 23333.300000999996, 8122.959385203154, 8146.389020823462, 8197.549134797524, 8346.874796878052, 8371.079181290175, 4313.525512193656, 4373.737575745466, 4453.109378124388, 4498.0, 4551.0, 3463.255400088993, 3578.0, 3585.032041348821, 3591.2278860045217, 3591.28174365128, 556.2323992889867, 659.3011407907537, 666.6000399760202, 667.1293961380348, 667.1693741292122, 614.1984709953464, 621.1800423441105, 622.3185611755121, 644.7807745366504, 665.5108495255982, 9113.68102116436, 9226.723198304062, 9312.100638977581, 9328.626854925862, 9395.248380129573, 540.235566673161, 580.3760956971273, 592.520058752412, 603.1495591216363, 628.6950828848005, 3882.165334453106, 3892.7858967757047, 4043.6765058795227, 4079.1433798902563, 4109.630133288018, 96616.0, 97034.02965970391, 97223.51388243014, 97581.0241897572, 98128.50935745276, 78042.0, 113567.43216283865, 121310.57378852373, 129144.35427822989, 141961.87057194152, 103057.0, 106929.930700692, 107195.46402268094, 110989.0, 111894.0, 9748.171405430618, 9836.950815245878, 10011.949940250252, 10046.588406099843, 10121.139703125316, 58830.823383532945, 59098.203706572574, 59099.113513298194, 61270.0, 62065.0, 93933.0, 98404.50797745965, 99338.50992234978, 100055.0, 105186.42220366548, 13128.343582821011, 13197.802032969705, 13435.865641343462, 13614.727705446034, 13734.313284335944, 14942.103473791607, 15042.097474151586, 15203.315850786963, 15223.0, 15841.366345346058, 13845.930770346487, 13891.652708682364, 14099.013069085066, 14316.0, 14580.1980891052, 13632.250226237653, 13932.0, 14204.573862784133, 14228.075175113585, 14349.56951291463, 11304.0, 13634.250116243702, 13766.862331376558, 13974.860251397356, 14217.21805300677, 10252.43611601369, 10547.683569492927, 11225.887741122811, 11478.311301321948, 11487.13846461502, 11273.154513411362, 11397.544098235978, 11637.825677044197, 11699.473523691284, 11768.411579420823], "value": 7783.24264971164, "unit": "score"}], "name": "dromaeo_css", "value": 7353.425273824713, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 114.0, 108.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 107.0, 163.0, 106.0, 112.0, 131.0, 90.0, 160.0, 136.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 185.0, 181.0, 226.0, 216.0, 173.0, 181.0, 181.0, 179.0], "value": 189.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 87.0, 57.0, 57.0, 65.0, 63.0, 84.0, 56.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 97.0, 58.0, 94.0, 98.0, 126.0, 97.0, 68.0, 104.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 85.0, 83.0, 86.0, 82.0, 92.0, 130.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 149.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 91.0, 92.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 84.0, 85.0, 83.0, 86.0, 87.0, 84.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 52.0, 52.0, 56.0, 55.0, 54.0, 54.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 67.0, 68.0, 74.0, 69.0, 69.0, 71.0, 70.0, 70.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 102.0, 103.0, 102.0, 104.0, 87.0, 85.0, 85.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 151.0, 139.0, 138.0, 136.0, 137.0, 139.0, 156.0, 140.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 169.0, 169.0, 172.0, 168.0, 169.0, 168.0, 167.0, 168.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 66.0, 66.0, 67.0, 66.0, 68.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1452.7000000000003, "alertThreshold": 2.0}]} 10:55:45 INFO - Return code: 0 10:55:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:45 ERROR - # TBPL SUCCESS # 10:55:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:45 INFO - 2016-08-15 10:55:45.907 screenresolution[1999:16456] starting screenresolution argv=screenresolution get 10:55:45 INFO - 2016-08-15 10:55:45.910 screenresolution[1999:16456] Display 0: 1600x1200x32@60 10:55:45 INFO - 2016-08-15 10:55:45.916 screenresolution[2000:16459] starting screenresolution argv=screenresolution list 10:55:45 INFO - Available Modes on Display 0 10:55:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:46 INFO - Intel Iris: 10:55:46 INFO - Chipset Model: Intel Iris 10:55:46 INFO - Type: GPU 10:55:46 INFO - Bus: Built-In 10:55:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:46 INFO - Vendor: Intel (0x8086) 10:55:46 INFO - Device ID: 0x0a2e 10:55:46 INFO - Revision ID: 0x0009 10:55:46 INFO - Displays: 10:55:46 INFO - Display: 10:55:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:46 INFO - Display Serial Number: 1600x1200 60 10:55:46 INFO - Main Display: Yes 10:55:46 INFO - Mirror: Off 10:55:46 INFO - Online: Yes 10:55:46 INFO - Rotation: Supported 10:55:46 INFO - Return code: 0 10:55:46 INFO - Running post-action listener: _resource_record_post_action 10:55:46 INFO - [mozharness: 2016-08-15 17:55:46.152263Z] Finished run-tests step (success) 10:55:46 INFO - Running post-run listener: _resource_record_post_run 10:55:46 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 630784; Write bytes: 705669120; Read time: 3; Write time: 2005 10:55:46 INFO - TinderboxPrint: CPU usage
53.5% 10:55:46 INFO - TinderboxPrint: I/O read bytes / time
630,784 / 3 10:55:46 INFO - TinderboxPrint: I/O write bytes / time
705,669,120 / 2,005 10:55:46 INFO - TinderboxPrint: CPU idle
2,253.9 (46.5%) 10:55:46 INFO - TinderboxPrint: CPU system
966.0 (19.9%) 10:55:46 INFO - TinderboxPrint: CPU user
1,625.8 (33.6%) 10:55:46 INFO - TinderboxPrint: Swap in / out
405,037,056 / 0 10:55:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385550848; Write bytes: 379910144; Read time: 28119; Write time: 817 10:55:46 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 630784; Write bytes: 298209280; Read time: 3; Write time: 1120 10:55:46 INFO - Running post-run listener: _upload_blobber_files 10:55:46 INFO - Blob upload gear active. 10:55:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:55:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:47 INFO - (blobuploader) - INFO - Done attempting. 10:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:48 INFO - (blobuploader) - INFO - Done attempting. 10:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:51 INFO - (blobuploader) - INFO - Done attempting. 10:55:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:51 INFO - Return code: 0 10:55:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aebcd86e39636615c3821bf3aaf184c89e9071c34ff6ff2adf54506e3a160b7b2de6dff1b84113c3266cfe6e4817552b1fe01be8d5625307620947eedad2490c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c47de68839360dfedc36f6874ef4887766974a50d13e3e211cbe859dc2ecb7a97cb29e7ba15c7ee8ade0553e57b6f53ef02b6090b0721ee6d96ba09010c670ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02d9763dbbf5d1db4da0f2d8cebe686bdc5b10c39382e1ea1dec9d6eae270eca72b875c4e10d451c452bdf0a005c7b3ba2d6ff8f2a13bda5ceb03281306cbd50"} 10:55:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:51 INFO - Contents: 10:55:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aebcd86e39636615c3821bf3aaf184c89e9071c34ff6ff2adf54506e3a160b7b2de6dff1b84113c3266cfe6e4817552b1fe01be8d5625307620947eedad2490c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c47de68839360dfedc36f6874ef4887766974a50d13e3e211cbe859dc2ecb7a97cb29e7ba15c7ee8ade0553e57b6f53ef02b6090b0721ee6d96ba09010c670ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02d9763dbbf5d1db4da0f2d8cebe686bdc5b10c39382e1ea1dec9d6eae270eca72b875c4e10d451c452bdf0a005c7b3ba2d6ff8f2a13bda5ceb03281306cbd50"} 10:55:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:51 INFO - Copying logs to upload dir... 10:55:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.485885 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-15 10:55:51.871947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 10:55:51.875838) ========= 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.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aebcd86e39636615c3821bf3aaf184c89e9071c34ff6ff2adf54506e3a160b7b2de6dff1b84113c3266cfe6e4817552b1fe01be8d5625307620947eedad2490c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c47de68839360dfedc36f6874ef4887766974a50d13e3e211cbe859dc2ecb7a97cb29e7ba15c7ee8ade0553e57b6f53ef02b6090b0721ee6d96ba09010c670ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02d9763dbbf5d1db4da0f2d8cebe686bdc5b10c39382e1ea1dec9d6eae270eca72b875c4e10d451c452bdf0a005c7b3ba2d6ff8f2a13bda5ceb03281306cbd50"} build_url:https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010962 build_url: 'https://queue.taskcluster.net/v1/task/T-oL4QSURXSQuYblM_njaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aebcd86e39636615c3821bf3aaf184c89e9071c34ff6ff2adf54506e3a160b7b2de6dff1b84113c3266cfe6e4817552b1fe01be8d5625307620947eedad2490c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c47de68839360dfedc36f6874ef4887766974a50d13e3e211cbe859dc2ecb7a97cb29e7ba15c7ee8ade0553e57b6f53ef02b6090b0721ee6d96ba09010c670ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02d9763dbbf5d1db4da0f2d8cebe686bdc5b10c39382e1ea1dec9d6eae270eca72b875c4e10d451c452bdf0a005c7b3ba2d6ff8f2a13bda5ceb03281306cbd50"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 10:55:51.913737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:55:51.914444) ========= 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.iOh6twaM8p/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.BJIiljwMta/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.005083 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 10:55:51.969553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 10:55:51.969841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 10:55:51.970145) ========= ========= Total master_lag: 0.70 =========