builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1471964135.62 results: success (0) buildid: 20160823065947 builduid: 01ad60674bde4718a17ce71a9ea97517 revision: 352d2e43336522a95c803d25a48c0df63dff931d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:35.618121) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:35.618539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:35.618813) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:35.662004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:35.662335) ========= 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.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-23 07:55:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.90M=0.001s 2016-08-23 07:55:36 (9.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.443950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:36.129387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:36.129729) ========= 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.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.020738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:36.180731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-23 07:55:36.181120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 352d2e43336522a95c803d25a48c0df63dff931d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 352d2e43336522a95c803d25a48c0df63dff931d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-23 07:55:36,263 truncating revision to first 12 chars 2016-08-23 07:55:36,264 Setting DEBUG logging. 2016-08-23 07:55:36,264 attempt 1/10 2016-08-23 07:55:36,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/352d2e433365?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 07:55:37,206 unpacking tar archive at: mozilla-central-352d2e433365/testing/mozharness/ program finished with exit code 0 elapsedTime=1.203173 ========= master_lag: 1.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-23 07:55:38.635859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:38.636201) ========= script_repo_revision: 352d2e43336522a95c803d25a48c0df63dff931d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:38.639644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:38.639946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 07:55:38.690082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-23 07:55:38.690518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:55:38 INFO - MultiFileLogger online at 20160823 07:55:38 in /builds/slave/test 07:55:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:55:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:55:38 INFO - {'append_to_log': False, 07:55:38 INFO - 'base_work_dir': '/builds/slave/test', 07:55:38 INFO - 'blob_upload_branch': 'Firefox', 07:55:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:55:38 INFO - 'branch': 'Firefox', 07:55:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:38 INFO - 'config_files': ('talos/mac_config.py',), 07:55:38 INFO - 'default_actions': ('clobber', 07:55:38 INFO - 'read-buildbot-config', 07:55:38 INFO - 'download-and-extract', 07:55:38 INFO - 'populate-webroot', 07:55:38 INFO - 'create-virtualenv', 07:55:38 INFO - 'install', 07:55:38 INFO - 'run-tests'), 07:55:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:38 INFO - 'download_minidump_stackwalk': True, 07:55:38 INFO - 'download_symbols': 'ondemand', 07:55:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:38 INFO - 'installer_path': 'installer.exe', 07:55:38 INFO - 'log_level': 'info', 07:55:38 INFO - 'log_name': 'talos', 07:55:38 INFO - 'log_to_console': True, 07:55:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:55:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:55:38 INFO - 'opt_config_files': (), 07:55:38 INFO - 'pip_index': False, 07:55:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:55:38 INFO - 'cmd': ('bash', 07:55:38 INFO - '-c', 07:55:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:55:38 INFO - 'enabled': True, 07:55:38 INFO - 'halt_on_failure': False, 07:55:38 INFO - 'name': 'check_screen_resolution'},), 07:55:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:55:38 INFO - 'cmd': ('bash', 07:55:38 INFO - '-c', 07:55:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:55:38 INFO - 'enabled': True, 07:55:38 INFO - 'halt_on_failure': False, 07:55:38 INFO - 'name': 'check_screen_resolution'},), 07:55:38 INFO - 'run_cmd_checks_enabled': True, 07:55:38 INFO - 'sps_profile': False, 07:55:38 INFO - 'sps_profile_interval': 0, 07:55:38 INFO - 'suite': 'dromaeojs-e10s', 07:55:38 INFO - 'system_bits': '32', 07:55:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:38 INFO - 'title': 't-yosemite-r7-0235', 07:55:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:38 INFO - 'use_talos_json': True, 07:55:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:55:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:38 INFO - 'work_dir': 'build'} 07:55:38 INFO - [mozharness: 2016-08-23 14:55:38.892943Z] Running clobber step. 07:55:38 INFO - Running pre-action listener: _resource_record_pre_action 07:55:38 INFO - Running main action method: clobber 07:55:38 INFO - rmtree: /builds/slave/test/build 07:55:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - [mozharness: 2016-08-23 14:55:39.083247Z] Finished clobber step (success) 07:55:39 INFO - [mozharness: 2016-08-23 14:55:39.083387Z] Running read-buildbot-config step. 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: read_buildbot_config 07:55:39 INFO - Using buildbot properties: 07:55:39 INFO - { 07:55:39 INFO - "project": "", 07:55:39 INFO - "product": "firefox", 07:55:39 INFO - "script_repo_revision": "production", 07:55:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:55:39 INFO - "repository": "", 07:55:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:55:39 INFO - "buildid": "20160823065947", 07:55:39 INFO - "pgo_build": "False", 07:55:39 INFO - "basedir": "/builds/slave/test", 07:55:39 INFO - "buildnumber": 99, 07:55:39 INFO - "slavename": "t-yosemite-r7-0235", 07:55:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:55:39 INFO - "platform": "yosemite_r7", 07:55:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:55:39 INFO - "branch": "mozilla-central", 07:55:39 INFO - "repo_path": "mozilla-central", 07:55:39 INFO - "revision": "352d2e43336522a95c803d25a48c0df63dff931d", 07:55:39 INFO - "stage_platform": "macosx64", 07:55:39 INFO - "builduid": "01ad60674bde4718a17ce71a9ea97517", 07:55:39 INFO - "slavebuilddir": "test" 07:55:39 INFO - } 07:55:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - [mozharness: 2016-08-23 14:55:39.086830Z] Finished read-buildbot-config step (success) 07:55:39 INFO - [mozharness: 2016-08-23 14:55:39.086926Z] Running download-and-extract step. 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: download_and_extract 07:55:39 INFO - mkdir: /builds/slave/test/build/tests 07:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:39 INFO - trying https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:55:39 INFO - Downloading https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:40 INFO - Downloaded 1199 bytes. 07:55:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:55:40 INFO - Using the following test package requirements: 07:55:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:55:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:55:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:55:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'jsshell-mac.zip'], 07:55:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:55:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:55:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:55:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:55:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:55:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:55:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:55:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:40 INFO - trying https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:55:40 INFO - Downloading https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:41 INFO - Downloaded 16352347 bytes. 07:55: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 07:55: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 07:55: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')]} 07:55:48 INFO - trying https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:55:48 INFO - Downloading https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:49 INFO - Downloaded 16352347 bytes. 07:55: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 07:55: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')]} 07:55:56 INFO - trying https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:55:56 INFO - Downloading https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:55:58 INFO - Downloaded 14413981 bytes. 07:55: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 07:55:58 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')]} 07:55:58 INFO - trying https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:55:58 INFO - Downloading https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/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 07:56:01 INFO - Downloaded 111476996 bytes. 07:56:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:56:01 INFO - mkdir: /builds/slave/test/properties 07:56:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:01 INFO - Contents: 07:56:01 INFO - build_url:https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:56:02 INFO - Running post-action listener: _resource_record_post_action 07:56:02 INFO - Running post-action listener: set_extra_try_arguments 07:56:02 INFO - [mozharness: 2016-08-23 14:56:02.512133Z] Finished download-and-extract step (success) 07:56:02 INFO - [mozharness: 2016-08-23 14:56:02.512277Z] Running populate-webroot step. 07:56:02 INFO - Running pre-action listener: _resource_record_pre_action 07:56:02 INFO - Running main action method: populate_webroot 07:56:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:02 INFO - '--tppagecycles', 07:56:02 INFO - '7'], 07:56:02 INFO - 'tests': ['tsvgm']}}, 07:56:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['damp', 'tps']}, 07:56:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'tests': ['damp', 'tps']}, 07:56:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['dromaeo_dom']}, 07:56:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['basic_compositor_video']}, 07:56:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['a11yr', 07:56:02 INFO - 'ts_paint', 07:56:02 INFO - 'tpaint', 07:56:02 INFO - 'sessionrestore', 07:56:02 INFO - 'sessionrestore_no_auto_restore', 07:56:02 INFO - 'tabpaint']}, 07:56:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['tsvgx', 07:56:02 INFO - 'tsvgr_opacity', 07:56:02 INFO - 'tart', 07:56:02 INFO - 'tscrollx', 07:56:02 INFO - 'cart']}, 07:56:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:02 INFO - 'tsvgr_opacity', 07:56:02 INFO - 'tart', 07:56:02 INFO - 'tscrollx', 07:56:02 INFO - 'cart']}, 07:56:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'talos_options': ['--disable-e10s'], 07:56:02 INFO - 'tests': ['tp5o']}, 07:56:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'tests': ['tp5o']}, 07:56:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'talos_options': ['--disable-e10s', 07:56:02 INFO - '--xperf_path', 07:56:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:02 INFO - 'tests': ['tp5n']}, 07:56:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:02 INFO - 'talos_options': ['--xperf_path', 07:56:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:02 INFO - 'tests': ['tp5n']}}, 07:56:02 INFO - 'talos.zip': {'path': '', 07:56:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:02 INFO - Running post-action listener: _resource_record_post_action 07:56:02 INFO - [mozharness: 2016-08-23 14:56:02.531034Z] Finished populate-webroot step (success) 07:56:02 INFO - [mozharness: 2016-08-23 14:56:02.531173Z] Running create-virtualenv step. 07:56:02 INFO - Running pre-action listener: _resource_record_pre_action 07:56:02 INFO - Running main action method: create_virtualenv 07:56:02 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:02 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 07:56:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:02 INFO - Using real prefix '/tools/python27' 07:56:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:06 INFO - Installing pip.................done. 07:56:06 INFO - Return code: 0 07:56:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56: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 07:56: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 07:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:06 INFO - 'HOME': '/Users/cltbld', 07:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:06 INFO - 'LOGNAME': 'cltbld', 07:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:06 INFO - 'MOZ_NO_REMOTE': '1', 07:56:06 INFO - 'NO_EM_RESTART': '1', 07:56:06 INFO - 'PAGER': '/bin/cat', 07:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:06 INFO - 'PWD': '/builds/slave/test', 07:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:06 INFO - 'SHELL': '/bin/bash', 07:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:06 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:06 INFO - 'USER': 'cltbld', 07:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:06 INFO - 'XPC_FLAGS': '0x0', 07:56:06 INFO - 'XPC_SERVICE_NAME': '0', 07:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56: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 07:56:06 INFO - Cleaning up... 07:56:06 INFO - Return code: 0 07:56:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', '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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:56: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 psutil>=3.1.1 07:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:06 INFO - 'HOME': '/Users/cltbld', 07:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:06 INFO - 'LOGNAME': 'cltbld', 07:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:06 INFO - 'MOZ_NO_REMOTE': '1', 07:56:06 INFO - 'NO_EM_RESTART': '1', 07:56:06 INFO - 'PAGER': '/bin/cat', 07:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:06 INFO - 'PWD': '/builds/slave/test', 07:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:06 INFO - 'SHELL': '/bin/bash', 07:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:06 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:06 INFO - 'USER': 'cltbld', 07:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:06 INFO - 'XPC_FLAGS': '0x0', 07:56:06 INFO - 'XPC_SERVICE_NAME': '0', 07:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:06 INFO - Downloading/unpacking psutil>=3.1.1 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:10 INFO - Installing collected packages: psutil 07:56:10 INFO - Running setup.py install for psutil 07:56:10 INFO - building 'psutil._psutil_osx' extension 07:56:10 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 07:56:10 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 07:56:10 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 07:56:10 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 07:56:10 INFO - building 'psutil._psutil_posix' extension 07:56:10 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 07:56:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:56:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:56:10 INFO - ^ 07:56:10 INFO - 1 warning generated. 07:56:10 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 07:56:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:11 INFO - Successfully installed psutil 07:56:11 INFO - Cleaning up... 07:56:11 INFO - Return code: 0 07:56:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:11 INFO - 'HOME': '/Users/cltbld', 07:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:11 INFO - 'LOGNAME': 'cltbld', 07:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:11 INFO - 'MOZ_NO_REMOTE': '1', 07:56:11 INFO - 'NO_EM_RESTART': '1', 07:56:11 INFO - 'PAGER': '/bin/cat', 07:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:11 INFO - 'PWD': '/builds/slave/test', 07:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:11 INFO - 'SHELL': '/bin/bash', 07:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:11 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:11 INFO - 'USER': 'cltbld', 07:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:11 INFO - 'XPC_FLAGS': '0x0', 07:56:11 INFO - 'XPC_SERVICE_NAME': '0', 07:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:13 INFO - Installing collected packages: mozsystemmonitor 07:56:13 INFO - Running setup.py install for mozsystemmonitor 07:56:14 INFO - Successfully installed mozsystemmonitor 07:56:14 INFO - Cleaning up... 07:56:14 INFO - Return code: 0 07:56:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56:14 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')]} 07:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:14 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')]} 07:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:14 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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:14 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 07:56:14 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 07:56:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:14 INFO - 'HOME': '/Users/cltbld', 07:56:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:14 INFO - 'LOGNAME': 'cltbld', 07:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:14 INFO - 'MOZ_NO_REMOTE': '1', 07:56:14 INFO - 'NO_EM_RESTART': '1', 07:56:14 INFO - 'PAGER': '/bin/cat', 07:56:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:14 INFO - 'PWD': '/builds/slave/test', 07:56:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:14 INFO - 'SHELL': '/bin/bash', 07:56:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:14 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:14 INFO - 'USER': 'cltbld', 07:56:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:14 INFO - 'XPC_FLAGS': '0x0', 07:56:14 INFO - 'XPC_SERVICE_NAME': '0', 07:56:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:14 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:14 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 07:56:14 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 07:56:14 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 07:56:14 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 07:56:14 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 07:56:14 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 07:56:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:16 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 07:56:16 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 07:56:16 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 07:56:16 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 07:56:16 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 07:56:16 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 07:56:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:17 INFO - warning: no files found matching '*.txt' 07:56:17 INFO - no previously-included directories found matching 'build' 07:56:17 INFO - no previously-included directories found matching 'dist' 07:56:17 INFO - no previously-included directories found matching '.git*' 07:56:17 INFO - Installing collected packages: jsonschema, functools32 07:56:17 INFO - Running setup.py install for functools32 07:56:17 INFO - warning: no files found matching '*.txt' 07:56:17 INFO - no previously-included directories found matching 'build' 07:56:17 INFO - no previously-included directories found matching 'dist' 07:56:17 INFO - no previously-included directories found matching '.git*' 07:56:17 INFO - Successfully installed jsonschema functools32 07:56:17 INFO - Cleaning up... 07:56:17 INFO - Return code: 0 07:56:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:17 INFO - 'HOME': '/Users/cltbld', 07:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:17 INFO - 'LOGNAME': 'cltbld', 07:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:17 INFO - 'MOZ_NO_REMOTE': '1', 07:56:17 INFO - 'NO_EM_RESTART': '1', 07:56:17 INFO - 'PAGER': '/bin/cat', 07:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:17 INFO - 'PWD': '/builds/slave/test', 07:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:17 INFO - 'SHELL': '/bin/bash', 07:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:17 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:17 INFO - 'USER': 'cltbld', 07:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:17 INFO - 'XPC_FLAGS': '0x0', 07:56:17 INFO - 'XPC_SERVICE_NAME': '0', 07:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:56:17 INFO - Cleaning up... 07:56:17 INFO - Return code: 0 07:56:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:17 INFO - 'HOME': '/Users/cltbld', 07:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:17 INFO - 'LOGNAME': 'cltbld', 07:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:17 INFO - 'MOZ_NO_REMOTE': '1', 07:56:17 INFO - 'NO_EM_RESTART': '1', 07:56:17 INFO - 'PAGER': '/bin/cat', 07:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:17 INFO - 'PWD': '/builds/slave/test', 07:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:17 INFO - 'SHELL': '/bin/bash', 07:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:17 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:17 INFO - 'USER': 'cltbld', 07:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:17 INFO - 'XPC_FLAGS': '0x0', 07:56:17 INFO - 'XPC_SERVICE_NAME': '0', 07:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:56:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:21 INFO - Downloading docopt-0.6.1.tar.gz 07:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:21 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:21 INFO - Running setup.py install for blobuploader 07:56:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:56:21 INFO - Running setup.py install for requests 07:56:22 INFO - Running setup.py install for docopt 07:56:22 INFO - Successfully installed blobuploader requests docopt 07:56:22 INFO - Cleaning up... 07:56:22 INFO - Return code: 0 07:56:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:22 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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:22 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 07:56:22 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 07:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:22 INFO - 'HOME': '/Users/cltbld', 07:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:22 INFO - 'LOGNAME': 'cltbld', 07:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:22 INFO - 'MOZ_NO_REMOTE': '1', 07:56:22 INFO - 'NO_EM_RESTART': '1', 07:56:22 INFO - 'PAGER': '/bin/cat', 07:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:22 INFO - 'PWD': '/builds/slave/test', 07:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:22 INFO - 'SHELL': '/bin/bash', 07:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:22 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:22 INFO - 'USER': 'cltbld', 07:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:22 INFO - 'XPC_FLAGS': '0x0', 07:56:22 INFO - 'XPC_SERVICE_NAME': '0', 07:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:22 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-TIRY5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-m6pXlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XqqtmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-FcYmZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hUD799-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-j8FuyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-DivZPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-sWQ5y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-cfwznp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-q0mBMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:23 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mI1KtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tHdvSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-yCSvmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xlKEqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-v_CzFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-zJF1rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-gG3fmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:24 INFO - Running setup.py install for manifestparser 07:56:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:56:24 INFO - Running setup.py install for mozcrash 07:56:24 INFO - Running setup.py install for mozdebug 07:56:25 INFO - Running setup.py install for mozdevice 07:56:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Running setup.py install for mozfile 07:56:25 INFO - Running setup.py install for mozhttpd 07:56:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Running setup.py install for mozinfo 07:56:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Running setup.py install for mozInstall 07:56:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:56:25 INFO - Running setup.py install for mozleak 07:56:25 INFO - Running setup.py install for mozlog 07:56:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Running setup.py install for moznetwork 07:56:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Running setup.py install for mozprocess 07:56:26 INFO - Running setup.py install for mozprofile 07:56:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Running setup.py install for mozrunner 07:56:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:56:26 INFO - Running setup.py install for mozscreenshot 07:56:26 INFO - Running setup.py install for moztest 07:56:27 INFO - Running setup.py install for mozversion 07:56:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:56:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:27 INFO - Cleaning up... 07:56:27 INFO - Return code: 0 07:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:27 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')]} 07:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:27 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')]} 07:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:27 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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:27 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 07:56:27 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 07:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:27 INFO - 'HOME': '/Users/cltbld', 07:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:27 INFO - 'LOGNAME': 'cltbld', 07:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:27 INFO - 'MOZ_NO_REMOTE': '1', 07:56:27 INFO - 'NO_EM_RESTART': '1', 07:56:27 INFO - 'PAGER': '/bin/cat', 07:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:27 INFO - 'PWD': '/builds/slave/test', 07:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:27 INFO - 'SHELL': '/bin/bash', 07:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:27 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:27 INFO - 'USER': 'cltbld', 07:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:27 INFO - 'XPC_FLAGS': '0x0', 07:56:27 INFO - 'XPC_SERVICE_NAME': '0', 07:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:27 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-3fCVsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:27 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)) 07:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:27 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YW20PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:27 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)) 07:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:27 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YMSpjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:27 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)) 07:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:27 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-NSG8q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:27 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)) 07:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:27 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JJVHGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56: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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HKgFa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-qL3DxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-RUn4Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-a4krlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-9bmWFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6yU1fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JbWcuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JlGSsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:28 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)) 07:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:28 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-OnN5uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56: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)) 07:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xmfT3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56: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)) 07:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-yeKUf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:29 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)) 07:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HNnnpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:29 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)) 07:56:29 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)) 07:56:29 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)) 07:56:29 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)) 07:56:29 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)) 07:56:29 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)) 07:56:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:31 INFO - Downloading blessings-1.6.tar.gz 07:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:31 INFO - Installing collected packages: blessings 07:56:31 INFO - Running setup.py install for blessings 07:56:32 INFO - Successfully installed blessings 07:56:32 INFO - Cleaning up... 07:56:32 INFO - Return code: 0 07:56:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:32 INFO - Reading from file tmpfile_stdout 07:56:32 INFO - Current package versions: 07:56:32 INFO - blessings == 1.6 07:56:32 INFO - blobuploader == 1.2.4 07:56:32 INFO - docopt == 0.6.1 07:56:32 INFO - functools32 == 3.2.3-2 07:56:32 INFO - jsonschema == 2.5.1 07:56:32 INFO - manifestparser == 1.1 07:56:32 INFO - mozInstall == 1.12 07:56:32 INFO - mozcrash == 0.17 07:56:32 INFO - mozdebug == 0.1 07:56:32 INFO - mozdevice == 0.48 07:56:32 INFO - mozfile == 1.2 07:56:32 INFO - mozhttpd == 0.7 07:56:32 INFO - mozinfo == 0.9 07:56:32 INFO - mozleak == 0.1 07:56:32 INFO - mozlog == 3.3 07:56:32 INFO - moznetwork == 0.27 07:56:32 INFO - mozprocess == 0.23 07:56:32 INFO - mozprofile == 0.28 07:56:32 INFO - mozrunner == 6.12 07:56:32 INFO - mozscreenshot == 0.1 07:56:32 INFO - mozsystemmonitor == 0.3 07:56:32 INFO - moztest == 0.7 07:56:32 INFO - mozversion == 1.4 07:56:32 INFO - psutil == 3.1.1 07:56:32 INFO - requests == 1.2.3 07:56:32 INFO - wsgiref == 0.1.2 07:56:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:32 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')]} 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 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')]} 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:32 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 07:56:32 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 07:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:32 INFO - 'HOME': '/Users/cltbld', 07:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:32 INFO - 'LOGNAME': 'cltbld', 07:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:32 INFO - 'MOZ_NO_REMOTE': '1', 07:56:32 INFO - 'NO_EM_RESTART': '1', 07:56:32 INFO - 'PAGER': '/bin/cat', 07:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:32 INFO - 'PWD': '/builds/slave/test', 07:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:32 INFO - 'SHELL': '/bin/bash', 07:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:32 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:32 INFO - 'USER': 'cltbld', 07:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:32 INFO - 'XPC_FLAGS': '0x0', 07:56:32 INFO - 'XPC_SERVICE_NAME': '0', 07:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 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)) 07:56:32 INFO - Cleaning up... 07:56:32 INFO - Return code: 0 07:56:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:56:32 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')]} 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 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')]} 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 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 0x10a761a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fd8c99930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, '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.bCCgovkjGt/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.13rao7sRk4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 07:56:32 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 07:56:32 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 07:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:32 INFO - 'HOME': '/Users/cltbld', 07:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:32 INFO - 'LOGNAME': 'cltbld', 07:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:32 INFO - 'MOZ_NO_REMOTE': '1', 07:56:32 INFO - 'NO_EM_RESTART': '1', 07:56:32 INFO - 'PAGER': '/bin/cat', 07:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:32 INFO - 'PWD': '/builds/slave/test', 07:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:32 INFO - 'SHELL': '/bin/bash', 07:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:56:32 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:32 INFO - 'USER': 'cltbld', 07:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:32 INFO - 'XPC_FLAGS': '0x0', 07:56:32 INFO - 'XPC_SERVICE_NAME': '0', 07:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:56:32 INFO - Cleaning up... 07:56:32 INFO - Return code: 0 07:56:32 INFO - Running post-action listener: _resource_record_post_action 07:56:32 INFO - Running post-action listener: _start_resource_monitoring 07:56:32 INFO - Starting resource monitoring. 07:56:32 INFO - [mozharness: 2016-08-23 14:56:32.966446Z] Finished create-virtualenv step (success) 07:56:32 INFO - [mozharness: 2016-08-23 14:56:32.967488Z] Running install step. 07:56:32 INFO - Running pre-action listener: _resource_record_pre_action 07:56:32 INFO - Running main action method: install 07:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:33 INFO - Reading from file tmpfile_stdout 07:56:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:56:33 INFO - Reading from file tmpfile_stdout 07:56:33 INFO - Output received: 07:56:33 INFO - Usage: mozinstall [options] installer 07:56:33 INFO - Options: 07:56:33 INFO - -h, --help show this help message and exit 07:56:33 INFO - -d DEST, --destination=DEST 07:56:33 INFO - Directory to install application into. [default: 07:56:33 INFO - "/builds/slave/test"] 07:56:33 INFO - --app=APP Application being installed. [default: firefox] 07:56:33 INFO - mkdir: /builds/slave/test/build/application 07:56:33 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'] 07:56:33 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 07:57:08 INFO - Reading from file tmpfile_stdout 07:57:08 INFO - Output received: 07:57:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:57:08 INFO - Running post-action listener: _resource_record_post_action 07:57:08 INFO - [mozharness: 2016-08-23 14:57:08.174748Z] Finished install step (success) 07:57:08 INFO - [mozharness: 2016-08-23 14:57:08.174892Z] Running run-tests step. 07:57:08 INFO - Running pre-action listener: _resource_record_pre_action 07:57:08 INFO - Running main action method: run_tests 07:57:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:08 INFO - 2016-08-23 07:57:08.189 screenresolution[7370:378404] starting screenresolution argv=screenresolution get 07:57:08 INFO - 2016-08-23 07:57:08.192 screenresolution[7370:378404] Display 0: 1600x1200x32@60 07:57:08 INFO - 2016-08-23 07:57:08.198 screenresolution[7371:378406] starting screenresolution argv=screenresolution list 07:57:08 INFO - Available Modes on Display 0 07:57:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:08 INFO - Intel Iris: 07:57:08 INFO - Chipset Model: Intel Iris 07:57:08 INFO - Type: GPU 07:57:08 INFO - Bus: Built-In 07:57:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:08 INFO - Vendor: Intel (0x8086) 07:57:08 INFO - Device ID: 0x0a2e 07:57:08 INFO - Revision ID: 0x0009 07:57:08 INFO - Displays: 07:57:08 INFO - Display: 07:57:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:08 INFO - Display Serial Number: 1600x1200 60 07:57:08 INFO - Main Display: Yes 07:57:08 INFO - Mirror: Off 07:57:08 INFO - Online: Yes 07:57:08 INFO - Rotation: Supported 07:57:08 INFO - Return code: 0 07:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:08 INFO - Python 2.7.3 07:57:08 INFO - Return code: 0 07:57:08 INFO - grabbing minidump binary from tooltool 07:57: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')]} 07:57: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 0x10a6c5d30>, '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 0x10a42adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57: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 07:57: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 07:57: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 07:57:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:08 INFO - Return code: 0 07:57:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:57:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:57:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bCCgovkjGt/Render', 07:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:08 INFO - 'HOME': '/Users/cltbld', 07:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:08 INFO - 'LOGNAME': 'cltbld', 07:57:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:08 INFO - 'MOZ_NO_REMOTE': '1', 07:57:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:08 INFO - 'NO_EM_RESTART': '1', 07:57:08 INFO - 'PAGER': '/bin/cat', 07:57:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:08 INFO - 'PWD': '/builds/slave/test', 07:57:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:08 INFO - 'SHELL': '/bin/bash', 07:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.13rao7sRk4/Listeners', 07:57:08 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 07:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:08 INFO - 'USER': 'cltbld', 07:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:08 INFO - 'XPC_FLAGS': '0x0', 07:57:08 INFO - 'XPC_SERVICE_NAME': '0', 07:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:57:08 INFO - mozversion application_buildid: 20160823065947 07:57:08 INFO - mozversion application_changeset: 352d2e43336522a95c803d25a48c0df63dff931d 07:57:08 INFO - mozversion application_display_name: Nightly 07:57:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:08 INFO - mozversion application_name: Firefox 07:57:08 INFO - mozversion application_remotingname: firefox 07:57:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:57:08 INFO - mozversion application_vendor: Mozilla 07:57:08 INFO - mozversion application_version: 51.0a1 07:57:08 INFO - mozversion platform_buildid: 20160823065947 07:57:08 INFO - mozversion platform_changeset: 352d2e43336522a95c803d25a48c0df63dff931d 07:57:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:57:08 INFO - mozversion platform_version: 51.0a1 07:57:08 INFO - using testdate: 1471964228 07:57:08 INFO - actual date: 1471964228 07:57:08 INFO - starting webserver on 'localhost:57580' 07:57:08 INFO - SUITE-START | Running 2 tests 07:57:08 INFO - TEST-START | dromaeo_css 07:57:08 INFO - operating with platform_type : mac_ 07:57:08 INFO - Initialising browser for dromaeo_css test... 07:57:08 INFO - TEST-INFO | started process 7381 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp3djSQd/profile http://localhost:57580/getInfo.html) 07:57:11 INFO - PROCESS | 7381 | __metrics Screen width/height:1600/1200 07:57:11 INFO - PROCESS | 7381 | colorDepth:24 07:57:11 INFO - PROCESS | 7381 | Browser inner width/height: 1024/689 07:57:11 INFO - PROCESS | 7381 | __metrics 07:57:11 ERROR - PROCESS | 7381 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 07:57:12 INFO - TEST-INFO | 7381: exit 0 07:57:12 INFO - Browser initialized. 07:57:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:12 INFO - TEST-INFO | started process 7386 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp3djSQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:24 INFO - PROCESS | 7386 | RSS: Main: 239669248 07:57:24 INFO - PROCESS | 7386 | 07:58:14 INFO - PROCESS | 7386 | 1471964294094 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] 08:00:26 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57580/tests/dromaeo/cssquery-ext.html) 08:00:28 INFO - PROCESS | 7386 | RSS: Main: 254799872 08:00:28 INFO - PROCESS | 7386 | 08:03:30 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-ext.html (next: http://localhost:57580/tests/dromaeo/cssquery-jquery.html) 08:03:31 INFO - PROCESS | 7386 | RSS: Main: 265207808 08:03:31 INFO - PROCESS | 7386 | 08:06:33 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57580/tests/dromaeo/cssquery-mootools.html) 08:06:33 INFO - PROCESS | 7386 | RSS: Main: 272445440 08:06:33 INFO - PROCESS | 7386 | 08:09:35 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57580/tests/dromaeo/cssquery-prototype.html) 08:09:36 INFO - PROCESS | 7386 | RSS: Main: 271966208 08:09:36 INFO - PROCESS | 7386 | 08:12:38 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57580/tests/dromaeo/cssquery-yui.html) 08:12:39 INFO - PROCESS | 7386 | RSS: Main: 277430272 08:12:39 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-yui.html (next: http://localhost:57580/tests/dromaeo/cssquery-dojo.html) 08:15:42 INFO - PROCESS | 7386 | RSS: Main: 280051712 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | __start_tp_report 08:15:42 INFO - PROCESS | 7386 | _x_x_mozilla_page_load 08:15:42 INFO - PROCESS | 7386 | _x_x_mozilla_page_load_details 08:15:42 INFO - PROCESS | 7386 | |i|pagename|runs| 08:15:42 INFO - PROCESS | 7386 | |0;dojo.html;2804.9439011219774;3435.9141021474475;3464.6708562686554;3466.7919924804514;3467.861285548578;4965.329680493132;5737.684427356488;5937.792177273796;5954.791582294621;6064.787732429366;5900.557458190642;5943.435373639508;5952.88094238115;6012.669303188323;6056.273247210341;5382.569394448435;5445.918311225335;5469.343678758554;5504.256925315091;5516.089845175541;5272.973635131819;5283.841484755444;5355.437679043684;5469.753861076241;5511.724413779295;5363.088274993261;5395.81114660987;5399.082156033483;5402.189671549259;5404.7838086476495;5412.783488660449;5416.458354164552;5437.075697131497;5445.074337362618;5449;4441.422615060053;5297.629165958385;5331.813386531491;5411;5421.674699518042;5131.102057139986;5380.24676545284;6014.939850601481;6020.909686354708;6051.969740151271;5785.619373982195;6256.687165641745;6292.5280603954425;6302.55882088254;6306.432421082079;6185.8144255672405;6231.376862313778;6239.37606239377;6356.9364306357265;6396.648184349859;6047.516198704093;6067.211262535886;6083.330833608299;6098.969505152446;6126.326104128498;6421.357864213542;6460.580062295936;6478.611283323015;6487.578307410097;6505.056766768792;6159.96920015406;6172.537059720449;6174.38256174379;6245.906311405332;6261.499080073583;6293.937060629427;6305.211848518935;6314.431701146918;6333.923233050393;6338.904916426257;6193.659348735772;6215.160953271251;6249.0626406039455;6272.372762723691;6279.560430769802;6151.169592105009;6155.72299246526;6161.045038019114;6244.718987645567;6263.279722831932;5117.462666420047;5130.179171332569;5130.48695130484;5137.075326441276;5148.382194136652;4583.991521865184;4606.700564463299;4619.769011549409;4637.304404339376;4667.229907065364;4401.823927042947;4610.492845786961;6021.789237376758;6052.910476114342;6075.301340345828;6331.873362532723;6338.683065846782;6363.96818015907;6370.331115232926;6387.137736405526;6086.482648974798;6091.0558863376245;6099.237595300588;6108.969455152785;6119.173911521888;4841.588464980446;5521.751521181476;5576.498115169654;5621.971890140523;5650.039493286151;5533.391326954032;6552.443042341454;6553;6565.737370505126;6567.868642627121;6340.936590634219;6349.841253968688;6350.936490635035;6357.7139028742895;6364.299927008118;6265.56141070139;6373.521985851173;6397.936020639734;6430.3891130342545;6504.902426463512;6242.157308763259;6254.499640028877;6270.7805226816845;6272.027835685476;6287.811365659038;6262.373762623702;6272.8118156455375;6296.6851657417865;6328.778492752732;6340.9365906340345;6109.633421994695;6137.232845894263;6207.720652570735;6210.937890621036;6242.344553821965;6016.849578760566;6222.253329600477;6232.283287422005;6237.12680224778;6277.686115694289;4757.33397324368;5451.182322651634;6173.259208894781;6214.564980451506;6267.780627678009;6038.456538911519;6123.295820980644;6157.261128664589;6173.629582225081;6197.938020619917;6159.23009623797;6165.876682466236;6188.721507532262;6199.194104766351;6218.844528886814 08:15:42 INFO - PROCESS | 7386 | |1;ext.html;489.3149590573197;511.4195388234353;517.226746014708;528.7012837746674;556.3824155187743;37668.43497347542;40584.98537536563;40809.59190408095;40835.77492675221;40898.386524202164;41751.582484175146;42091.57908420915;42178.15643687124;42302;42343.78828105855;8690.913090869106;9759.512024398751;9807.215422766161;9813.460259685715;9835.065668761456;9635.518224088803;9708.854367184498;9718.854217186712;9735.853962190573;9749.610015599368;9637.614495420175;9694.224462043056;9718.854217186748;9719.271054670928;9760.072793084646;9699.321047526675;9721.027897210222;9731.464769437678;9748.073932976427;9762.658306959222;9653.517324133765;9686.982866798955;9716.222702183808;9721.805563888753;9728.416295022322;39562;39865.20269594592;39913.40129898054;39959.40060899089;39969.401223951005;3335.7998520088872;3530.117470632342;3634.309481198564;3895.4935858338517;4270.957290427087;31302.06093817189;31761.047168584748;31969.680303196903;32080.518792218136;32170.35659286801;3214.0851091327704;3328.6172090209693;3358.3619112368815;3395.830208489566;3443.1908501502126;300644;313551;323433.38283308665;362476;368121.1593942013;29806.701932980828;53516.73241633767;56148.877022459325;58352.708236458544;58580.4141958575;34059.48910766341;34679.82660086734;35178.82410587931;35236.64763352334;35339.823300883334;12485.31330776816;14247.643808904653;14469.638259043608;14643.48747793822;14650.706985860223;10930;12546.372681365896;12586.685332866751;12614.243145411121;12662.240265584094;7723.536587804638;7759.379249660126;7788.727394541163;7791.298783109547;7838.725644602411;2772.9445411091665;3197.4244635965283;3243.3351163012;3243.724283435887;3258.608966923937;903.3179949138358;927.8329900617954;993.5330394714473;1063.5641883457424;1154.1286328821686;30585.69414305873;30848.074557763302;30855.691443085732;30967.535486967714;31294.217644559067;994.7214779861506;1027.121810851726;1049.6536143072767;1065.4566171252718;1123.764009558002;15244.780417566568;15276;15398.692026159413;15882.682346353009;15886.60283492922;687090;689711;692000;692624;693701;57693.13460298099;58126.709366453746;58292.12561811576;58466.4153358461;58754.41245587575;1365.1399618240644;1373.9587812365644;1406.5077222972081;1406.5920882944035;1414.9504767333094;28500.714992850637;29236.26909327284;29318.70681293245;29813.850930745208;29963;48998.51001490082;49193.50806491889;49393.50606493889;49418.50581494139;49821.252681210535;529114;530844;533629;534669;537432;26663.466730665667;26756.464870702086;26957.46085078248;27056.05303814357;27111.59332609973;46689.76655116703;46953.76523117499;47399;47505.76247118742;48950.75524622354;39251.504789328945;39351.40972885466;39359;40354.596454036255;40690;39098.41352379773;39194;39413.63518188918;40666;40716.79641601773;37300.253994920495;38282.234355313296;38366;38527;38613;31180.844095779375;34774.82612586921;35203.82398087993;35291.647083528835;35417.29165416729;23659.763402365756;24762.142839286764;25743.227703168934;25875.094371697654;25950.35124121912 08:15:42 INFO - PROCESS | 7386 | |2;jquery.html;368.32596348681915;372.89186136020555;382.3137468244501;385.89002134391706;400.77756844951057;19819.702704459443;20357;21363.145474181034;21665.241716539924;21790.89104554475;11698;11967.341796201206;12040.69898252544;12097.697557561065;20161.596768064668;4948.57937075349;5596.076647353182;5636.689982050985;5642.125470552071;5692.658440493563;5302.628815982883;5527.806526771564;5537.169424586325;5575.275214222145;5599.972000139994;5554.444555544434;5570.220169176318;5577.553795696334;5580.804671836487;5592.3009623797025;5393.73031348433;5423.755930983096;5480.616356855022;5490.6431081979545;5564.054110801174;5353.411124776271;5363.222332761728;5382;5384.246205531229;5395.352557693062;13111.606651800366;13537.661558461019;23373.065077396885;23465;24396.756032439804;2181.2801775414077;2221.677856710784;2224.5439684864564;2225.2434172381304;2530.051230788454;8833.734987950373;10304.433256170907;14563;14946.103233805898;15097.773533397009;1718.6476772261656;1790.534461040126;1873.1758026468447;1901.695728683404;1909.799471055533;110276.4486177564;110887.89112108937;112887.43556282249;115781.421092894;116206;11203.663890083311;11225.326480411202;11379.65861024154;11387.999999999834;11536;14504.274786260645;14511.346989385504;14520.419183232552;14529.346179421951;14539.200343981183;7905.802354941057;8144.248986467819;8380.078191398941;8482.151784821592;8596.26931710799;8263;8305.709300174465;8311.638992849577;8466.619002144795;8479.364047696448;4479.462464504215;4481.731096134177;4528.456585209796;4531.954680453153;4570.360149579062;1895.3745264062827;1903.3433465454395;1937.2638397408894;1979.1291831594053;1986.4140078676826;844.7634662294568;863.766782968595;888.5290795878195;908.4640062363237;951.3150531617224;19346.903265483583;19691.50771230702;19821.702674459895;20026.799732002786;20400.795992040188;829.655692887457;834.7787836223406;943.3679434778714;960.3853533738413;1014.4876837197169;8379.49723016621;10037.648682296085;10515.737106572244;11089.946455086754;11155.553777848958;563619;564310;565153;583086;603492;130120;137870;138216;139089;140214;982.9017098290257;993.4337427666305;1025.6153942271649;1030.4178139351243;1032.948352582368;14639.926800366356;17832.643347133246;17909.10454477245;18551.72172417388;18629.90685046566;52940.4705952951;53405;53628.514146580346;54127;55478.72260638671;71094;72495;74500.25499744933;79545;81748;6929.341712537301;7887.566183859713;7946.417414340247;8018.4787988780545;8225.218604232588;10189.592416303265;12394.442250098587;12521.93739031299;12808.871911281141;12859.421326040163;10770.246082774443;11017.182164942695;11022.063124634496;11032.393218373067;11223.270487418291;9492.430454172772;10093.243006774375;10664.84002739975;10729.9463502682;11019.779604408028;10709.303895246783;10789.730256743644;11143.33140011602;11227.887721122685;11404.714882128013;7211.134663840373;7279;7318.926810732038;7414.8887766682465;7482.401407887465;9243.445393276425;10814.729631758953;11072.114230861673;11187.049100826522;11245.14455114897 08:15:42 INFO - PROCESS | 7386 | |3;mootools.html;1525.0849490305814;1559.9610009749758;1694.3730819596751;1770.4865588979196;1860.2466001269481;6127.908081378783;7515.924840751591;8429.283510901572;8995.145461181193;9007.144321289476;7644.96177519113;7830.725924592641;7841;7854.882176767339;7885.250901164381;2161.6001039807607;2263.3436303472054;2324.6745455636183;2364.255259593231;2368.455255291284;2054.4863784053987;2328.196772113618;2358.988205058972;2371.3834403055243;2378.369732021016;2355.7644235576477;2366.597678394677;2381.1784934197763;2381.261808839257;2382.3924899150693;2339.3215967369442;2349.5066036132434;2351.3886389538757;2353.105819788478;2362.7991620712087;2321.7910388065156;2327.150590034625;2329.149860300978;2330.370799884022;2332.988335058331;8640.740777776677;8649.697260595913;8725.127487251288;8727.869081963776;8744.475331480131;4623.676342656016;5379.757910894019;5434.239206511092;5444.700541470257;5450.373207081197;3485.9128521786906;3498.9475157872653;3556.5376501054698;3604.945925811115;3683.613220611851;1067.1676092647747;1107.058999850121;1112.8831472695413;1113.1984970820995;1129.1362107987395;11493.965543101078;11533;11584.478698458506;11615.941920290345;11660.00889924349;4590.62281315604;4695.577398034194;4858.82994095205;4870.1233777920315;4875.8049678012485;9804.215662746963;10007.699769006942;10013.449260290608;10023.949880250551;10027.448490333101;5356.46435356469;5373.435789242073;5374.8656283592445;5390.191471279261;5399.784008639689;4412.492563355255;4738.147133515931;4871.537203965618;4900.803967841246;4935.950640493621;3956;3976.5228172619472;4026.3960405938756;4069.613386728256;4111.09555897702;1290.341925617923;1311.698309388846;1319.7954317080676;1329.2290471526492;1330.660681526224;780.2353693380405;927.2442958988538;930.5533343994921;939.5208443693765;954.2747511891013;6012.458878700938;6027.6986150693165;6059.454649081604;6123.295820980555;6299.181106456132;769.6151924037981;905.5653286422554;963.6193703487083;980.9768024330616;988.6391467114595;3954.980225098856;3961.485006949078;4029.7582145071387;4085.8365665373053;4104.712670113123;10427.426491542887;10682.839757403644;10811.6215932442;10893.618723344804;10898.182636302308;10605;10829.458527073615;10835.566577336976;10861.239713219999;10873.021428071512;7802.453828231969;8107.351411887153;8133.430659853753;8152.062512811102;8270.917290827136;5917.497012753965;5928.407159284209;6039.365866583946;6063.818085457443;6174.598651087665;9888.060634239735;10029.448380339152;10104.191664666956;10118.645847395306;10150.187984961038;9974.551145198338;9978.700638980843;10211.948940255252;10241.231907607109;10362.481875906326;7045.154581450054;7402.25977402277;7536.434767392577;7601.847963040819;7729.304362607392;8583.270422014199;8609.784755381166;8610.870836937325;8613.569321533772;8681.305495560466;7491.550506969599;7625.504342217738;7629.427792915442;7711.845763084595;7771.261730135628;7332.266773322625;7374.926250737424;7448.590327532038;7499.62501874915;7565.43259255547;7015.158181018311;7193.424526038009;7194.568325900463;7203.603801790951;7204.387627051549;4205.6635469163;4923.359963204761;5029.346184996073;5118.897622047463;5127.743612819269;4951.3810773653295;4979.128652485873;5084.186530155157;5213.765380557808;5214.42641309448 08:15:42 INFO - PROCESS | 7386 | |4;prototype.html;289.4298232482011;304.2697525937749;310.8290440257858;312.35186987001947;314.8299918044256;4613.9538604613945;5362.222477740735;5629.804376293244;5709.714514274286;5716.28546431696;4606.700564463316;5420.403755586883;5578.107502799553;5622.072358060926;5633.521150702195;3859.7105217108688;4224.753697659198;4245.702800803945;4249.617534421902;4290.806913688876;4098.590140985907;4198.8320467181275;4233.640140588053;4284.271673815443;4286.442762440894;3928.37146056631;4057.5942405759483;4211.10500274876;4211.810468528924;4212.894677633053;3833.386658134699;4200.978995105035;4220.155968806221;4221;4244.7240929339805;3338.983305083483;3380.2732412531423;3655.4882316475714;3672.8530858765616;3684.457724170314;4796.280557916306;5155.350287907871;5422.725659470021;5443.836684899459;5468.26178465906;4846.176150054499;4851.151048566522;4856.635752318591;4859.854204373874;4865.19724245499;5237.852480482984;5897.351291357947;5899;5917.763289468416;5978.581499295051;3478.3304014073387;3998.9200215995807;4006.2187873364705;4011.5186177658866;4027.476428064362;4748.2640190770835;5233.816816411445;5654.342459044243;6195.6766212670245;6274.121622972787;3770.1517158639635;4007.438958545806;4057.107436363995;4074.592540745961;4080.8367665293054;3375.3080618473155;3407.063057659114;3785.299719551892;3863.8987888451657;4101.282275601758;3887.5334959805004;4750.216214324598;4767.332573439721;4790.185668436305;4837.7097374157665;5693.971530142323;5857.619254748428;5950.880982380415;5992.940070599326;6059.848503787441;1239.5992528442803;1321.651915046647;1334.419527505538;1387;1399.3562961037833;854.3208149521146;928.5218112671979;944.8535477001076;956.2015716876347;961.7932144588947;5425.565954723613;5443.564514838883;5467.7308916799875;5468.945310546844;5482.616216864782;5063.772130254148;5745.482906538432;5821.592488525847;6005.429484198994;6027.638341699512;4832.7434866934855;5217.34783152106;5439.673619582838;5453.509184173444;5485.753141108659;2307.4231442139467;2335.486193037529;2656.379608438851;2694.528457519926;2700.3789128500557;4461.866144015685;4556.430446194226;4646.842005374032;5166.689998600096;5255.106631872591;4147.52303485097;4672.509386514367;5055.494450554988;5084.3898732152375;5190.377154741455;4859.687884271227;5037.496250374933;5149.948500514947;5167.121589329898;5237.292965449692;4309.892252693582;4573.839915602938;4899.628104130849;5062.848114556569;5115.514026167508;4358.564143585616;4833.299171620025;5124.74376281177;5464.781408743605;6078.848028799315;5614.803481878114;6323.241211054703;6334.9366506334345;6355.7457701693265;6360.724227023179;3738.4018557030745;3837.7121715870862;4018.578049304781;4023.7384570002855;4059.6955228358584;5765;5978.432048955342;6074.696265186812;6125.8468538285115;6139.355367686508;4988.8276255080755;5902.350741418526;5909.645421274738;5993.760249590142;6019.939800601938;5861.9413805863105;5896.528277737856;5951.345352011362;5964.254468191476;5995.820125396245;5250.1411462574215;5579.302587176603;5692.260006199168;5801.535877129735;5816.941830581809;5949.791757288474;5954.345022047658;5976.820695379146;5994.220751302303;6050.45545900871;5660.217031635022;5843.29880414353;5861.648301101947;5877.735501902339;5929.9110513341475 08:15:42 INFO - PROCESS | 7386 | |5;yui.html;715.2168375628686;731.6902744088081;741.9777406677798;747.0400535312125;759.4418102694522;15271.38914443421;15611.531654050368;15764.448244311452;15775;15922.92038539807;14464.349104290306;14494.202818844959;14597;14598.854011459882;14630.634234144152;840.7183593496186;858.7767180533075;860.5267103093305;862.4351050062188;862.8835107260502;683.8529716111035;843.236870632079;863.995680021599;872.4111224923183;877.8727084572733;901.2069378946518;916.2669864108719;916.6837441082849;923.1875949164726;923.5059243304834;894.7449976756626;910.6539514984264;911.1435250864166;912.5072460871122;922.1285884838863;673.4948788408693;677.069030083635;678.1523096129838;678.6708446403491;680.323078536859;12542.933850622709;14542.563723088324;14761.261936903113;14820.55538333841;14861.851381486154;11499.252548584398;14596.270186490632;14675.926620366936;14886.404543818235;14906.776398354034;9652.372595781251;10244.48777561119;11527.48126334317;11593.88406115945;11617.128715346384;3526.1537231064617;3738.6635202831876;3837.3668344723087;3970.920581588381;4012.819423125937;83496;98901.51647725362;99528.50235748847;101055;104176;9585.233181345615;9770.804583908282;9998.400095994264;10694.786104277871;11311.264767790068;21392.930353482265;21425.46436339104;21698.13207471715;21800.34598962034;21801.781982179975;8252.05101413333;8280.875786863202;8413.663453461793;8438.409311348269;8533.189347012149;4551.385562949025;4582.037772067836;4598.586127248564;4617.538246175355;4618.261078227468;3044.665086840446;3129.483635200212;3153.2589841387257;3154.6372167200607;3165.778395512338;667.5360624366116;671.2012704881175;672.5942779590679;694.187800273681;696.0325148044121;580.3210244014513;655.2431941108027;672.2152684622336;677.1603212017063;683.1938312790855;9527.28545359087;9543.761405964906;9732.659356922615;9777.902220977841;9936.652217172365;560.9214709940611;599.1462166412845;609.387565496673;632.6646877155115;643.9130717353191;4352.673549483801;4489.905680109166;4730.858074257778;4795.376601041912;4800.857721478742;92684;129666;150236;157237.70385257612;158290.20854895882;114562;116769.4161529187;138212;139990;145769;120731;122486.38756806159;123709.38145309396;124227.37886310692;125552.37223814006;9163.171559816044;9246;9375.812483750151;9798.824141103114;9826.456843870968;50556.163794610424;55866.882662347336;60565;61538;65825;86969;89485.55257223672;90799;90947;91549;13026.47894084226;13121.147125436815;13315.400806963517;13415.530456433979;14013.579592612237;15145.394184232948;15159.166245856584;15192.316345764688;15537.300821463288;15930.60173495672;14016.439342426189;14129.505467308594;14190.077644953046;14266.500672476413;14749.926250368679;10662.573497060032;13474.393652285475;13821.79267310971;14279.57161285163;14516;13380.397882095524;13436.261005644783;13716.65708357299;13926.58220253394;14020.158790472604;11201.271917325348;11342.262752921033;11423.657290281304;11478.426078695864;11748.941255293668;9742.269329800152;9888.901110988798;10077.294589378673;10887.727806804893;11371.829422558503 08:15:42 INFO - PROCESS | 7386 | __end_tp_report 08:15:42 INFO - PROCESS | 7386 | __start_cc_report 08:15:42 INFO - PROCESS | 7386 | _x_x_mozilla_cycle_collect,423 08:15:42 INFO - PROCESS | 7386 | __end_cc_report 08:15:42 INFO - PROCESS | 7386 | __startTimestamp1471965342528__endTimestamp 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | ------- Summary: start ------- 08:15:42 INFO - PROCESS | 7386 | Number of tests: 6 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#0] dojo.html Cycles:165 Average:5842.98 Median:6126.33 stddev:677.41 (11.1%) stddev-sans-first:636.18 08:15:42 INFO - PROCESS | 7386 | Values: 2804.9 3435.9 3464.7 3466.8 3467.9 4965.3 5737.7 5937.8 5954.8 6064.8 5900.6 5943.4 5952.9 6012.7 6056.3 5382.6 5445.9 5469.3 5504.3 5516.1 5273.0 5283.8 5355.4 5469.8 5511.7 5363.1 5395.8 5399.1 5402.2 5404.8 5412.8 5416.5 5437.1 5445.1 5449.0 4441.4 5297.6 5331.8 5411.0 5421.7 5131.1 5380.2 6014.9 6020.9 6052.0 5785.6 6256.7 6292.5 6302.6 6306.4 6185.8 6231.4 6239.4 6356.9 6396.6 6047.5 6067.2 6083.3 6099.0 6126.3 6421.4 6460.6 6478.6 6487.6 6505.1 6160.0 6172.5 6174.4 6245.9 6261.5 6293.9 6305.2 6314.4 6333.9 6338.9 6193.7 6215.2 6249.1 6272.4 6279.6 6151.2 6155.7 6161.0 6244.7 6263.3 5117.5 5130.2 5130.5 5137.1 5148.4 4584.0 4606.7 4619.8 4637.3 4667.2 4401.8 4610.5 6021.8 6052.9 6075.3 6331.9 6338.7 6364.0 6370.3 6387.1 6086.5 6091.1 6099.2 6109.0 6119.2 4841.6 5521.8 5576.5 5622.0 5650.0 5533.4 6552.4 6553.0 6565.7 6567.9 6340.9 6349.8 6350.9 6357.7 6364.3 6265.6 6373.5 6397.9 6430.4 6504.9 6242.2 6254.5 6270.8 6272.0 6287.8 6262.4 6272.8 6296.7 6328.8 6340.9 6109.6 6137.2 6207.7 6210.9 6242.3 6016.8 6222.3 6232.3 6237.1 6277.7 4757.3 5451.2 6173.3 6214.6 6267.8 6038.5 6123.3 6157.3 6173.6 6197.9 6159.2 6165.9 6188.7 6199.2 6218.8 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#1] ext.html Cycles:180 Average:64723.13 Median:39355.20 stddev:144856.33 (368.1%) stddev-sans-first:145182.41 08:15:42 INFO - PROCESS | 7386 | Values: 489.3 511.4 517.2 528.7 556.4 37668.4 40585.0 40809.6 40835.8 40898.4 41751.6 42091.6 42178.2 42302.0 42343.8 8690.9 9759.5 9807.2 9813.5 9835.1 9635.5 9708.9 9718.9 9735.9 9749.6 9637.6 9694.2 9718.9 9719.3 9760.1 9699.3 9721.0 9731.5 9748.1 9762.7 9653.5 9687.0 9716.2 9721.8 9728.4 39562.0 39865.2 39913.4 39959.4 39969.4 3335.8 3530.1 3634.3 3895.5 4271.0 31302.1 31761.0 31969.7 32080.5 32170.4 3214.1 3328.6 3358.4 3395.8 3443.2 300644.0 313551.0 323433.4 362476.0 368121.2 29806.7 53516.7 56148.9 58352.7 58580.4 34059.5 34679.8 35178.8 35236.6 35339.8 12485.3 14247.6 14469.6 14643.5 14650.7 10930.0 12546.4 12586.7 12614.2 12662.2 7723.5 7759.4 7788.7 7791.3 7838.7 2772.9 3197.4 3243.3 3243.7 3258.6 903.3 927.8 993.5 1063.6 1154.1 30585.7 30848.1 30855.7 30967.5 31294.2 994.7 1027.1 1049.7 1065.5 1123.8 15244.8 15276.0 15398.7 15882.7 15886.6 687090.0 689711.0 692000.0 692624.0 693701.0 57693.1 58126.7 58292.1 58466.4 58754.4 1365.1 1374.0 1406.5 1406.6 1415.0 28500.7 29236.3 29318.7 29813.9 29963.0 48998.5 49193.5 49393.5 49418.5 49821.3 529114.0 530844.0 533629.0 534669.0 537432.0 26663.5 26756.5 26957.5 27056.1 27111.6 46689.8 46953.8 47399.0 47505.8 48950.8 39251.5 39351.4 39359.0 40354.6 40690.0 39098.4 39194.0 39413.6 40666.0 40716.8 37300.3 38282.2 38366.0 38527.0 38613.0 31180.8 34774.8 35203.8 35291.6 35417.3 23659.8 24762.1 25743.2 25875.1 25950.4 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#2] jquery.html Cycles:180 Average:34021.68 Median:12799.15 stddev:96590.74 (754.7%) stddev-sans-first:96828.65 08:15:42 INFO - PROCESS | 7386 | Values: 368.3 372.9 382.3 385.9 400.8 19819.7 20357.0 21363.1 21665.2 21790.9 11698.0 11967.3 12040.7 12097.7 20161.6 4948.6 5596.1 5636.7 5642.1 5692.7 5302.6 5527.8 5537.2 5575.3 5600.0 5554.4 5570.2 5577.6 5580.8 5592.3 5393.7 5423.8 5480.6 5490.6 5564.1 5353.4 5363.2 5382.0 5384.2 5395.4 13111.6 13537.7 23373.1 23465.0 24396.8 2181.3 2221.7 2224.5 2225.2 2530.1 8833.7 10304.4 14563.0 14946.1 15097.8 1718.6 1790.5 1873.2 1901.7 1909.8 110276.4 110887.9 112887.4 115781.4 116206.0 11203.7 11225.3 11379.7 11388.0 11536.0 14504.3 14511.3 14520.4 14529.3 14539.2 7905.8 8144.2 8380.1 8482.2 8596.3 8263.0 8305.7 8311.6 8466.6 8479.4 4479.5 4481.7 4528.5 4532.0 4570.4 1895.4 1903.3 1937.3 1979.1 1986.4 844.8 863.8 888.5 908.5 951.3 19346.9 19691.5 19821.7 20026.8 20400.8 829.7 834.8 943.4 960.4 1014.5 8379.5 10037.6 10515.7 11089.9 11155.6 563619.0 564310.0 565153.0 583086.0 603492.0 130120.0 137870.0 138216.0 139089.0 140214.0 982.9 993.4 1025.6 1030.4 1032.9 14639.9 17832.6 17909.1 18551.7 18629.9 52940.5 53405.0 53628.5 54127.0 55478.7 71094.0 72495.0 74500.3 79545.0 81748.0 6929.3 7887.6 7946.4 8018.5 8225.2 10189.6 12394.4 12521.9 12808.9 12859.4 10770.2 11017.2 11022.1 11032.4 11223.3 9492.4 10093.2 10664.8 10729.9 11019.8 10709.3 10789.7 11143.3 11227.9 11404.7 7211.1 7279.0 7318.9 7414.9 7482.4 9243.4 10814.7 11072.1 11187.0 11245.1 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#3] mootools.html Cycles:180 Average:5715.45 Median:4888.30 stddev:3182.16 (65.1%) stddev-sans-first:3175.50 08:15:42 INFO - PROCESS | 7386 | Values: 1525.1 1560.0 1694.4 1770.5 1860.2 6127.9 7515.9 8429.3 8995.1 9007.1 7645.0 7830.7 7841.0 7854.9 7885.3 2161.6 2263.3 2324.7 2364.3 2368.5 2054.5 2328.2 2359.0 2371.4 2378.4 2355.8 2366.6 2381.2 2381.3 2382.4 2339.3 2349.5 2351.4 2353.1 2362.8 2321.8 2327.2 2329.1 2330.4 2333.0 8640.7 8649.7 8725.1 8727.9 8744.5 4623.7 5379.8 5434.2 5444.7 5450.4 3485.9 3498.9 3556.5 3604.9 3683.6 1067.2 1107.1 1112.9 1113.2 1129.1 11494.0 11533.0 11584.5 11615.9 11660.0 4590.6 4695.6 4858.8 4870.1 4875.8 9804.2 10007.7 10013.4 10023.9 10027.4 5356.5 5373.4 5374.9 5390.2 5399.8 4412.5 4738.1 4871.5 4900.8 4936.0 3956.0 3976.5 4026.4 4069.6 4111.1 1290.3 1311.7 1319.8 1329.2 1330.7 780.2 927.2 930.6 939.5 954.3 6012.5 6027.7 6059.5 6123.3 6299.2 769.6 905.6 963.6 981.0 988.6 3955.0 3961.5 4029.8 4085.8 4104.7 10427.4 10682.8 10811.6 10893.6 10898.2 10605.0 10829.5 10835.6 10861.2 10873.0 7802.5 8107.4 8133.4 8152.1 8270.9 5917.5 5928.4 6039.4 6063.8 6174.6 9888.1 10029.4 10104.2 10118.6 10150.2 9974.6 9978.7 10211.9 10241.2 10362.5 7045.2 7402.3 7536.4 7601.8 7729.3 8583.3 8609.8 8610.9 8613.6 8681.3 7491.6 7625.5 7629.4 7711.8 7771.3 7332.3 7374.9 7448.6 7499.6 7565.4 7015.2 7193.4 7194.6 7203.6 7204.4 4205.7 4923.4 5029.3 5118.9 5127.7 4951.4 4979.1 5084.2 5213.8 5214.4 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#4] prototype.html Cycles:180 Average:4617.19 Median:5074.08 stddev:1442.37 (28.4%) stddev-sans-first:1409.37 08:15:42 INFO - PROCESS | 7386 | Values: 289.4 304.3 310.8 312.4 314.8 4614.0 5362.2 5629.8 5709.7 5716.3 4606.7 5420.4 5578.1 5622.1 5633.5 3859.7 4224.8 4245.7 4249.6 4290.8 4098.6 4198.8 4233.6 4284.3 4286.4 3928.4 4057.6 4211.1 4211.8 4212.9 3833.4 4201.0 4220.2 4221.0 4244.7 3339.0 3380.3 3655.5 3672.9 3684.5 4796.3 5155.4 5422.7 5443.8 5468.3 4846.2 4851.2 4856.6 4859.9 4865.2 5237.9 5897.4 5899.0 5917.8 5978.6 3478.3 3998.9 4006.2 4011.5 4027.5 4748.3 5233.8 5654.3 6195.7 6274.1 3770.2 4007.4 4057.1 4074.6 4080.8 3375.3 3407.1 3785.3 3863.9 4101.3 3887.5 4750.2 4767.3 4790.2 4837.7 5694.0 5857.6 5950.9 5992.9 6059.8 1239.6 1321.7 1334.4 1387.0 1399.4 854.3 928.5 944.9 956.2 961.8 5425.6 5443.6 5467.7 5468.9 5482.6 5063.8 5745.5 5821.6 6005.4 6027.6 4832.7 5217.3 5439.7 5453.5 5485.8 2307.4 2335.5 2656.4 2694.5 2700.4 4461.9 4556.4 4646.8 5166.7 5255.1 4147.5 4672.5 5055.5 5084.4 5190.4 4859.7 5037.5 5149.9 5167.1 5237.3 4309.9 4573.8 4899.6 5062.8 5115.5 4358.6 4833.3 5124.7 5464.8 6078.8 5614.8 6323.2 6334.9 6355.7 6360.7 3738.4 3837.7 4018.6 4023.7 4059.7 5765.0 5978.4 6074.7 6125.8 6139.4 4988.8 5902.4 5909.6 5993.8 6019.9 5861.9 5896.5 5951.3 5964.3 5995.8 5250.1 5579.3 5692.3 5801.5 5816.9 5949.8 5954.3 5976.8 5994.2 6050.5 5660.2 5843.3 5861.6 5877.7 5929.9 08:15:42 INFO - PROCESS | 7386 | 08:15:42 INFO - PROCESS | 7386 | [#5] yui.html Cycles:180 Average:24507.78 Median:4421.29 stddev:39098.81 (884.3%) stddev-sans-first:39167.68 08:15:42 INFO - PROCESS | 7386 | Values: 715.2 731.7 742.0 747.0 759.4 15271.4 15611.5 15764.4 15775.0 15922.9 14464.3 14494.2 14597.0 14598.9 14630.6 840.7 858.8 860.5 862.4 862.9 683.9 843.2 864.0 872.4 877.9 901.2 916.3 916.7 923.2 923.5 894.7 910.7 911.1 912.5 922.1 673.5 677.1 678.2 678.7 680.3 12542.9 14542.6 14761.3 14820.6 14861.9 11499.3 14596.3 14675.9 14886.4 14906.8 9652.4 10244.5 11527.5 11593.9 11617.1 3526.2 3738.7 3837.4 3970.9 4012.8 83496.0 98901.5 99528.5 101055.0 104176.0 9585.2 9770.8 9998.4 10694.8 11311.3 21392.9 21425.5 21698.1 21800.3 21801.8 8252.1 8280.9 8413.7 8438.4 8533.2 4551.4 4582.0 4598.6 4617.5 4618.3 3044.7 3129.5 3153.3 3154.6 3165.8 667.5 671.2 672.6 694.2 696.0 580.3 655.2 672.2 677.2 683.2 9527.3 9543.8 9732.7 9777.9 9936.7 560.9 599.1 609.4 632.7 643.9 4352.7 4489.9 4730.9 4795.4 4800.9 92684.0 129666.0 150236.0 157237.7 158290.2 114562.0 116769.4 138212.0 139990.0 145769.0 120731.0 122486.4 123709.4 124227.4 125552.4 9163.2 9246.0 9375.8 9798.8 9826.5 50556.2 55866.9 60565.0 61538.0 65825.0 86969.0 89485.6 90799.0 90947.0 91549.0 13026.5 13121.1 13315.4 13415.5 14013.6 15145.4 15159.2 15192.3 15537.3 15930.6 14016.4 14129.5 14190.1 14266.5 14749.9 10662.6 13474.4 13821.8 14279.6 14516.0 13380.4 13436.3 13716.7 13926.6 14020.2 11201.3 11342.3 11423.7 11478.4 11748.9 9742.3 9888.9 10077.3 10887.7 11371.8 08:15:42 INFO - PROCESS | 7386 | -------- Summary: end -------- 08:15:42 INFO - PROCESS | 7386 | 08:15:43 INFO - TEST-INFO | 7386: exit 0 08:15:43 INFO - TEST-OK | dromaeo_css | took 1114406ms 08:15:43 INFO - TEST-START | kraken 08:15:43 INFO - operating with platform_type : mac_ 08:15:43 INFO - Initialising browser for kraken test... 08:15:43 INFO - TEST-INFO | started process 7501 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp0AmUVx/profile http://localhost:57580/getInfo.html) 08:15:45 INFO - PROCESS | 7501 | __metrics Screen width/height:1600/1200 08:15:45 INFO - PROCESS | 7501 | colorDepth:24 08:15:45 INFO - PROCESS | 7501 | Browser inner width/height: 1024/689 08:15:45 INFO - PROCESS | 7501 | __metrics 08:15:46 ERROR - PROCESS | 7501 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 08:15:46 INFO - TEST-INFO | 7501: exit 0 08:15:46 INFO - Browser initialized. 08:15:46 INFO - Running cycle 1/1 for kraken test... 08:15:46 INFO - TEST-INFO | started process 7503 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp0AmUVx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:58 INFO - PROCESS | 7503 | RSS: Main: 239611904 08:15:58 INFO - PROCESS | 7503 | 08:16:01 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:02 INFO - PROCESS | 7503 | RSS: Main: 252530688 08:16:02 INFO - PROCESS | 7503 | 08:16:04 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-dft) 08:16:05 INFO - PROCESS | 7503 | RSS: Main: 261140480 08:16:05 INFO - PROCESS | 7503 | 08:16:09 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-fft) 08:16:09 INFO - PROCESS | 7503 | RSS: Main: 264032256 08:16:09 INFO - PROCESS | 7503 | 08:16:11 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-oscillator) 08:16:12 INFO - PROCESS | 7503 | RSS: Main: 265293824 08:16:12 INFO - PROCESS | 7503 | 08:16:14 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:15 INFO - PROCESS | 7503 | RSS: Main: 267042816 08:16:15 INFO - PROCESS | 7503 | 08:16:18 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:18 INFO - PROCESS | 7503 | RSS: Main: 267112448 08:16:18 INFO - PROCESS | 7503 | 08:16:21 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:22 INFO - PROCESS | 7503 | RSS: Main: 267362304 08:16:22 INFO - PROCESS | 7503 | 08:16:25 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57580/tests/kraken/driver.html?testName=json-parse-financial) 08:16:25 INFO - PROCESS | 7503 | RSS: Main: 267636736 08:16:25 INFO - PROCESS | 7503 | 08:16:27 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:28 INFO - PROCESS | 7503 | RSS: Main: 267325440 08:16:28 INFO - PROCESS | 7503 | 08:16:29 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:30 INFO - PROCESS | 7503 | RSS: Main: 267706368 08:16:30 INFO - PROCESS | 7503 | 08:16:32 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:33 INFO - PROCESS | 7503 | RSS: Main: 267677696 08:16:33 INFO - PROCESS | 7503 | 08:16:36 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:37 INFO - PROCESS | 7503 | RSS: Main: 267530240 08:16:37 INFO - PROCESS | 7503 | 08:16:39 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:40 INFO - PROCESS | 7503 | RSS: Main: 267907072 08:16:40 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57580/tests/kraken/driver.html?testName=ai-astar) 08:16:42 INFO - PROCESS | 7503 | RSS: Main: 270221312 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | __start_tp_report 08:16:42 INFO - PROCESS | 7503 | _x_x_mozilla_page_load 08:16:42 INFO - PROCESS | 7503 | _x_x_mozilla_page_load_details 08:16:42 INFO - PROCESS | 7503 | |i|pagename|runs| 08:16:42 INFO - PROCESS | 7503 | |0;ai-astar;108;119;110;148;102;97;158;136;146;160 08:16:42 INFO - PROCESS | 7503 | |1;audio-beat-detection;150;109;134;159;110;132;132;111;159;134 08:16:42 INFO - PROCESS | 7503 | |2;audio-dft;270;263;214;214;246;272;197;218;197;188 08:16:42 INFO - PROCESS | 7503 | |3;audio-fft;67;83;99;172;76;76;77;57;139;75 08:16:42 INFO - PROCESS | 7503 | |4;audio-oscillator;72;72;118;96;73;63;133;94;96;131 08:16:42 INFO - PROCESS | 7503 | |5;imaging-gaussian-blur;90;86;88;85;90;86;89;110;94;119 08:16:42 INFO - PROCESS | 7503 | |6;imaging-darkroom;102;140;137;94;96;95;97;96;95;97 08:16:42 INFO - PROCESS | 7503 | |7;imaging-desaturate;93;94;94;90;92;90;92;92;99;90 08:16:42 INFO - PROCESS | 7503 | |8;json-parse-financial;56;60;58;58;57;60;59;60;58;57 08:16:42 INFO - PROCESS | 7503 | |9;json-stringify-tinderbox;69;70;69;78;75;79;78;73;76;70 08:16:42 INFO - PROCESS | 7503 | |10;stanford-crypto-aes;88;86;85;82;86;90;90;83;99;85 08:16:42 INFO - PROCESS | 7503 | |11;stanford-crypto-ccm;138;140;163;147;155;132;133;142;177;157 08:16:42 INFO - PROCESS | 7503 | |12;stanford-crypto-pbkdf2;172;169;172;181;170;166;169;218;199;183 08:16:42 INFO - PROCESS | 7503 | |13;stanford-crypto-sha256-iterative;69;67;69;66;70;66;72;64;72;75 08:16:42 INFO - PROCESS | 7503 | __end_tp_report 08:16:42 INFO - PROCESS | 7503 | __start_cc_report 08:16:42 INFO - PROCESS | 7503 | _x_x_mozilla_cycle_collect,1080 08:16:42 INFO - PROCESS | 7503 | __end_cc_report 08:16:42 INFO - PROCESS | 7503 | __startTimestamp1471965402578__endTimestamp 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | ------- Summary: start ------- 08:16:42 INFO - PROCESS | 7503 | Number of tests: 14 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#0] ai-astar Cycles:10 Average:128.40 Median:147.00 stddev:23.93 (16.3%) stddev-sans-first:24.21 08:16:42 INFO - PROCESS | 7503 | Values: 108.0 119.0 110.0 148.0 102.0 97.0 158.0 136.0 146.0 160.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:134.00 stddev:18.96 (14.1%) stddev-sans-first:19.08 08:16:42 INFO - PROCESS | 7503 | Values: 150.0 109.0 134.0 159.0 110.0 132.0 132.0 111.0 159.0 134.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#2] audio-dft Cycles:10 Average:227.90 Median:232.00 stddev:32.08 (13.8%) stddev-sans-first:30.19 08:16:42 INFO - PROCESS | 7503 | Values: 270.0 263.0 214.0 214.0 246.0 272.0 197.0 218.0 197.0 188.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:35.92 (47.3%) stddev-sans-first:36.94 08:16:42 INFO - PROCESS | 7503 | Values: 67.0 83.0 99.0 172.0 76.0 76.0 77.0 57.0 139.0 75.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:72.50 stddev:25.47 (35.1%) stddev-sans-first:25.64 08:16:42 INFO - PROCESS | 7503 | Values: 72.0 72.0 118.0 96.0 73.0 63.0 133.0 94.0 96.0 131.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:88.50 stddev:11.46 (12.9%) stddev-sans-first:12.08 08:16:42 INFO - PROCESS | 7503 | Values: 90.0 86.0 88.0 85.0 90.0 86.0 89.0 110.0 94.0 119.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.50 stddev:17.85 (18.7%) stddev-sans-first:18.91 08:16:42 INFO - PROCESS | 7503 | Values: 102.0 140.0 137.0 94.0 96.0 95.0 97.0 96.0 95.0 97.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:92.50 stddev:2.72 (2.9%) stddev-sans-first:2.88 08:16:42 INFO - PROCESS | 7503 | Values: 93.0 94.0 94.0 90.0 92.0 90.0 92.0 92.0 99.0 90.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:1.42 (2.4%) stddev-sans-first:1.24 08:16:42 INFO - PROCESS | 7503 | Values: 56.0 60.0 58.0 58.0 57.0 60.0 59.0 60.0 58.0 57.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:75.50 stddev:4.00 (5.3%) stddev-sans-first:3.87 08:16:42 INFO - PROCESS | 7503 | Values: 69.0 70.0 69.0 78.0 75.0 79.0 78.0 73.0 76.0 70.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:4.86 (5.6%) stddev-sans-first:5.15 08:16:42 INFO - PROCESS | 7503 | Values: 88.0 86.0 85.0 82.0 86.0 90.0 90.0 83.0 99.0 85.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:151.00 stddev:14.44 (9.6%) stddev-sans-first:14.82 08:16:42 INFO - PROCESS | 7503 | Values: 138.0 140.0 163.0 147.0 155.0 132.0 133.0 142.0 177.0 157.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:176.50 stddev:16.60 (9.4%) stddev-sans-first:17.36 08:16:42 INFO - PROCESS | 7503 | Values: 172.0 169.0 172.0 181.0 170.0 166.0 169.0 218.0 199.0 183.0 08:16:42 INFO - PROCESS | 7503 | 08:16:42 INFO - PROCESS | 7503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:3.37 (4.8%) stddev-sans-first:3.57 08:16:42 INFO - PROCESS | 7503 | Values: 69.0 67.0 69.0 66.0 70.0 66.0 72.0 64.0 72.0 75.0 08:16:42 INFO - PROCESS | 7503 | -------- Summary: end -------- 08:16:42 INFO - PROCESS | 7503 | 08:16:43 INFO - TEST-INFO | 7503: exit 0 08:16:43 INFO - TEST-OK | kraken | took 60163ms 08:16:43 INFO - SUITE-END | took 1174s 08:16:43 INFO - Completed test suite (00:19:34) 08:16:43 INFO - javascript benchmark 08:16:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7276.435343898662, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2804.9439011219774, 3435.9141021474475, 3464.6708562686554, 3466.7919924804514, 3467.861285548578, 4965.329680493132, 5737.684427356488, 5937.792177273796, 5954.791582294621, 6064.787732429366, 5900.557458190642, 5943.435373639508, 5952.88094238115, 6012.669303188323, 6056.273247210341, 5382.569394448435, 5445.918311225335, 5469.343678758554, 5504.256925315091, 5516.089845175541, 5272.973635131819, 5283.841484755444, 5355.437679043684, 5469.753861076241, 5511.724413779295, 5363.088274993261, 5395.81114660987, 5399.082156033483, 5402.189671549259, 5404.7838086476495, 5412.783488660449, 5416.458354164552, 5437.075697131497, 5445.074337362618, 5449.0, 4441.422615060053, 5297.629165958385, 5331.813386531491, 5411.0, 5421.674699518042, 5131.102057139986, 5380.24676545284, 6014.939850601481, 6020.909686354708, 6051.969740151271, 5785.619373982195, 6256.687165641745, 6292.5280603954425, 6302.55882088254, 6306.432421082079, 6185.8144255672405, 6231.376862313778, 6239.37606239377, 6356.9364306357265, 6396.648184349859, 6047.516198704093, 6067.211262535886, 6083.330833608299, 6098.969505152446, 6126.326104128498, 6421.357864213542, 6460.580062295936, 6478.611283323015, 6487.578307410097, 6505.056766768792, 6159.96920015406, 6172.537059720449, 6174.38256174379, 6245.906311405332, 6261.499080073583, 6293.937060629427, 6305.211848518935, 6314.431701146918, 6333.923233050393, 6338.904916426257, 6193.659348735772, 6215.160953271251, 6249.0626406039455, 6272.372762723691, 6279.560430769802, 6151.169592105009, 6155.72299246526, 6161.045038019114, 6244.718987645567, 6263.279722831932, 5117.462666420047, 5130.179171332569, 5130.48695130484, 5137.075326441276, 5148.382194136652, 4583.991521865184, 4606.700564463299, 4619.769011549409, 4637.304404339376, 4667.229907065364, 4401.823927042947, 4610.492845786961, 6021.789237376758, 6052.910476114342, 6075.301340345828, 6331.873362532723, 6338.683065846782, 6363.96818015907, 6370.331115232926, 6387.137736405526, 6086.482648974798, 6091.0558863376245, 6099.237595300588, 6108.969455152785, 6119.173911521888, 4841.588464980446, 5521.751521181476, 5576.498115169654, 5621.971890140523, 5650.039493286151, 5533.391326954032, 6552.443042341454, 6553.0, 6565.737370505126, 6567.868642627121, 6340.936590634219, 6349.841253968688, 6350.936490635035, 6357.7139028742895, 6364.299927008118, 6265.56141070139, 6373.521985851173, 6397.936020639734, 6430.3891130342545, 6504.902426463512, 6242.157308763259, 6254.499640028877, 6270.7805226816845, 6272.027835685476, 6287.811365659038, 6262.373762623702, 6272.8118156455375, 6296.6851657417865, 6328.778492752732, 6340.9365906340345, 6109.633421994695, 6137.232845894263, 6207.720652570735, 6210.937890621036, 6242.344553821965, 6016.849578760566, 6222.253329600477, 6232.283287422005, 6237.12680224778, 6277.686115694289, 4757.33397324368, 5451.182322651634, 6173.259208894781, 6214.564980451506, 6267.780627678009, 6038.456538911519, 6123.295820980644, 6157.261128664589, 6173.629582225081, 6197.938020619917, 6159.23009623797, 6165.876682466236, 6188.721507532262, 6199.194104766351, 6218.844528886814], "value": 5801.150144028984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.3149590573197, 511.4195388234353, 517.226746014708, 528.7012837746674, 556.3824155187743, 37668.43497347542, 40584.98537536563, 40809.59190408095, 40835.77492675221, 40898.386524202164, 41751.582484175146, 42091.57908420915, 42178.15643687124, 42302.0, 42343.78828105855, 8690.913090869106, 9759.512024398751, 9807.215422766161, 9813.460259685715, 9835.065668761456, 9635.518224088803, 9708.854367184498, 9718.854217186712, 9735.853962190573, 9749.610015599368, 9637.614495420175, 9694.224462043056, 9718.854217186748, 9719.271054670928, 9760.072793084646, 9699.321047526675, 9721.027897210222, 9731.464769437678, 9748.073932976427, 9762.658306959222, 9653.517324133765, 9686.982866798955, 9716.222702183808, 9721.805563888753, 9728.416295022322, 39562.0, 39865.20269594592, 39913.40129898054, 39959.40060899089, 39969.401223951005, 3335.7998520088872, 3530.117470632342, 3634.309481198564, 3895.4935858338517, 4270.957290427087, 31302.06093817189, 31761.047168584748, 31969.680303196903, 32080.518792218136, 32170.35659286801, 3214.0851091327704, 3328.6172090209693, 3358.3619112368815, 3395.830208489566, 3443.1908501502126, 300644.0, 313551.0, 323433.38283308665, 362476.0, 368121.1593942013, 29806.701932980828, 53516.73241633767, 56148.877022459325, 58352.708236458544, 58580.4141958575, 34059.48910766341, 34679.82660086734, 35178.82410587931, 35236.64763352334, 35339.823300883334, 12485.31330776816, 14247.643808904653, 14469.638259043608, 14643.48747793822, 14650.706985860223, 10930.0, 12546.372681365896, 12586.685332866751, 12614.243145411121, 12662.240265584094, 7723.536587804638, 7759.379249660126, 7788.727394541163, 7791.298783109547, 7838.725644602411, 2772.9445411091665, 3197.4244635965283, 3243.3351163012, 3243.724283435887, 3258.608966923937, 903.3179949138358, 927.8329900617954, 993.5330394714473, 1063.5641883457424, 1154.1286328821686, 30585.69414305873, 30848.074557763302, 30855.691443085732, 30967.535486967714, 31294.217644559067, 994.7214779861506, 1027.121810851726, 1049.6536143072767, 1065.4566171252718, 1123.764009558002, 15244.780417566568, 15276.0, 15398.692026159413, 15882.682346353009, 15886.60283492922, 687090.0, 689711.0, 692000.0, 692624.0, 693701.0, 57693.13460298099, 58126.709366453746, 58292.12561811576, 58466.4153358461, 58754.41245587575, 1365.1399618240644, 1373.9587812365644, 1406.5077222972081, 1406.5920882944035, 1414.9504767333094, 28500.714992850637, 29236.26909327284, 29318.70681293245, 29813.850930745208, 29963.0, 48998.51001490082, 49193.50806491889, 49393.50606493889, 49418.50581494139, 49821.252681210535, 529114.0, 530844.0, 533629.0, 534669.0, 537432.0, 26663.466730665667, 26756.464870702086, 26957.46085078248, 27056.05303814357, 27111.59332609973, 46689.76655116703, 46953.76523117499, 47399.0, 47505.76247118742, 48950.75524622354, 39251.504789328945, 39351.40972885466, 39359.0, 40354.596454036255, 40690.0, 39098.41352379773, 39194.0, 39413.63518188918, 40666.0, 40716.79641601773, 37300.253994920495, 38282.234355313296, 38366.0, 38527.0, 38613.0, 31180.844095779375, 34774.82612586921, 35203.82398087993, 35291.647083528835, 35417.29165416729, 23659.763402365756, 24762.142839286764, 25743.227703168934, 25875.094371697654, 25950.35124121912], "value": 18539.435921490964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.32596348681915, 372.89186136020555, 382.3137468244501, 385.89002134391706, 400.77756844951057, 19819.702704459443, 20357.0, 21363.145474181034, 21665.241716539924, 21790.89104554475, 11698.0, 11967.341796201206, 12040.69898252544, 12097.697557561065, 20161.596768064668, 4948.57937075349, 5596.076647353182, 5636.689982050985, 5642.125470552071, 5692.658440493563, 5302.628815982883, 5527.806526771564, 5537.169424586325, 5575.275214222145, 5599.972000139994, 5554.444555544434, 5570.220169176318, 5577.553795696334, 5580.804671836487, 5592.3009623797025, 5393.73031348433, 5423.755930983096, 5480.616356855022, 5490.6431081979545, 5564.054110801174, 5353.411124776271, 5363.222332761728, 5382.0, 5384.246205531229, 5395.352557693062, 13111.606651800366, 13537.661558461019, 23373.065077396885, 23465.0, 24396.756032439804, 2181.2801775414077, 2221.677856710784, 2224.5439684864564, 2225.2434172381304, 2530.051230788454, 8833.734987950373, 10304.433256170907, 14563.0, 14946.103233805898, 15097.773533397009, 1718.6476772261656, 1790.534461040126, 1873.1758026468447, 1901.695728683404, 1909.799471055533, 110276.4486177564, 110887.89112108937, 112887.43556282249, 115781.421092894, 116206.0, 11203.663890083311, 11225.326480411202, 11379.65861024154, 11387.999999999834, 11536.0, 14504.274786260645, 14511.346989385504, 14520.419183232552, 14529.346179421951, 14539.200343981183, 7905.802354941057, 8144.248986467819, 8380.078191398941, 8482.151784821592, 8596.26931710799, 8263.0, 8305.709300174465, 8311.638992849577, 8466.619002144795, 8479.364047696448, 4479.462464504215, 4481.731096134177, 4528.456585209796, 4531.954680453153, 4570.360149579062, 1895.3745264062827, 1903.3433465454395, 1937.2638397408894, 1979.1291831594053, 1986.4140078676826, 844.7634662294568, 863.766782968595, 888.5290795878195, 908.4640062363237, 951.3150531617224, 19346.903265483583, 19691.50771230702, 19821.702674459895, 20026.799732002786, 20400.795992040188, 829.655692887457, 834.7787836223406, 943.3679434778714, 960.3853533738413, 1014.4876837197169, 8379.49723016621, 10037.648682296085, 10515.737106572244, 11089.946455086754, 11155.553777848958, 563619.0, 564310.0, 565153.0, 583086.0, 603492.0, 130120.0, 137870.0, 138216.0, 139089.0, 140214.0, 982.9017098290257, 993.4337427666305, 1025.6153942271649, 1030.4178139351243, 1032.948352582368, 14639.926800366356, 17832.643347133246, 17909.10454477245, 18551.72172417388, 18629.90685046566, 52940.4705952951, 53405.0, 53628.514146580346, 54127.0, 55478.72260638671, 71094.0, 72495.0, 74500.25499744933, 79545.0, 81748.0, 6929.341712537301, 7887.566183859713, 7946.417414340247, 8018.4787988780545, 8225.218604232588, 10189.592416303265, 12394.442250098587, 12521.93739031299, 12808.871911281141, 12859.421326040163, 10770.246082774443, 11017.182164942695, 11022.063124634496, 11032.393218373067, 11223.270487418291, 9492.430454172772, 10093.243006774375, 10664.84002739975, 10729.9463502682, 11019.779604408028, 10709.303895246783, 10789.730256743644, 11143.33140011602, 11227.887721122685, 11404.714882128013, 7211.134663840373, 7279.0, 7318.926810732038, 7414.8887766682465, 7482.401407887465, 9243.445393276425, 10814.729631758953, 11072.114230861673, 11187.049100826522, 11245.14455114897], "value": 9240.180447315346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.0849490305814, 1559.9610009749758, 1694.3730819596751, 1770.4865588979196, 1860.2466001269481, 6127.908081378783, 7515.924840751591, 8429.283510901572, 8995.145461181193, 9007.144321289476, 7644.96177519113, 7830.725924592641, 7841.0, 7854.882176767339, 7885.250901164381, 2161.6001039807607, 2263.3436303472054, 2324.6745455636183, 2364.255259593231, 2368.455255291284, 2054.4863784053987, 2328.196772113618, 2358.988205058972, 2371.3834403055243, 2378.369732021016, 2355.7644235576477, 2366.597678394677, 2381.1784934197763, 2381.261808839257, 2382.3924899150693, 2339.3215967369442, 2349.5066036132434, 2351.3886389538757, 2353.105819788478, 2362.7991620712087, 2321.7910388065156, 2327.150590034625, 2329.149860300978, 2330.370799884022, 2332.988335058331, 8640.740777776677, 8649.697260595913, 8725.127487251288, 8727.869081963776, 8744.475331480131, 4623.676342656016, 5379.757910894019, 5434.239206511092, 5444.700541470257, 5450.373207081197, 3485.9128521786906, 3498.9475157872653, 3556.5376501054698, 3604.945925811115, 3683.613220611851, 1067.1676092647747, 1107.058999850121, 1112.8831472695413, 1113.1984970820995, 1129.1362107987395, 11493.965543101078, 11533.0, 11584.478698458506, 11615.941920290345, 11660.00889924349, 4590.62281315604, 4695.577398034194, 4858.82994095205, 4870.1233777920315, 4875.8049678012485, 9804.215662746963, 10007.699769006942, 10013.449260290608, 10023.949880250551, 10027.448490333101, 5356.46435356469, 5373.435789242073, 5374.8656283592445, 5390.191471279261, 5399.784008639689, 4412.492563355255, 4738.147133515931, 4871.537203965618, 4900.803967841246, 4935.950640493621, 3956.0, 3976.5228172619472, 4026.3960405938756, 4069.613386728256, 4111.09555897702, 1290.341925617923, 1311.698309388846, 1319.7954317080676, 1329.2290471526492, 1330.660681526224, 780.2353693380405, 927.2442958988538, 930.5533343994921, 939.5208443693765, 954.2747511891013, 6012.458878700938, 6027.6986150693165, 6059.454649081604, 6123.295820980555, 6299.181106456132, 769.6151924037981, 905.5653286422554, 963.6193703487083, 980.9768024330616, 988.6391467114595, 3954.980225098856, 3961.485006949078, 4029.7582145071387, 4085.8365665373053, 4104.712670113123, 10427.426491542887, 10682.839757403644, 10811.6215932442, 10893.618723344804, 10898.182636302308, 10605.0, 10829.458527073615, 10835.566577336976, 10861.239713219999, 10873.021428071512, 7802.453828231969, 8107.351411887153, 8133.430659853753, 8152.062512811102, 8270.917290827136, 5917.497012753965, 5928.407159284209, 6039.365866583946, 6063.818085457443, 6174.598651087665, 9888.060634239735, 10029.448380339152, 10104.191664666956, 10118.645847395306, 10150.187984961038, 9974.551145198338, 9978.700638980843, 10211.948940255252, 10241.231907607109, 10362.481875906326, 7045.154581450054, 7402.25977402277, 7536.434767392577, 7601.847963040819, 7729.304362607392, 8583.270422014199, 8609.784755381166, 8610.870836937325, 8613.569321533772, 8681.305495560466, 7491.550506969599, 7625.504342217738, 7629.427792915442, 7711.845763084595, 7771.261730135628, 7332.266773322625, 7374.926250737424, 7448.590327532038, 7499.62501874915, 7565.43259255547, 7015.158181018311, 7193.424526038009, 7194.568325900463, 7203.603801790951, 7204.387627051549, 4205.6635469163, 4923.359963204761, 5029.346184996073, 5118.897622047463, 5127.743612819269, 4951.3810773653295, 4979.128652485873, 5084.186530155157, 5213.765380557808, 5214.42641309448], "value": 4606.230133181391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.4298232482011, 304.2697525937749, 310.8290440257858, 312.35186987001947, 314.8299918044256, 4613.9538604613945, 5362.222477740735, 5629.804376293244, 5709.714514274286, 5716.28546431696, 4606.700564463316, 5420.403755586883, 5578.107502799553, 5622.072358060926, 5633.521150702195, 3859.7105217108688, 4224.753697659198, 4245.702800803945, 4249.617534421902, 4290.806913688876, 4098.590140985907, 4198.8320467181275, 4233.640140588053, 4284.271673815443, 4286.442762440894, 3928.37146056631, 4057.5942405759483, 4211.10500274876, 4211.810468528924, 4212.894677633053, 3833.386658134699, 4200.978995105035, 4220.155968806221, 4221.0, 4244.7240929339805, 3338.983305083483, 3380.2732412531423, 3655.4882316475714, 3672.8530858765616, 3684.457724170314, 4796.280557916306, 5155.350287907871, 5422.725659470021, 5443.836684899459, 5468.26178465906, 4846.176150054499, 4851.151048566522, 4856.635752318591, 4859.854204373874, 4865.19724245499, 5237.852480482984, 5897.351291357947, 5899.0, 5917.763289468416, 5978.581499295051, 3478.3304014073387, 3998.9200215995807, 4006.2187873364705, 4011.5186177658866, 4027.476428064362, 4748.2640190770835, 5233.816816411445, 5654.342459044243, 6195.6766212670245, 6274.121622972787, 3770.1517158639635, 4007.438958545806, 4057.107436363995, 4074.592540745961, 4080.8367665293054, 3375.3080618473155, 3407.063057659114, 3785.299719551892, 3863.8987888451657, 4101.282275601758, 3887.5334959805004, 4750.216214324598, 4767.332573439721, 4790.185668436305, 4837.7097374157665, 5693.971530142323, 5857.619254748428, 5950.880982380415, 5992.940070599326, 6059.848503787441, 1239.5992528442803, 1321.651915046647, 1334.419527505538, 1387.0, 1399.3562961037833, 854.3208149521146, 928.5218112671979, 944.8535477001076, 956.2015716876347, 961.7932144588947, 5425.565954723613, 5443.564514838883, 5467.7308916799875, 5468.945310546844, 5482.616216864782, 5063.772130254148, 5745.482906538432, 5821.592488525847, 6005.429484198994, 6027.638341699512, 4832.7434866934855, 5217.34783152106, 5439.673619582838, 5453.509184173444, 5485.753141108659, 2307.4231442139467, 2335.486193037529, 2656.379608438851, 2694.528457519926, 2700.3789128500557, 4461.866144015685, 4556.430446194226, 4646.842005374032, 5166.689998600096, 5255.106631872591, 4147.52303485097, 4672.509386514367, 5055.494450554988, 5084.3898732152375, 5190.377154741455, 4859.687884271227, 5037.496250374933, 5149.948500514947, 5167.121589329898, 5237.292965449692, 4309.892252693582, 4573.839915602938, 4899.628104130849, 5062.848114556569, 5115.514026167508, 4358.564143585616, 4833.299171620025, 5124.74376281177, 5464.781408743605, 6078.848028799315, 5614.803481878114, 6323.241211054703, 6334.9366506334345, 6355.7457701693265, 6360.724227023179, 3738.4018557030745, 3837.7121715870862, 4018.578049304781, 4023.7384570002855, 4059.6955228358584, 5765.0, 5978.432048955342, 6074.696265186812, 6125.8468538285115, 6139.355367686508, 4988.8276255080755, 5902.350741418526, 5909.645421274738, 5993.760249590142, 6019.939800601938, 5861.9413805863105, 5896.528277737856, 5951.345352011362, 5964.254468191476, 5995.820125396245, 5250.1411462574215, 5579.302587176603, 5692.260006199168, 5801.535877129735, 5816.941830581809, 5949.791757288474, 5954.345022047658, 5976.820695379146, 5994.220751302303, 6050.45545900871, 5660.217031635022, 5843.29880414353, 5861.648301101947, 5877.735501902339, 5929.9110513341475], "value": 4156.64977367897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.2168375628686, 731.6902744088081, 741.9777406677798, 747.0400535312125, 759.4418102694522, 15271.38914443421, 15611.531654050368, 15764.448244311452, 15775.0, 15922.92038539807, 14464.349104290306, 14494.202818844959, 14597.0, 14598.854011459882, 14630.634234144152, 840.7183593496186, 858.7767180533075, 860.5267103093305, 862.4351050062188, 862.8835107260502, 683.8529716111035, 843.236870632079, 863.995680021599, 872.4111224923183, 877.8727084572733, 901.2069378946518, 916.2669864108719, 916.6837441082849, 923.1875949164726, 923.5059243304834, 894.7449976756626, 910.6539514984264, 911.1435250864166, 912.5072460871122, 922.1285884838863, 673.4948788408693, 677.069030083635, 678.1523096129838, 678.6708446403491, 680.323078536859, 12542.933850622709, 14542.563723088324, 14761.261936903113, 14820.55538333841, 14861.851381486154, 11499.252548584398, 14596.270186490632, 14675.926620366936, 14886.404543818235, 14906.776398354034, 9652.372595781251, 10244.48777561119, 11527.48126334317, 11593.88406115945, 11617.128715346384, 3526.1537231064617, 3738.6635202831876, 3837.3668344723087, 3970.920581588381, 4012.819423125937, 83496.0, 98901.51647725362, 99528.50235748847, 101055.0, 104176.0, 9585.233181345615, 9770.804583908282, 9998.400095994264, 10694.786104277871, 11311.264767790068, 21392.930353482265, 21425.46436339104, 21698.13207471715, 21800.34598962034, 21801.781982179975, 8252.05101413333, 8280.875786863202, 8413.663453461793, 8438.409311348269, 8533.189347012149, 4551.385562949025, 4582.037772067836, 4598.586127248564, 4617.538246175355, 4618.261078227468, 3044.665086840446, 3129.483635200212, 3153.2589841387257, 3154.6372167200607, 3165.778395512338, 667.5360624366116, 671.2012704881175, 672.5942779590679, 694.187800273681, 696.0325148044121, 580.3210244014513, 655.2431941108027, 672.2152684622336, 677.1603212017063, 683.1938312790855, 9527.28545359087, 9543.761405964906, 9732.659356922615, 9777.902220977841, 9936.652217172365, 560.9214709940611, 599.1462166412845, 609.387565496673, 632.6646877155115, 643.9130717353191, 4352.673549483801, 4489.905680109166, 4730.858074257778, 4795.376601041912, 4800.857721478742, 92684.0, 129666.0, 150236.0, 157237.70385257612, 158290.20854895882, 114562.0, 116769.4161529187, 138212.0, 139990.0, 145769.0, 120731.0, 122486.38756806159, 123709.38145309396, 124227.37886310692, 125552.37223814006, 9163.171559816044, 9246.0, 9375.812483750151, 9798.824141103114, 9826.456843870968, 50556.163794610424, 55866.882662347336, 60565.0, 61538.0, 65825.0, 86969.0, 89485.55257223672, 90799.0, 90947.0, 91549.0, 13026.47894084226, 13121.147125436815, 13315.400806963517, 13415.530456433979, 14013.579592612237, 15145.394184232948, 15159.166245856584, 15192.316345764688, 15537.300821463288, 15930.60173495672, 14016.439342426189, 14129.505467308594, 14190.077644953046, 14266.500672476413, 14749.926250368679, 10662.573497060032, 13474.393652285475, 13821.79267310971, 14279.57161285163, 14516.0, 13380.397882095524, 13436.261005644783, 13716.65708357299, 13926.58220253394, 14020.158790472604, 11201.271917325348, 11342.262752921033, 11423.657290281304, 11478.426078695864, 11748.941255293668, 9742.269329800152, 9888.901110988798, 10077.294589378673, 10887.727806804893, 11371.829422558503], "value": 7799.922625715298, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 110.0, 148.0, 102.0, 97.0, 158.0, 136.0, 146.0, 160.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 109.0, 134.0, 159.0, 110.0, 132.0, 132.0, 111.0, 159.0, 134.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [270.0, 263.0, 214.0, 214.0, 246.0, 272.0, 197.0, 218.0, 197.0, 188.0], "value": 227.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 99.0, 172.0, 76.0, 76.0, 77.0, 57.0, 139.0, 75.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 118.0, 96.0, 73.0, 63.0, 133.0, 94.0, 96.0, 131.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 85.0, 90.0, 86.0, 89.0, 110.0, 94.0, 119.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 140.0, 137.0, 94.0, 96.0, 95.0, 97.0, 96.0, 95.0, 97.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 90.0, 92.0, 90.0, 92.0, 92.0, 99.0, 90.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 58.0, 58.0, 57.0, 60.0, 59.0, 60.0, 58.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 78.0, 75.0, 79.0, 78.0, 73.0, 76.0, 70.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 82.0, 86.0, 90.0, 90.0, 83.0, 99.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 163.0, 147.0, 155.0, 132.0, 133.0, 142.0, 177.0, 157.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 172.0, 181.0, 170.0, 166.0, 169.0, 218.0, 199.0, 183.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 70.0, 66.0, 72.0, 64.0, 72.0, 75.0], "value": 69.0, "unit": "score"}]}]} 08:16:43 INFO - Return code: 0 08:16:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:16:43 ERROR - # TBPL SUCCESS # 08:16:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:43 INFO - 2016-08-23 08:16:43.897 screenresolution[7514:381264] starting screenresolution argv=screenresolution get 08:16:43 INFO - 2016-08-23 08:16:43.900 screenresolution[7514:381264] Display 0: 1600x1200x32@60 08:16:43 INFO - 2016-08-23 08:16:43.906 screenresolution[7515:381267] starting screenresolution argv=screenresolution list 08:16:43 INFO - Available Modes on Display 0 08:16:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:44 INFO - Intel Iris: 08:16:44 INFO - Chipset Model: Intel Iris 08:16:44 INFO - Type: GPU 08:16:44 INFO - Bus: Built-In 08:16:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:44 INFO - Vendor: Intel (0x8086) 08:16:44 INFO - Device ID: 0x0a2e 08:16:44 INFO - Revision ID: 0x0009 08:16:44 INFO - Displays: 08:16:44 INFO - Display: 08:16:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:44 INFO - Display Serial Number: 1600x1200 60 08:16:44 INFO - Main Display: Yes 08:16:44 INFO - Mirror: Off 08:16:44 INFO - Online: Yes 08:16:44 INFO - Rotation: Supported 08:16:44 INFO - Return code: 0 08:16:44 INFO - Running post-action listener: _resource_record_post_action 08:16:44 INFO - [mozharness: 2016-08-23 15:16:44.141890Z] Finished run-tests step (success) 08:16:44 INFO - Running post-run listener: _resource_record_post_run 08:16:44 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 1690624; Write bytes: 711213568; Read time: 19; Write time: 2016 08:16:44 INFO - TinderboxPrint: CPU usage
54.8% 08:16:44 INFO - TinderboxPrint: I/O read bytes / time
1,690,624 / 19 08:16:44 INFO - TinderboxPrint: I/O write bytes / time
711,213,568 / 2,016 08:16:44 INFO - TinderboxPrint: CPU idle
2,189.7 (45.2%) 08:16:44 INFO - TinderboxPrint: CPU system
984.1 (20.3%) 08:16:44 INFO - TinderboxPrint: CPU user
1,667.7 (34.4%) 08:16:44 INFO - TinderboxPrint: Swap in / out
422,510,592 / 0 08:16:44 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 405877248; Write bytes: 400689152; Read time: 30567; Write time: 815 08:16:44 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 1575936; Write bytes: 300616192; Read time: 17; Write time: 1167 08:16:44 INFO - Running post-run listener: _upload_blobber_files 08:16:44 INFO - Blob upload gear active. 08:16:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:16:44 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 08:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:16:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:45 INFO - (blobuploader) - INFO - Done attempting. 08:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:47 INFO - (blobuploader) - INFO - Done attempting. 08:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:49 INFO - (blobuploader) - INFO - Done attempting. 08:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:49 INFO - Return code: 0 08:16:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b12ee421d690b911e31521d8540379b609a65e27ad195f6194258b5c002d4c34af188217651db4b5385d09530d430e04cc71b75392e727225ad0d104d4f805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7891bbcb39886869a507aa3d964054e4281c49d3a5927ca2892f9e077ed1533d3ee85a0d6f6c8a87e72ceb9062b0fcadfca19421ae93e4540fa84e66dabf9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d039f502bb7ff50a515a1956f2fb7048aad444d5e99fddf2fd511f1e0a062c4b4a7f516df5411f78767cd8abb974dca1bf383710ebe43e817781483a59c4b30"} 08:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:16:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:16:49 INFO - Contents: 08:16:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b12ee421d690b911e31521d8540379b609a65e27ad195f6194258b5c002d4c34af188217651db4b5385d09530d430e04cc71b75392e727225ad0d104d4f805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7891bbcb39886869a507aa3d964054e4281c49d3a5927ca2892f9e077ed1533d3ee85a0d6f6c8a87e72ceb9062b0fcadfca19421ae93e4540fa84e66dabf9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d039f502bb7ff50a515a1956f2fb7048aad444d5e99fddf2fd511f1e0a062c4b4a7f516df5411f78767cd8abb974dca1bf383710ebe43e817781483a59c4b30"} 08:16:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:49 INFO - Copying logs to upload dir... 08:16:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:16:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.030382 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-23 08:16:49.771638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:16:49.774884) ========= 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.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b12ee421d690b911e31521d8540379b609a65e27ad195f6194258b5c002d4c34af188217651db4b5385d09530d430e04cc71b75392e727225ad0d104d4f805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7891bbcb39886869a507aa3d964054e4281c49d3a5927ca2892f9e077ed1533d3ee85a0d6f6c8a87e72ceb9062b0fcadfca19421ae93e4540fa84e66dabf9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d039f502bb7ff50a515a1956f2fb7048aad444d5e99fddf2fd511f1e0a062c4b4a7f516df5411f78767cd8abb974dca1bf383710ebe43e817781483a59c4b30"} build_url:https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/URUUS0aSTY21SpJMpbTVtA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b12ee421d690b911e31521d8540379b609a65e27ad195f6194258b5c002d4c34af188217651db4b5385d09530d430e04cc71b75392e727225ad0d104d4f805a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7891bbcb39886869a507aa3d964054e4281c49d3a5927ca2892f9e077ed1533d3ee85a0d6f6c8a87e72ceb9062b0fcadfca19421ae93e4540fa84e66dabf9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d039f502bb7ff50a515a1956f2fb7048aad444d5e99fddf2fd511f1e0a062c4b4a7f516df5411f78767cd8abb974dca1bf383710ebe43e817781483a59c4b30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:16:49.809570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:16:49.809898) ========= 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.bCCgovkjGt/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.13rao7sRk4/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005372 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:16:49.858260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:16:49.858582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:16:49.858895) ========= ========= Total master_lag: 1.42 =========