builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1471055731.17 results: success (0) buildid: 20160812162516 builduid: b2d258a2bbf44226897399275612483d revision: 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.171138) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.171581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.171857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.196285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.196639) ========= 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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-12 19:35:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-08-12 19:35:31 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.316216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.316560) ========= 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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.026263 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:31.365627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 19:35:31.365971) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-12 19:35:31,449 truncating revision to first 12 chars 2016-08-12 19:35:31,449 Setting DEBUG logging. 2016-08-12 19:35:31,449 attempt 1/10 2016-08-12 19:35:31,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8fd2f35a58fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 19:35:32,480 unpacking tar archive at: autoland-8fd2f35a58fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 19:35:32.696567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:32.696886) ========= script_repo_revision: 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:32.697289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:32.697567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 19:35:32.715310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-12 19:35:32.715594) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:35:32 INFO - MultiFileLogger online at 20160812 19:35:32 in /builds/slave/test 19:35:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 19:35:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:35:32 INFO - {'append_to_log': False, 19:35:32 INFO - 'base_work_dir': '/builds/slave/test', 19:35:32 INFO - 'blob_upload_branch': 'Autoland', 19:35:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:35:32 INFO - 'branch': 'Autoland', 19:35:32 INFO - 'buildbot_json_path': 'buildprops.json', 19:35:32 INFO - 'config_files': ('talos/mac_config.py',), 19:35:32 INFO - 'default_actions': ('clobber', 19:35:32 INFO - 'read-buildbot-config', 19:35:32 INFO - 'download-and-extract', 19:35:32 INFO - 'populate-webroot', 19:35:32 INFO - 'create-virtualenv', 19:35:32 INFO - 'install', 19:35:32 INFO - 'run-tests'), 19:35:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:35:32 INFO - 'download_minidump_stackwalk': True, 19:35:32 INFO - 'download_symbols': 'ondemand', 19:35:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:35:32 INFO - 'tooltool.py': '/tools/tooltool.py', 19:35:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:35:32 INFO - '/tools/misc-python/virtualenv.py')}, 19:35:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:35:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:35:32 INFO - 'installer_path': 'installer.exe', 19:35:32 INFO - 'log_level': 'info', 19:35:32 INFO - 'log_name': 'talos', 19:35:32 INFO - 'log_to_console': True, 19:35:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:35:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:35:32 INFO - 'opt_config_files': (), 19:35:32 INFO - 'pip_index': False, 19:35:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:32 INFO - 'cmd': ('bash', 19:35:32 INFO - '-c', 19:35:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:32 INFO - 'enabled': True, 19:35:32 INFO - 'halt_on_failure': False, 19:35:32 INFO - 'name': 'check_screen_resolution'},), 19:35:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:32 INFO - 'cmd': ('bash', 19:35:32 INFO - '-c', 19:35:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:32 INFO - 'enabled': True, 19:35:32 INFO - 'halt_on_failure': False, 19:35:32 INFO - 'name': 'check_screen_resolution'},), 19:35:32 INFO - 'run_cmd_checks_enabled': True, 19:35:32 INFO - 'sps_profile': False, 19:35:32 INFO - 'sps_profile_interval': 0, 19:35:32 INFO - 'suite': 'dromaeojs-e10s', 19:35:32 INFO - 'system_bits': '32', 19:35:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:35:32 INFO - 'title': 't-yosemite-r7-0314', 19:35:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:35:32 INFO - 'use_talos_json': True, 19:35:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:35:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:35:32 INFO - 'work_dir': 'build'} 19:35:32 INFO - [mozharness: 2016-08-13 02:35:32.911883Z] Running clobber step. 19:35:32 INFO - Running pre-action listener: _resource_record_pre_action 19:35:32 INFO - Running main action method: clobber 19:35:32 INFO - rmtree: /builds/slave/test/build 19:35:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:35:34 INFO - Running post-action listener: _resource_record_post_action 19:35:34 INFO - [mozharness: 2016-08-13 02:35:34.860241Z] Finished clobber step (success) 19:35:34 INFO - [mozharness: 2016-08-13 02:35:34.860449Z] Running read-buildbot-config step. 19:35:34 INFO - Running pre-action listener: _resource_record_pre_action 19:35:34 INFO - Running main action method: read_buildbot_config 19:35:34 INFO - Using buildbot properties: 19:35:34 INFO - { 19:35:34 INFO - "project": "", 19:35:34 INFO - "product": "firefox", 19:35:34 INFO - "script_repo_revision": "production", 19:35:34 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 19:35:34 INFO - "repository": "", 19:35:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 19:35:34 INFO - "buildid": "20160812162516", 19:35:34 INFO - "pgo_build": "False", 19:35:34 INFO - "basedir": "/builds/slave/test", 19:35:34 INFO - "buildnumber": 111, 19:35:34 INFO - "slavename": "t-yosemite-r7-0314", 19:35:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:35:34 INFO - "platform": "yosemite_r7", 19:35:34 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:35:34 INFO - "branch": "autoland", 19:35:34 INFO - "repo_path": "integration/autoland", 19:35:34 INFO - "revision": "8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728", 19:35:34 INFO - "stage_platform": "macosx64", 19:35:34 INFO - "builduid": "b2d258a2bbf44226897399275612483d", 19:35:34 INFO - "slavebuilddir": "test" 19:35:34 INFO - } 19:35:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:35:34 INFO - Running post-action listener: _resource_record_post_action 19:35:34 INFO - [mozharness: 2016-08-13 02:35:34.866174Z] Finished read-buildbot-config step (success) 19:35:34 INFO - [mozharness: 2016-08-13 02:35:34.866420Z] Running download-and-extract step. 19:35:34 INFO - Running pre-action listener: _resource_record_pre_action 19:35:34 INFO - Running main action method: download_and_extract 19:35:34 INFO - mkdir: /builds/slave/test/build/tests 19:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:34 INFO - trying https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:35:34 INFO - Downloading https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:35 INFO - Downloaded 1199 bytes. 19:35:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:35:35 INFO - Using the following test package requirements: 19:35:35 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:35:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:35:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:35:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'jsshell-mac.zip'], 19:35:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:35:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:35:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:35:35 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:35:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:35:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:35:35 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:35:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:35:35 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')]} 19:35:35 INFO - trying https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:35:35 INFO - Downloading https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:37 INFO - Downloaded 16329842 bytes. 19:35:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:35:44 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 19:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:44 INFO - trying https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:35:44 INFO - Downloading https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:45 INFO - Downloaded 16329842 bytes. 19:35:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:51 INFO - trying https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:35:51 INFO - Downloading https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:52 INFO - Downloaded 14413719 bytes. 19:35:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:35:52 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')]} 19:35:52 INFO - trying https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:35:52 INFO - Downloading https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/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 19:35:55 INFO - Downloaded 110973070 bytes. 19:35:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:35:55 INFO - mkdir: /builds/slave/test/properties 19:35:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:35:55 INFO - Writing to file /builds/slave/test/properties/build_url 19:35:55 INFO - Contents: 19:35:55 INFO - build_url:https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:35:56 INFO - Running post-action listener: _resource_record_post_action 19:35:56 INFO - Running post-action listener: set_extra_try_arguments 19:35:56 INFO - [mozharness: 2016-08-13 02:35:56.453063Z] Finished download-and-extract step (success) 19:35:56 INFO - [mozharness: 2016-08-13 02:35:56.453202Z] Running populate-webroot step. 19:35:56 INFO - Running pre-action listener: _resource_record_pre_action 19:35:56 INFO - Running main action method: populate_webroot 19:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:35:56 INFO - '--tppagecycles', 19:35:56 INFO - '7'], 19:35:56 INFO - 'tests': ['tsvgm']}}, 19:35:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:35:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:35:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:35:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['damp', 'tps']}, 19:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'tests': ['damp', 'tps']}, 19:35:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['dromaeo_dom']}, 19:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:35:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['basic_compositor_video']}, 19:35:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:35:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'other-e10s': {'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['a11yr', 19:35:56 INFO - 'ts_paint', 19:35:56 INFO - 'tpaint', 19:35:56 INFO - 'sessionrestore', 19:35:56 INFO - 'sessionrestore_no_auto_restore', 19:35:56 INFO - 'tabpaint']}, 19:35:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['tsvgx', 19:35:56 INFO - 'tsvgr_opacity', 19:35:56 INFO - 'tart', 19:35:56 INFO - 'tscrollx', 19:35:56 INFO - 'cart']}, 19:35:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:35:56 INFO - 'tsvgr_opacity', 19:35:56 INFO - 'tart', 19:35:56 INFO - 'tscrollx', 19:35:56 INFO - 'cart']}, 19:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'talos_options': ['--disable-e10s'], 19:35:56 INFO - 'tests': ['tp5o']}, 19:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'tests': ['tp5o']}, 19:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'talos_options': ['--disable-e10s', 19:35:56 INFO - '--xperf_path', 19:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:56 INFO - 'tests': ['tp5n']}, 19:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:35:56 INFO - 'talos_options': ['--xperf_path', 19:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:56 INFO - 'tests': ['tp5n']}}, 19:35:56 INFO - 'talos.zip': {'path': '', 19:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:35:56 INFO - Running post-action listener: _resource_record_post_action 19:35:56 INFO - [mozharness: 2016-08-13 02:35:56.471846Z] Finished populate-webroot step (success) 19:35:56 INFO - [mozharness: 2016-08-13 02:35:56.471983Z] Running create-virtualenv step. 19:35:56 INFO - Running pre-action listener: _resource_record_pre_action 19:35:56 INFO - Running main action method: create_virtualenv 19:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 19:35:56 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 19:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:35:56 INFO - Using real prefix '/tools/python27' 19:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:00 INFO - Installing pip.................done. 19:36:00 INFO - Return code: 0 19:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:00 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')]} 19:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:00 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')]} 19:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:00 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:00 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 19:36:00 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 19:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:00 INFO - 'HOME': '/Users/cltbld', 19:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:00 INFO - 'LOGNAME': 'cltbld', 19:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:00 INFO - 'MOZ_NO_REMOTE': '1', 19:36:00 INFO - 'NO_EM_RESTART': '1', 19:36:00 INFO - 'PAGER': '/bin/cat', 19:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:00 INFO - 'PWD': '/builds/slave/test', 19:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:00 INFO - 'SHELL': '/bin/bash', 19:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:00 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:00 INFO - 'USER': 'cltbld', 19:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:00 INFO - 'XPC_FLAGS': '0x0', 19:36:00 INFO - 'XPC_SERVICE_NAME': '0', 19:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:00 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 19:36:00 INFO - Cleaning up... 19:36:00 INFO - Return code: 0 19:36:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:36:00 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')]} 19:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:00 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')]} 19:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:00 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:00 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 19:36:00 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 19:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:00 INFO - 'HOME': '/Users/cltbld', 19:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:00 INFO - 'LOGNAME': 'cltbld', 19:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:00 INFO - 'MOZ_NO_REMOTE': '1', 19:36:00 INFO - 'NO_EM_RESTART': '1', 19:36:00 INFO - 'PAGER': '/bin/cat', 19:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:00 INFO - 'PWD': '/builds/slave/test', 19:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:00 INFO - 'SHELL': '/bin/bash', 19:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:00 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:00 INFO - 'USER': 'cltbld', 19:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:00 INFO - 'XPC_FLAGS': '0x0', 19:36:00 INFO - 'XPC_SERVICE_NAME': '0', 19:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:00 INFO - Downloading/unpacking psutil>=3.1.1 19:36:00 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 19:36:00 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 19:36:00 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 19:36:00 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 19:36:00 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 19:36:00 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 19:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:03 INFO - Installing collected packages: psutil 19:36:03 INFO - Running setup.py install for psutil 19:36:03 INFO - building 'psutil._psutil_osx' extension 19:36:03 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 19:36:04 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 19:36:04 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 19:36:04 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 19:36:04 INFO - building 'psutil._psutil_posix' extension 19:36:04 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 19:36:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:36:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:36:04 INFO - ^ 19:36:04 INFO - 1 warning generated. 19:36:04 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 19:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:04 INFO - Successfully installed psutil 19:36:04 INFO - Cleaning up... 19:36:04 INFO - Return code: 0 19:36:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:36:04 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')]} 19:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:04 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')]} 19:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:04 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:04 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 19:36:04 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 19:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:04 INFO - 'HOME': '/Users/cltbld', 19:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:04 INFO - 'LOGNAME': 'cltbld', 19:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:04 INFO - 'MOZ_NO_REMOTE': '1', 19:36:04 INFO - 'NO_EM_RESTART': '1', 19:36:04 INFO - 'PAGER': '/bin/cat', 19:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:04 INFO - 'PWD': '/builds/slave/test', 19:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:04 INFO - 'SHELL': '/bin/bash', 19:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:04 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:04 INFO - 'USER': 'cltbld', 19:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:04 INFO - 'XPC_FLAGS': '0x0', 19:36:04 INFO - 'XPC_SERVICE_NAME': '0', 19:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:36:05 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 19:36:05 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 19:36:05 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 19:36:05 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 19:36:05 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 19:36:05 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 19:36:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:36:07 INFO - Installing collected packages: mozsystemmonitor 19:36:07 INFO - Running setup.py install for mozsystemmonitor 19:36:07 INFO - Successfully installed mozsystemmonitor 19:36:07 INFO - Cleaning up... 19:36:07 INFO - Return code: 0 19:36:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:07 INFO - 'HOME': '/Users/cltbld', 19:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:07 INFO - 'LOGNAME': 'cltbld', 19:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:07 INFO - 'MOZ_NO_REMOTE': '1', 19:36:07 INFO - 'NO_EM_RESTART': '1', 19:36:07 INFO - 'PAGER': '/bin/cat', 19:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:07 INFO - 'PWD': '/builds/slave/test', 19:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:07 INFO - 'SHELL': '/bin/bash', 19:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:07 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:07 INFO - 'USER': 'cltbld', 19:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:07 INFO - 'XPC_FLAGS': '0x0', 19:36:07 INFO - 'XPC_SERVICE_NAME': '0', 19:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:08 INFO - Downloading/unpacking jsonschema==2.5.1 19:36:08 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 19:36:08 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 19:36:08 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 19:36:08 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 19:36:08 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 19:36:08 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 19:36:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:36:10 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 19:36:10 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 19:36:10 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 19:36:10 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 19:36:10 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 19:36:10 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 19:36:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:11 INFO - warning: no files found matching '*.txt' 19:36:11 INFO - no previously-included directories found matching 'build' 19:36:11 INFO - no previously-included directories found matching 'dist' 19:36:11 INFO - no previously-included directories found matching '.git*' 19:36:11 INFO - Installing collected packages: jsonschema, functools32 19:36:11 INFO - Running setup.py install for functools32 19:36:11 INFO - warning: no files found matching '*.txt' 19:36:11 INFO - no previously-included directories found matching 'build' 19:36:11 INFO - no previously-included directories found matching 'dist' 19:36:11 INFO - no previously-included directories found matching '.git*' 19:36:11 INFO - Successfully installed jsonschema functools32 19:36:11 INFO - Cleaning up... 19:36:11 INFO - Return code: 0 19:36:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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', '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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:36: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 functools32==3.2.3-2 19:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:11 INFO - 'HOME': '/Users/cltbld', 19:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:11 INFO - 'LOGNAME': 'cltbld', 19:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:11 INFO - 'MOZ_NO_REMOTE': '1', 19:36:11 INFO - 'NO_EM_RESTART': '1', 19:36:11 INFO - 'PAGER': '/bin/cat', 19:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:11 INFO - 'PWD': '/builds/slave/test', 19:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:11 INFO - 'SHELL': '/bin/bash', 19:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:11 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:11 INFO - 'USER': 'cltbld', 19:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:11 INFO - 'XPC_FLAGS': '0x0', 19:36:11 INFO - 'XPC_SERVICE_NAME': '0', 19:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:36:11 INFO - Cleaning up... 19:36:11 INFO - Return code: 0 19:36:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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', '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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:36: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 blobuploader==1.2.4 19:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:11 INFO - 'HOME': '/Users/cltbld', 19:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:11 INFO - 'LOGNAME': 'cltbld', 19:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:11 INFO - 'MOZ_NO_REMOTE': '1', 19:36:11 INFO - 'NO_EM_RESTART': '1', 19:36:11 INFO - 'PAGER': '/bin/cat', 19:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:11 INFO - 'PWD': '/builds/slave/test', 19:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:11 INFO - 'SHELL': '/bin/bash', 19:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:11 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:11 INFO - 'USER': 'cltbld', 19:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:11 INFO - 'XPC_FLAGS': '0x0', 19:36:11 INFO - 'XPC_SERVICE_NAME': '0', 19:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:11 INFO - Downloading/unpacking blobuploader==1.2.4 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:14 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:15 INFO - Downloading docopt-0.6.1.tar.gz 19:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:15 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:15 INFO - Running setup.py install for blobuploader 19:36:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:15 INFO - Running setup.py install for requests 19:36:16 INFO - Running setup.py install for docopt 19:36:16 INFO - Successfully installed blobuploader requests docopt 19:36:16 INFO - Cleaning up... 19:36:16 INFO - Return code: 0 19:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:16 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')]} 19:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:16 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')]} 19:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:16 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:16 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 19:36:16 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 19:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:16 INFO - 'HOME': '/Users/cltbld', 19:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:16 INFO - 'LOGNAME': 'cltbld', 19:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:16 INFO - 'MOZ_NO_REMOTE': '1', 19:36:16 INFO - 'NO_EM_RESTART': '1', 19:36:16 INFO - 'PAGER': '/bin/cat', 19:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:16 INFO - 'PWD': '/builds/slave/test', 19:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:16 INFO - 'SHELL': '/bin/bash', 19:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:16 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:16 INFO - 'USER': 'cltbld', 19:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:16 INFO - 'XPC_FLAGS': '0x0', 19:36:16 INFO - 'XPC_SERVICE_NAME': '0', 19:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ePRlbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NNUU7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Kbb4sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bLv3BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-fUGDVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PIUXE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-AumbMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-1eBdyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-jImZKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zYa9aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-BC3E0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:17 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-NqvCLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:18 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2I10h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:18 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-bIVuBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:18 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-V944R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:18 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-TpYNjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:18 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-aKhNGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:18 INFO - Running setup.py install for manifestparser 19:36:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:18 INFO - Running setup.py install for mozcrash 19:36:18 INFO - Running setup.py install for mozdebug 19:36:18 INFO - Running setup.py install for mozdevice 19:36:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Running setup.py install for mozfile 19:36:19 INFO - Running setup.py install for mozhttpd 19:36:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Running setup.py install for mozinfo 19:36:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Running setup.py install for mozInstall 19:36:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:19 INFO - Running setup.py install for mozleak 19:36:19 INFO - Running setup.py install for mozlog 19:36:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Running setup.py install for moznetwork 19:36:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Running setup.py install for mozprocess 19:36:20 INFO - Running setup.py install for mozprofile 19:36:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Running setup.py install for mozrunner 19:36:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:20 INFO - Running setup.py install for mozscreenshot 19:36:20 INFO - Running setup.py install for moztest 19:36:20 INFO - Running setup.py install for mozversion 19:36:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:21 INFO - Cleaning up... 19:36:21 INFO - Return code: 0 19:36:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:21 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')]} 19:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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')]} 19:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:21 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 19:36:21 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 19:36:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:21 INFO - 'HOME': '/Users/cltbld', 19:36:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:21 INFO - 'LOGNAME': 'cltbld', 19:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:21 INFO - 'MOZ_NO_REMOTE': '1', 19:36:21 INFO - 'NO_EM_RESTART': '1', 19:36:21 INFO - 'PAGER': '/bin/cat', 19:36:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:21 INFO - 'PWD': '/builds/slave/test', 19:36:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:21 INFO - 'SHELL': '/bin/bash', 19:36:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:21 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:21 INFO - 'USER': 'cltbld', 19:36:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:21 INFO - 'XPC_FLAGS': '0x0', 19:36:21 INFO - 'XPC_SERVICE_NAME': '0', 19:36:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-XSsJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qtwU39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Xsh98g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-EQjfcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vZPBPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-xZOrrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:21 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)) 19:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:21 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RsuqqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-jGPn16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-JaZUZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-sF4Vob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-YCL5J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-AOiw2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8tuhoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DYkIzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-sXQA3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:22 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)) 19:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:22 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zv2ZIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:23 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)) 19:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:23 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-266_p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:23 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)) 19:36:23 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)) 19:36:23 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)) 19:36:23 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)) 19:36:23 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)) 19:36:23 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)) 19:36:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:25 INFO - Downloading blessings-1.6.tar.gz 19:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:25 INFO - Installing collected packages: blessings 19:36:25 INFO - Running setup.py install for blessings 19:36:25 INFO - Successfully installed blessings 19:36:25 INFO - Cleaning up... 19:36:26 INFO - Return code: 0 19:36:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:26 INFO - Reading from file tmpfile_stdout 19:36:26 INFO - Current package versions: 19:36:26 INFO - blessings == 1.6 19:36:26 INFO - blobuploader == 1.2.4 19:36:26 INFO - docopt == 0.6.1 19:36:26 INFO - functools32 == 3.2.3-2 19:36:26 INFO - jsonschema == 2.5.1 19:36:26 INFO - manifestparser == 1.1 19:36:26 INFO - mozInstall == 1.12 19:36:26 INFO - mozcrash == 0.17 19:36:26 INFO - mozdebug == 0.1 19:36:26 INFO - mozdevice == 0.48 19:36:26 INFO - mozfile == 1.2 19:36:26 INFO - mozhttpd == 0.7 19:36:26 INFO - mozinfo == 0.9 19:36:26 INFO - mozleak == 0.1 19:36:26 INFO - mozlog == 3.3 19:36:26 INFO - moznetwork == 0.27 19:36:26 INFO - mozprocess == 0.23 19:36:26 INFO - mozprofile == 0.28 19:36:26 INFO - mozrunner == 6.12 19:36:26 INFO - mozscreenshot == 0.1 19:36:26 INFO - mozsystemmonitor == 0.3 19:36:26 INFO - moztest == 0.7 19:36:26 INFO - mozversion == 1.4 19:36:26 INFO - psutil == 3.1.1 19:36:26 INFO - requests == 1.2.3 19:36:26 INFO - wsgiref == 0.1.2 19:36:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:26 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 19:36:26 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 19:36:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:26 INFO - 'HOME': '/Users/cltbld', 19:36:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:26 INFO - 'LOGNAME': 'cltbld', 19:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:26 INFO - 'MOZ_NO_REMOTE': '1', 19:36:26 INFO - 'NO_EM_RESTART': '1', 19:36:26 INFO - 'PAGER': '/bin/cat', 19:36:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:26 INFO - 'PWD': '/builds/slave/test', 19:36:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:26 INFO - 'SHELL': '/bin/bash', 19:36:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:26 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:26 INFO - 'USER': 'cltbld', 19:36:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:26 INFO - 'XPC_FLAGS': '0x0', 19:36:26 INFO - 'XPC_SERVICE_NAME': '0', 19:36:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 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)) 19:36:26 INFO - Cleaning up... 19:36:26 INFO - Return code: 0 19:36:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 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 0x10b154a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf38de0740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, '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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 19:36:26 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 19:36:26 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 19:36:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:36:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:26 INFO - 'HOME': '/Users/cltbld', 19:36:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:26 INFO - 'LOGNAME': 'cltbld', 19:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:26 INFO - 'MOZ_NO_REMOTE': '1', 19:36:26 INFO - 'NO_EM_RESTART': '1', 19:36:26 INFO - 'PAGER': '/bin/cat', 19:36:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:26 INFO - 'PWD': '/builds/slave/test', 19:36:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:26 INFO - 'SHELL': '/bin/bash', 19:36:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:36:26 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:36:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:26 INFO - 'USER': 'cltbld', 19:36:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:26 INFO - 'XPC_FLAGS': '0x0', 19:36:26 INFO - 'XPC_SERVICE_NAME': '0', 19:36:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:36:27 INFO - Cleaning up... 19:36:27 INFO - Return code: 0 19:36:27 INFO - Running post-action listener: _resource_record_post_action 19:36:27 INFO - Running post-action listener: _start_resource_monitoring 19:36:27 INFO - Starting resource monitoring. 19:36:27 INFO - [mozharness: 2016-08-13 02:36:27.262023Z] Finished create-virtualenv step (success) 19:36:27 INFO - [mozharness: 2016-08-13 02:36:27.263015Z] Running install step. 19:36:27 INFO - Running pre-action listener: _resource_record_pre_action 19:36:27 INFO - Running main action method: install 19:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:27 INFO - Reading from file tmpfile_stdout 19:36:27 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:27 INFO - Reading from file tmpfile_stdout 19:36:27 INFO - Output received: 19:36:27 INFO - Usage: mozinstall [options] installer 19:36:27 INFO - Options: 19:36:27 INFO - -h, --help show this help message and exit 19:36:27 INFO - -d DEST, --destination=DEST 19:36:27 INFO - Directory to install application into. [default: 19:36:27 INFO - "/builds/slave/test"] 19:36:27 INFO - --app=APP Application being installed. [default: firefox] 19:36:27 INFO - mkdir: /builds/slave/test/build/application 19:36:27 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'] 19:36:27 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 19:37:01 INFO - Reading from file tmpfile_stdout 19:37:01 INFO - Output received: 19:37:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:37:01 INFO - Running post-action listener: _resource_record_post_action 19:37:01 INFO - [mozharness: 2016-08-13 02:37:01.512639Z] Finished install step (success) 19:37:01 INFO - [mozharness: 2016-08-13 02:37:01.512781Z] Running run-tests step. 19:37:01 INFO - Running pre-action listener: _resource_record_pre_action 19:37:01 INFO - Running main action method: run_tests 19:37:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:01 INFO - 2016-08-12 19:37:01.527 screenresolution[1649:7396] starting screenresolution argv=screenresolution get 19:37:01 INFO - 2016-08-12 19:37:01.529 screenresolution[1649:7396] Display 0: 1600x1200x32@60 19:37:01 INFO - 2016-08-12 19:37:01.535 screenresolution[1650:7398] starting screenresolution argv=screenresolution list 19:37:01 INFO - Available Modes on Display 0 19:37:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:01 INFO - Intel Iris: 19:37:01 INFO - Chipset Model: Intel Iris 19:37:01 INFO - Type: GPU 19:37:01 INFO - Bus: Built-In 19:37:01 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:01 INFO - Vendor: Intel (0x8086) 19:37:01 INFO - Device ID: 0x0a2e 19:37:01 INFO - Revision ID: 0x0009 19:37:01 INFO - Displays: 19:37:01 INFO - Display: 19:37:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:01 INFO - Display Serial Number: 1600x1200 60 19:37:01 INFO - Main Display: Yes 19:37:01 INFO - Mirror: Off 19:37:01 INFO - Online: Yes 19:37:01 INFO - Rotation: Supported 19:37:01 INFO - Return code: 0 19:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:01 INFO - Python 2.7.3 19:37:01 INFO - Return code: 0 19:37:01 INFO - grabbing minidump binary from tooltool 19:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:37:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b8d30>, '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 0x10ae1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:37:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:37:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:37:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:01 INFO - Return code: 0 19:37:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 19:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 19:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GwfsYJzu6x/Render', 19:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:01 INFO - 'HOME': '/Users/cltbld', 19:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:01 INFO - 'LOGNAME': 'cltbld', 19:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:01 INFO - 'MOZ_NO_REMOTE': '1', 19:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:01 INFO - 'NO_EM_RESTART': '1', 19:37:01 INFO - 'PAGER': '/bin/cat', 19:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:01 INFO - 'PWD': '/builds/slave/test', 19:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:01 INFO - 'SHELL': '/bin/bash', 19:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rbmHnNoeGX/Listeners', 19:37:01 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 19:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:01 INFO - 'USER': 'cltbld', 19:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:01 INFO - 'XPC_FLAGS': '0x0', 19:37:01 INFO - 'XPC_SERVICE_NAME': '0', 19:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 19:37:02 INFO - mozversion application_buildid: 20160812162516 19:37:02 INFO - mozversion application_changeset: 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 19:37:02 INFO - mozversion application_display_name: Nightly 19:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:02 INFO - mozversion application_name: Firefox 19:37:02 INFO - mozversion application_remotingname: firefox 19:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:37:02 INFO - mozversion application_vendor: Mozilla 19:37:02 INFO - mozversion application_version: 51.0a1 19:37:02 INFO - mozversion platform_buildid: 20160812162516 19:37:02 INFO - mozversion platform_changeset: 8fd2f35a58fa11f9fb6e356ce37528c6e7e0f728 19:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:37:02 INFO - mozversion platform_version: 51.0a1 19:37:02 INFO - using testdate: 1471055822 19:37:02 INFO - actual date: 1471055822 19:37:02 INFO - starting webserver on 'localhost:49270' 19:37:02 INFO - SUITE-START | Running 2 tests 19:37:02 INFO - TEST-START | dromaeo_css 19:37:02 INFO - operating with platform_type : mac_ 19:37:02 INFO - Initialising browser for dromaeo_css test... 19:37:02 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpQ84zeV/profile http://localhost:49270/getInfo.html) 19:37:05 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 19:37:05 INFO - PROCESS | 1660 | colorDepth:24 19:37:05 INFO - PROCESS | 1660 | Browser inner width/height: 1024/663 19:37:05 INFO - PROCESS | 1660 | __metrics 19:37:05 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:37:05 INFO - TEST-INFO | 1660: exit 0 19:37:05 INFO - Browser initialized. 19:37:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:05 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpQ84zeV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:17 INFO - PROCESS | 1663 | RSS: Main: 268304384 19:37:17 INFO - PROCESS | 1663 | 19:38:07 INFO - PROCESS | 1663 | 1471055887398 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] 19:40:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 19:40:20 INFO - PROCESS | 1663 | RSS: Main: 280772608 19:40:20 INFO - PROCESS | 1663 | 19:43:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 19:43:23 INFO - PROCESS | 1663 | RSS: Main: 288927744 19:43:23 INFO - PROCESS | 1663 | 19:46:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 19:46:25 INFO - PROCESS | 1663 | RSS: Main: 293806080 19:46:25 INFO - PROCESS | 1663 | 19:49:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 19:49:28 INFO - PROCESS | 1663 | RSS: Main: 292282368 19:49:28 INFO - PROCESS | 1663 | 19:52:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 19:52:31 INFO - PROCESS | 1663 | RSS: Main: 296394752 19:52:31 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 19:55:34 INFO - PROCESS | 1663 | RSS: Main: 298426368 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | __start_tp_report 19:55:34 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:55:34 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:55:34 INFO - PROCESS | 1663 | |i|pagename|runs| 19:55:34 INFO - PROCESS | 1663 | |0;dojo.html;2711.9322016949577;3218.5011323244903;3244.3673483670664;3288.7862288951233;3346.615139258985;5085.23721441783;5348.117560602501;5604.355499117602;5686.317641882974;5727.513161381283;5682.096497673285;5739.397363276858;5772.220750198722;5780.682062486561;5832.737526811293;5181;5293.311869456965;5303;5373.838784836461;5375.838724838261;5311.601629877755;5330.973345133269;5394.487523685244;5400.972995135038;5425.9186112208345;5088.54203121719;5135.768890399941;5205.089109405839;5260.500252476008;5283.973580132075;5207.218917162456;5216.5305122538775;5220.425753167148;5238.92141617876;5257.395399529065;5156.149235376196;5204.011237864794;5247.921281180786;5260.026895024433;5277.656952298088;5476.2333273341765;5639.379668236491;5696.2594862668;5738.684372359518;5831.979403604395;5321.909008653217;6086;6256.311805701369;6263.87472250557;6264.154339164245;6138.081874382042;6313.116163737081;6316.96841515794;6322.209723784527;6329.968350158266;5770.047942089592;5803.129530570448;5804.868050730067;5829.213056237396;5947.1079338099635;5230.97384513075;5343.545798607084;6285.779997700059;6297.527685423612;6310.148130002391;5252.789888404497;5813.854653633608;6114.266288045463;6201.976673848764;6233.532485063638;5189.221616757441;6110.3765049759795;6117.888303246575;6140.749659041545;6183.598066125687;6121.117656725397;6142.222533142085;6231.376862313823;6233.407826256498;6245.063240513869;5591.916121258185;5890.2342695449315;6184.907226391608;6210.161628180228;6263.530235232376;4873.780679869415;4898.4121905371585;4912.04215178044;4940.827071052496;4947.529984651453;3915.882523524299;4053.858114965962;4389.144116897238;4452.799624016927;4467.888302792456;5495.505404513533;5768.769249229984;5795.884082318415;5835.35811060783;5856.180134781134;6106.794380079898;6185.381461853779;6195.2255968004;6210.31686514483;6220.191375121205;5788.623739456922;5865.20819689345;5878.882422351529;5890.204822348928;5925.614835035709;4866.46468888422;5508.55931525477;5510.9448905510435;5520.337559492807;5527.39198688144;6180.969095154495;6216.502679785697;6262.09199666055;6282.120503129657;6349.365063493614;6276.089966954857;6288.119663247057;6293.874122517615;6302.842428939313;6310.6213627182515;6323.177986861862;6332.968335158294;6340.239171299474;6341.27075386318;6355.872882542416;6082.939170608414;6115.296740874856;6118.314626315779;6145.033589251397;6202.472789812917;5141.791678955517;6274.341194174546;6275.215598050244;6283.560150789401;6311;5739.282589676291;6158.0147176451555;6169.259688837368;6170.660613666291;6174.66039367839;6047.576669633084;6099.461111717743;6112.0171844544475;6122.938770612237;6147;5014.774335155;5770.076787713946;6043.909341359795;6076.51387888959;6094.14681944537;6132.448079672851;6140.201773769381;6168.753249870135;6199.194104766351;6219.689015549114;5865.824025279248;5948.434898684618;5949.881002379841;5962.433568810956;6059.454649081604 19:55:34 INFO - PROCESS | 1663 | |1;ext.html;473.1672256827982;501.3006855436666;518.1864472777738;529.1718460609146;574.4772257245907;38548.229035419274;41150.79424602877;41151.76544703656;41162.58837411625;41194.176116477654;36679.449808252895;41053.74204418756;42545.14909701804;42858.35712464315;42907.78546107273;9636.229101671885;9830.311878168532;9852.458114803683;9861.654842080528;9865.506724663774;9726.027397260254;9796.804063918717;9817.95091024544;9838.311318207729;9857.605695772161;8292.37807164462;9704.563294651722;9796.314258001943;9832.852507212398;9847.60609575616;8328.916710832875;8359.874601880916;9810.166135878459;9835.852462213108;9864.60541578336;8653.740387788377;9681.41911485306;9690.903090969141;9740.269479789044;9744.976777438409;38176.80911595452;38392.65625703115;40129.19741605181;40261.19477610431;40536;2591.313301974978;2663.893444262227;3216.64616892144;3305.949912266706;3401.914952126192;31027.84486077578;31293.530597041063;31428;32111.715531378715;32466.863659772032;2694.8652567371555;3089.644690860557;3111.797733147338;3143.5913331267016;3149.6377916539664;424283;428094;430659;431230;433483;34416.31167376639;34484.96545103651;34550.96347109591;34583.0229523608;34794.47808282878;32730;35733.82133089318;35757.46363804545;35872.82063589717;35909.10227244288;16102.516924492284;16212;16253.593660158354;16257.837421625869;16294.592635183979;12139.757204855854;12276.140670153003;12288.877111228774;12292.815607765891;12302.138850280573;19901.203951841766;20097.59804803896;20123.893185874625;20136.798632013786;20137.09383077765;7813.296803287732;8010;8017.559034253172;8021.679132834738;8064.959675201587;860.6428332242175;999.1806718490913;1044.289882879634;1073.581303291717;1103.757173421846;31131.533027004614;31177.688223117933;31271.374572508423;31389.843050785057;31662.841685791424;948.5589201021559;999.2256001598673;1034.403646846421;1071.223363061774;1106.2256420505678;11847.76304473923;13727.931360343135;15404.845951540565;15476.845231547766;15914;680564;689592;697961;703965;707489.4625526839;48112;60009;60520.48698782566;60646.393536064956;60666;1323.7021670124145;1333.5732565578921;1380.8964327675465;1386.8197134372467;1393.6376542098924;27788.166355009384;30100.84949575238;30124.849375753856;30420.695793041785;30787.846060769552;51396;51631.48368516267;51799;51888.48111518836;52068.21897671462;588590;592919;593527;594810;598704;26654.466910662068;27499.45001100007;27698.723012769613;27700.861495692392;27799;47716.284255736886;48296.275555867396;48824;49321.76695582639;49653.00693986028;40429.39355909605;40534;40680.98297542467;40919;41932;39361.80319098386;40927.1814563713;40952.590474094875;41048.1790364197;42169.578304216564;38161.23677526489;38605.613943861325;39187.41218881662;39226.80386598049;39466;28849.56725649075;34652.30695386128;35861;36467.45298820573;36574.817125914204;26394.868025659747;26423.94304227886;26676.733232667426;26841.597376039765;26879.059232926753 19:55:34 INFO - PROCESS | 1663 | |2;jquery.html;377.8814708462948;380.4046666966198;385.84631950468093;393.2901113490149;408.37110849292094;19191.61616767664;20970.26604068858;21719.022643981018;21816.236431724894;22004.809302651127;20220.494487637818;20733.688994665055;20796.48008799777;20863.687044694343;21042.36872893812;5371.946280537184;5959.374265702104;6102.725377358008;6171.660558669271;6176.444120029197;5967.403259674042;6024.3674414186535;6147.938520614782;6202.906956395657;6206.534509911752;5914.142449344842;6077.11881777142;6086.847828804293;6125.846853828668;6135.631862088267;5989.850253743648;6023.909641355383;6031.939680603182;6080.209572755558;6081.817545473643;5213.348331458567;5246.396664383607;5254.4220135785035;5261.921071183897;5269.209618557209;19253.51866203342;20195.293164739163;20318.882461464615;23758.168464103674;25661.230163095137;2143.0570548958563;2176.336217453692;2383.9629761053825;2570.7943364530793;2583.4962182374443;11456.599019034295;14928.104313741102;15497.767533487007;15709;15776.76334854978;1574.9841352327685;1722.2163915418455;1837.9632407351912;1894.6873765828623;1917.8178073083034;78661.06694665301;108576;114304.42847785707;133303;134324.32837835845;9519.809603808024;10675.359478431319;11357.943210283896;11656.30062196271;11945.104117191246;14625.853741462663;14731.337089830984;14739.778903316459;14750.926245368704;14771.261436928326;6878.621675807779;7094.326039026284;8391.118932512121;8450.450720703135;8567.785805354915;8038.799030024296;8101.189881011969;8216.383771217183;8313.916860831314;8352.8329433411;4541.545845415432;4653.488116307203;4683.2038553446;4709.893175103848;4732.6687131900435;1851.6204178143448;1881.4543782302978;1900.8859468431663;1905.9714104288446;1911.4838993471685;819.6844214977158;874.9912500874909;981.5681100315838;994.6469003503652;1047.2512153810062;20469.488262793253;21327.907453419168;21349.89325053365;21380.824054676832;21548.784512154678;937.540605103508;952.1288021460286;958.7075941837807;960.5389413081759;975.7999610079917;11231.438428078727;11309;11349.716257093474;11457.770844583061;11525.48135333912;494526;521715;560652;586198;591029;114343;128026;133898;134720.65279347278;144241;979.5102448775613;1002.6039714312951;1007.4106647611083;1028.2391030637275;1030.6289735695143;17412.73880891813;18150.909245453688;18665.253389864254;19222.03889805532;20101.89439580837;32548.83725581357;39078;41506.37740433835;43199;55073.39119305709;81692;85060.72408913996;85239.57380213059;86382.56808715916;86964.1303586956;7815.53106813593;8188.140245274399;8392.16078392156;8400.243978042006;8551.957240213758;12663.746725065263;12699.936500317439;13318;13503.864961350653;14117.505887293895;11125.388103654377;11422.885771142182;11888.643340699793;11980.46087926028;12272.325022123869;11480;11545.826812597987;11571.6528504145;11833.940830296138;11926.284422934652;11266.774664506827;11641.126915481203;11646.767064658829;11996.64010079699;12114.273143611059;6404.815109204812;8099.554524501209;8509.617067231866;8607.612657430556;8748.037715851378;8443.95778021106;10728.249022568345;11771.646850594496;11820.586279480176;11846.822297665369 19:55:34 INFO - PROCESS | 1663 | |3;mootools.html;1466.3694611317137;1525.740624093904;1712.7582502685555;1817.7636907202061;1880.840128589069;7964.561949092812;8410.28512576431;8540.975082990035;8963.193312601865;9000.954995225024;7424.517406368595;8757.43076700014;8760.16778406052;8776.91223087769;8842.95578522108;1815.8002619711854;2181.727284089489;2354.6585745066955;2356.210669425736;2364.810815134785;1949.337225343383;2045.8772473651554;2345.6833327500826;2359.976400235993;2364.609839376501;2346.460314127743;2353.6587194856734;2354.6350315701093;2362.621980483123;2367.337145599235;2325.976740232593;2330.8135349172026;2337.824663150262;2341.3678306857137;2351.2123438648073;2305.1931823861682;2317.8493397929083;2339.0994467130276;2340.1458467659354;2341.028473183627;8866.290696744309;8878.955605221932;8896.19934205918;8912.24245939096;8918.10818918103;5144.6913185209005;5258.55302299305;5290.312259406291;5299.516135482071;5310.654807437504;3460.532828068229;3489.098411855258;3606.549181352331;3611.458281257806;3638.4542318652148;1040.7658276887717;1077.5582011375297;1082.0640146273417;1100.5047728522118;1101.801675698374;11496.827547586792;11504;11631.127665425127;11649.718530961673;11719.882801172049;4554.567316104964;4694.272387779832;4789.185838407479;4811.807527698923;4813.638977076734;9131.497767622712;9851.852222216672;9897.554610042565;9948.651797187063;9982.401055936667;5324.866878328073;5329.280547126088;5349.946500535023;5361.624686272002;5368.677879327175;4267.4025636410925;4688.601468875116;4900.926486102711;4910.852674419773;4918.827841025547;3895.902602434962;3951.4665520154986;3988.3818008208773;4039.4748682671066;4091.1408604193452;1274.216356940475;1285.3830161522335;1286.424130440222;1292.1600959376292;1295.740851829619;735.1435577552091;852.6759831264204;900.1538553759445;912.539167720297;942.2697409507549;5276.314079169683;5756.30924289088;5999.340072592011;6036.758529658764;6089.69551522431;938.0900526489295;945.7824700318965;949.349695458613;959.3668179001826;995.0845222395413;3506.281212351462;3644.5079914211774;3867.7099217558793;3888.2806680764147;3958.287508248485;9197.63209471627;10654.680359589225;10900.34597924127;10912.454377281105;10923.3992130432;10735.51690173944;10791.730206744895;10871.130309575216;10874.565017399216;10883.510242039127;8060.9117769101595;8195.590220488952;8343.08226095129;8356;8399.572072747647;5327.200919862052;6016.067509536029;6044.304904935989;6057.182280392267;6105.175801266772;9496;9775.266854986046;10129.594816207564;10138.290319677551;10160.949195253976;7801.492902961516;8687.044425113107;10147.289689721649;10171.84742228882;10198.541065651914;6792.898106528307;7356.963215184104;7469.850602988018;7519.586422746583;7633.427492937941;8460.873086903825;8506.234438900528;8529.232369086812;8560.400771945904;8561.529115898686;5780.913286300624;7482.401407887465;7585.506942048749;7671.808204794925;7711.537307761552;6061.454469097803;7359.337659610661;7362.9307978338875;7380.77857664271;7441.665125069493;6939.722411103701;6987.371136597731;7060.117485314336;7061.2585678505075;7067.399271062018;4962.131626965339;4985.551300382983;5002.224655178453;5013.222950442687;5072.82245121419;4234.364845273234;4325.653947684241;4911.214205727067;5109.897802044013;5171.586273098068 19:55:34 INFO - PROCESS | 1663 | |4;prototype.html;304.45654506705534;306.7377392329558;316.3877896270716;317.61251273446385;320.05423972162265;5102.3366962294895;5455.618106732531;5465.852171044081;5549.278593782813;5711.314642242932;4635.860924172281;5555.611107222496;5561.833145005657;5648.548116150709;5665.696889715357;3611.368010598135;4259.893502662428;4327.221100201962;4343.631755996851;4362.629176519999;4094.485040534991;4189.706720529564;4275.033484597074;4293.162833247518;4363.905325443789;3670.1925576373287;3882.5340959084806;4264.104538047014;4313.352997050436;4323.632491238232;3930.7051971102283;4267.935980960288;4275.508316543575;4292.635126014293;4319.805608747598;3560.839762210707;3693.353663108945;3697.482352470656;3718.2377612589353;3741.607131251234;4423.402840616508;4943.975280123613;5491.176323551459;5541.141123125922;5580.525655319303;4731.124741922756;4909.582685471739;4946.851594452136;4948.678335908155;4970.801167953277;5217.452167522393;5511.311086114236;5770.932377510132;5958.40415958405;6013.278406591194;3368.4778859276853;3599.31612993533;3880.3597406427907;3957.762534247954;4071.3485842265095;6410.487161027107;6415.294317625057;6421.197350331162;6464.5798023128345;6510.609363438209;3509.2279698466295;3537.380958332333;3886.9805650971566;4102.261592913304;4200.096979149497;3632.055665526982;3927.6857851371824;4186.853460128881;4220.641245494167;4271.3592961055465;4924.60603151747;4924.975375123101;4949;4969.304297398367;4998.400191976913;5758;5766.481016708516;6059.242594675666;6119.5521791283845;6122.969385153135;1188.7206506470973;1375.587323802855;1390.9220354225354;1427.186503692906;1438.9136651800925;802.9197080291924;841.6885752271698;870.5777697816554;878.9452656811851;879.9340049496313;4518.593326600621;4542.227821270392;4688.507062238654;4756.453007904135;4759.358021482583;5088.303199304374;5106.004329155779;5113.64204505681;5231.032259032091;5253.900198882678;3922.4116382542275;4162.771982265239;4278.336857787048;4500.887477813016;4734.4081989751285;2512.69847618287;2531.822772405914;2607.2438992692287;2722.509948209302;2764.8940423830627;4943.083580687412;4963.6277279204205;4971.3957380898555;5434.510894019557;5466.972665136649;4934.642973182404;5215.7913683453;5254.9752798204745;5275.604329675213;5401.702906340189;4700.506446823103;5015.498450154955;5261.684578855286;5367;5444.40111587725;4680.953190468052;4913.336699545658;4939.382127472445;5083.542481176712;5113.360829896263;4042.586608158458;4513.932291015703;4516.848203708033;4902.264660300983;5097.745112744274;4605.40129783126;4917.778699958439;5098.413682426569;5234.659747116425;5308.893822123458;3458.4985177149674;3495.8574089703784;4047.4535937648043;4152.730072545275;4159.772867004181;6072.360462674965;6077.8974192419055;6138.815835524942;6169.167162433194;6170.969145154246;5203.531682148625;5581.246531718166;5964.701764911651;5965.313988891333;5971.1486091471625;5871.944819313207;5893.911591326219;5954;5974.581779275409;5984.162217289496;5041.42023667283;5496.972515137559;5505.247376311844;5810.506106980785;5864.472197502245;4935.432425271139;5582.036753904773;5642.774289028393;5839.153322768259;5930.555208359304;5765.827025189251;5818.214541036906;5844.15259787337;5861.501772349398;5880.647161170344 19:55:34 INFO - PROCESS | 1663 | |5;yui.html;668.3550373889199;696.3454352908266;697.4176562570253;774.7520793346124;780.0950896959528;12431.68920776981;15688.686226275482;15943.760843587355;15944.601384965381;15960.201989900517;14290.14259144452;14410;14432.20622865742;14434;14511.927440362784;681.8602186551769;833.7290380626321;833.9617176615108;862.4480332587149;864.2999170671744;854.9572521373938;860.9655613775473;870.5081628879663;873.5239294584435;876.3383645347785;919.843626583479;921.1985572551856;923.9029901860308;924.085155695863;927.5686805635378;898.7393655839865;907.9636814527411;910.968116115936;917.9311551633655;919.3013309884469;653.0922018394435;661.4476911778622;678.7726111752569;691.640347019552;697.5953946710896;12854.228746275254;14514.056586321962;14677.853221467756;14848.554543363716;14926.253687315699;12400.937995309965;14387.928060359736;14755.26223688822;14798.630034249123;15032.17323047232;11514.790946950618;11669.94165029178;12005.93997030018;12221.511139554406;12301.077419193596;3671.320805650963;3872.8257228424786;3876.592957739453;3889.2027134437653;4057.3102572562734;114660;115702;117161;117301;120347;11340.489677964511;11502.424878756028;11582.015528679987;11603.129765267639;11771.470283837249;23643.172488963148;23679.816009199472;23801.40496487567;23959.16142935024;24054.87972560126;7524.398048156135;7536.397088232929;7585.469017168855;7661.770146895602;7780.8832867507035;4370.694051416371;4534.161180181677;4574.245249533789;4578.221702310615;4612.561806628365;3603.873864414733;3674.65090816372;3683.2817600567632;3709.7588656737225;3717.7211709121925;677.4174210179242;711.7935798618446;713.5468977199412;713.5611598866764;716.1308983552923;586.5278450847109;686.8488932434856;697.7488104282454;700.5901547594714;707.398711095575;9216.769580760534;9862.408255504693;9868;9887.653932112342;9986.951370106179;580.6632153351046;667.1292624900854;678.5080816408164;679.6601699150425;681.5910453727823;4524.615407690383;4838.588719958843;4840.419149702058;4848.587870031016;4852.902941941142;94378.52810735903;129124.35437822939;147838;149114;163568.18215908844;142823;143124;143952;144876;147840;105711;119630;121609.78390216161;122839.77160228461;124640;8750.218057667009;9541.071847646339;10158.238132140266;10174.13519850821;10253.33353332031;59685.70157149187;61537.076943844986;63268;63953.36046639474;64788.67605661941;73870.63064684642;87660.68508972244;95006;96333.81162600977;100284;13235.073544851768;13291.534796282083;13357.53248636293;13360.064795464225;13439.596812095653;14990.475333363716;15092.54722358331;15133.243337833284;15500;15593.454229101926;13594.252316122313;13692.041557090908;13703.794443083163;13884.791728124288;14375.353109109907;12846.807297890353;13003.544875929298;13818.930905345811;13942.930285348508;14076.225807580682;13373.598792036255;13692.315384230948;13751.037427379988;14135.15189088658;14303.07030043044;11266.436678165896;11427.371494567878;11562.248453850472;11891.583794567148;12114.970227530759;10656.200784941006;11412.543498259976;11434.599789007345;11692.590759323382;11696.415179240834 19:55:34 INFO - PROCESS | 1663 | __end_tp_report 19:55:34 INFO - PROCESS | 1663 | __start_cc_report 19:55:34 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,415 19:55:34 INFO - PROCESS | 1663 | __end_cc_report 19:55:34 INFO - PROCESS | 1663 | __startTimestamp1471056934887__endTimestamp 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:55:34 INFO - PROCESS | 1663 | Number of tests: 6 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5700.64 Median:5865.82 stddev:674.57 (11.5%) stddev-sans-first:634.58 19:55:34 INFO - PROCESS | 1663 | Values: 2711.9 3218.5 3244.4 3288.8 3346.6 5085.2 5348.1 5604.4 5686.3 5727.5 5682.1 5739.4 5772.2 5780.7 5832.7 5181.0 5293.3 5303.0 5373.8 5375.8 5311.6 5331.0 5394.5 5401.0 5425.9 5088.5 5135.8 5205.1 5260.5 5284.0 5207.2 5216.5 5220.4 5238.9 5257.4 5156.1 5204.0 5247.9 5260.0 5277.7 5476.2 5639.4 5696.3 5738.7 5832.0 5321.9 6086.0 6256.3 6263.9 6264.2 6138.1 6313.1 6317.0 6322.2 6330.0 5770.0 5803.1 5804.9 5829.2 5947.1 5231.0 5343.5 6285.8 6297.5 6310.1 5252.8 5813.9 6114.3 6202.0 6233.5 5189.2 6110.4 6117.9 6140.7 6183.6 6121.1 6142.2 6231.4 6233.4 6245.1 5591.9 5890.2 6184.9 6210.2 6263.5 4873.8 4898.4 4912.0 4940.8 4947.5 3915.9 4053.9 4389.1 4452.8 4467.9 5495.5 5768.8 5795.9 5835.4 5856.2 6106.8 6185.4 6195.2 6210.3 6220.2 5788.6 5865.2 5878.9 5890.2 5925.6 4866.5 5508.6 5510.9 5520.3 5527.4 6181.0 6216.5 6262.1 6282.1 6349.4 6276.1 6288.1 6293.9 6302.8 6310.6 6323.2 6333.0 6340.2 6341.3 6355.9 6082.9 6115.3 6118.3 6145.0 6202.5 5141.8 6274.3 6275.2 6283.6 6311.0 5739.3 6158.0 6169.3 6170.7 6174.7 6047.6 6099.5 6112.0 6122.9 6147.0 5014.8 5770.1 6043.9 6076.5 6094.1 6132.4 6140.2 6168.8 6199.2 6219.7 5865.8 5948.4 5949.9 5962.4 6059.5 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:69439.82 Median:39797.60 stddev:156391.00 (393.0%) stddev-sans-first:156743.99 19:55:34 INFO - PROCESS | 1663 | Values: 473.2 501.3 518.2 529.2 574.5 38548.2 41150.8 41151.8 41162.6 41194.2 36679.4 41053.7 42545.1 42858.4 42907.8 9636.2 9830.3 9852.5 9861.7 9865.5 9726.0 9796.8 9818.0 9838.3 9857.6 8292.4 9704.6 9796.3 9832.9 9847.6 8328.9 8359.9 9810.2 9835.9 9864.6 8653.7 9681.4 9690.9 9740.3 9745.0 38176.8 38392.7 40129.2 40261.2 40536.0 2591.3 2663.9 3216.6 3305.9 3401.9 31027.8 31293.5 31428.0 32111.7 32466.9 2694.9 3089.6 3111.8 3143.6 3149.6 424283.0 428094.0 430659.0 431230.0 433483.0 34416.3 34485.0 34551.0 34583.0 34794.5 32730.0 35733.8 35757.5 35872.8 35909.1 16102.5 16212.0 16253.6 16257.8 16294.6 12139.8 12276.1 12288.9 12292.8 12302.1 19901.2 20097.6 20123.9 20136.8 20137.1 7813.3 8010.0 8017.6 8021.7 8065.0 860.6 999.2 1044.3 1073.6 1103.8 31131.5 31177.7 31271.4 31389.8 31662.8 948.6 999.2 1034.4 1071.2 1106.2 11847.8 13727.9 15404.8 15476.8 15914.0 680564.0 689592.0 697961.0 703965.0 707489.5 48112.0 60009.0 60520.5 60646.4 60666.0 1323.7 1333.6 1380.9 1386.8 1393.6 27788.2 30100.8 30124.8 30420.7 30787.8 51396.0 51631.5 51799.0 51888.5 52068.2 588590.0 592919.0 593527.0 594810.0 598704.0 26654.5 27499.5 27698.7 27700.9 27799.0 47716.3 48296.3 48824.0 49321.8 49653.0 40429.4 40534.0 40681.0 40919.0 41932.0 39361.8 40927.2 40952.6 41048.2 42169.6 38161.2 38605.6 39187.4 39226.8 39466.0 28849.6 34652.3 35861.0 36467.5 36574.8 26394.9 26423.9 26676.7 26841.6 26879.1 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33713.34 Median:21910.52 stddev:92700.21 (423.1%) stddev-sans-first:92926.47 19:55:34 INFO - PROCESS | 1663 | Values: 377.9 380.4 385.8 393.3 408.4 19191.6 20970.3 21719.0 21816.2 22004.8 20220.5 20733.7 20796.5 20863.7 21042.4 5371.9 5959.4 6102.7 6171.7 6176.4 5967.4 6024.4 6147.9 6202.9 6206.5 5914.1 6077.1 6086.8 6125.8 6135.6 5989.9 6023.9 6031.9 6080.2 6081.8 5213.3 5246.4 5254.4 5261.9 5269.2 19253.5 20195.3 20318.9 23758.2 25661.2 2143.1 2176.3 2384.0 2570.8 2583.5 11456.6 14928.1 15497.8 15709.0 15776.8 1575.0 1722.2 1838.0 1894.7 1917.8 78661.1 108576.0 114304.4 133303.0 134324.3 9519.8 10675.4 11357.9 11656.3 11945.1 14625.9 14731.3 14739.8 14750.9 14771.3 6878.6 7094.3 8391.1 8450.5 8567.8 8038.8 8101.2 8216.4 8313.9 8352.8 4541.5 4653.5 4683.2 4709.9 4732.7 1851.6 1881.5 1900.9 1906.0 1911.5 819.7 875.0 981.6 994.6 1047.3 20469.5 21327.9 21349.9 21380.8 21548.8 937.5 952.1 958.7 960.5 975.8 11231.4 11309.0 11349.7 11457.8 11525.5 494526.0 521715.0 560652.0 586198.0 591029.0 114343.0 128026.0 133898.0 134720.7 144241.0 979.5 1002.6 1007.4 1028.2 1030.6 17412.7 18150.9 18665.3 19222.0 20101.9 32548.8 39078.0 41506.4 43199.0 55073.4 81692.0 85060.7 85239.6 86382.6 86964.1 7815.5 8188.1 8392.2 8400.2 8552.0 12663.7 12699.9 13318.0 13503.9 14117.5 11125.4 11422.9 11888.6 11980.5 12272.3 11480.0 11545.8 11571.7 11833.9 11926.3 11266.8 11641.1 11646.8 11996.6 12114.3 6404.8 8099.6 8509.6 8607.6 8748.0 8444.0 10728.2 11771.6 11820.6 11846.8 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5661.26 Median:5007.72 stddev:3178.41 (63.5%) stddev-sans-first:3171.69 19:55:34 INFO - PROCESS | 1663 | Values: 1466.4 1525.7 1712.8 1817.8 1880.8 7964.6 8410.3 8541.0 8963.2 9001.0 7424.5 8757.4 8760.2 8776.9 8843.0 1815.8 2181.7 2354.7 2356.2 2364.8 1949.3 2045.9 2345.7 2360.0 2364.6 2346.5 2353.7 2354.6 2362.6 2367.3 2326.0 2330.8 2337.8 2341.4 2351.2 2305.2 2317.8 2339.1 2340.1 2341.0 8866.3 8879.0 8896.2 8912.2 8918.1 5144.7 5258.6 5290.3 5299.5 5310.7 3460.5 3489.1 3606.5 3611.5 3638.5 1040.8 1077.6 1082.1 1100.5 1101.8 11496.8 11504.0 11631.1 11649.7 11719.9 4554.6 4694.3 4789.2 4811.8 4813.6 9131.5 9851.9 9897.6 9948.7 9982.4 5324.9 5329.3 5349.9 5361.6 5368.7 4267.4 4688.6 4900.9 4910.9 4918.8 3895.9 3951.5 3988.4 4039.5 4091.1 1274.2 1285.4 1286.4 1292.2 1295.7 735.1 852.7 900.2 912.5 942.3 5276.3 5756.3 5999.3 6036.8 6089.7 938.1 945.8 949.3 959.4 995.1 3506.3 3644.5 3867.7 3888.3 3958.3 9197.6 10654.7 10900.3 10912.5 10923.4 10735.5 10791.7 10871.1 10874.6 10883.5 8060.9 8195.6 8343.1 8356.0 8399.6 5327.2 6016.1 6044.3 6057.2 6105.2 9496.0 9775.3 10129.6 10138.3 10160.9 7801.5 8687.0 10147.3 10171.8 10198.5 6792.9 7357.0 7469.9 7519.6 7633.4 8460.9 8506.2 8529.2 8560.4 8561.5 5780.9 7482.4 7585.5 7671.8 7711.5 6061.5 7359.3 7362.9 7380.8 7441.7 6939.7 6987.4 7060.1 7061.3 7067.4 4962.1 4985.6 5002.2 5013.2 5072.8 4234.4 4325.7 4911.2 5109.9 5171.6 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4559.75 Median:4947.76 stddev:1409.07 (28.5%) stddev-sans-first:1376.35 19:55:34 INFO - PROCESS | 1663 | Values: 304.5 306.7 316.4 317.6 320.1 5102.3 5455.6 5465.9 5549.3 5711.3 4635.9 5555.6 5561.8 5648.5 5665.7 3611.4 4259.9 4327.2 4343.6 4362.6 4094.5 4189.7 4275.0 4293.2 4363.9 3670.2 3882.5 4264.1 4313.4 4323.6 3930.7 4267.9 4275.5 4292.6 4319.8 3560.8 3693.4 3697.5 3718.2 3741.6 4423.4 4944.0 5491.2 5541.1 5580.5 4731.1 4909.6 4946.9 4948.7 4970.8 5217.5 5511.3 5770.9 5958.4 6013.3 3368.5 3599.3 3880.4 3957.8 4071.3 6410.5 6415.3 6421.2 6464.6 6510.6 3509.2 3537.4 3887.0 4102.3 4200.1 3632.1 3927.7 4186.9 4220.6 4271.4 4924.6 4925.0 4949.0 4969.3 4998.4 5758.0 5766.5 6059.2 6119.6 6123.0 1188.7 1375.6 1390.9 1427.2 1438.9 802.9 841.7 870.6 878.9 879.9 4518.6 4542.2 4688.5 4756.5 4759.4 5088.3 5106.0 5113.6 5231.0 5253.9 3922.4 4162.8 4278.3 4500.9 4734.4 2512.7 2531.8 2607.2 2722.5 2764.9 4943.1 4963.6 4971.4 5434.5 5467.0 4934.6 5215.8 5255.0 5275.6 5401.7 4700.5 5015.5 5261.7 5367.0 5444.4 4681.0 4913.3 4939.4 5083.5 5113.4 4042.6 4513.9 4516.8 4902.3 5097.7 4605.4 4917.8 5098.4 5234.7 5308.9 3458.5 3495.9 4047.5 4152.7 4159.8 6072.4 6077.9 6138.8 6169.2 6171.0 5203.5 5581.2 5964.7 5965.3 5971.1 5871.9 5893.9 5954.0 5974.6 5984.2 5041.4 5497.0 5505.2 5810.5 5864.5 4935.4 5582.0 5642.8 5839.2 5930.6 5765.8 5818.2 5844.2 5861.5 5880.6 19:55:34 INFO - PROCESS | 1663 | 19:55:34 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:25554.26 Median:23880.28 stddev:40953.39 (171.5%) stddev-sans-first:41025.64 19:55:34 INFO - PROCESS | 1663 | Values: 668.4 696.3 697.4 774.8 780.1 12431.7 15688.7 15943.8 15944.6 15960.2 14290.1 14410.0 14432.2 14434.0 14511.9 681.9 833.7 834.0 862.4 864.3 855.0 861.0 870.5 873.5 876.3 919.8 921.2 923.9 924.1 927.6 898.7 908.0 911.0 917.9 919.3 653.1 661.4 678.8 691.6 697.6 12854.2 14514.1 14677.9 14848.6 14926.3 12400.9 14387.9 14755.3 14798.6 15032.2 11514.8 11669.9 12005.9 12221.5 12301.1 3671.3 3872.8 3876.6 3889.2 4057.3 114660.0 115702.0 117161.0 117301.0 120347.0 11340.5 11502.4 11582.0 11603.1 11771.5 23643.2 23679.8 23801.4 23959.2 24054.9 7524.4 7536.4 7585.5 7661.8 7780.9 4370.7 4534.2 4574.2 4578.2 4612.6 3603.9 3674.7 3683.3 3709.8 3717.7 677.4 711.8 713.5 713.6 716.1 586.5 686.8 697.7 700.6 707.4 9216.8 9862.4 9868.0 9887.7 9987.0 580.7 667.1 678.5 679.7 681.6 4524.6 4838.6 4840.4 4848.6 4852.9 94378.5 129124.4 147838.0 149114.0 163568.2 142823.0 143124.0 143952.0 144876.0 147840.0 105711.0 119630.0 121609.8 122839.8 124640.0 8750.2 9541.1 10158.2 10174.1 10253.3 59685.7 61537.1 63268.0 63953.4 64788.7 73870.6 87660.7 95006.0 96333.8 100284.0 13235.1 13291.5 13357.5 13360.1 13439.6 14990.5 15092.5 15133.2 15500.0 15593.5 13594.3 13692.0 13703.8 13884.8 14375.4 12846.8 13003.5 13818.9 13942.9 14076.2 13373.6 13692.3 13751.0 14135.2 14303.1 11266.4 11427.4 11562.2 11891.6 12115.0 10656.2 11412.5 11434.6 11692.6 11696.4 19:55:34 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:55:34 INFO - PROCESS | 1663 | 19:55:35 INFO - TEST-INFO | 1663: exit 0 19:55:35 INFO - TEST-OK | dromaeo_css | took 1113376ms 19:55:35 INFO - TEST-START | kraken 19:55:35 INFO - operating with platform_type : mac_ 19:55:35 INFO - Initialising browser for kraken test... 19:55:35 INFO - TEST-INFO | started process 1785 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpCm_HPi/profile http://localhost:49270/getInfo.html) 19:55:38 INFO - PROCESS | 1785 | __metrics Screen width/height:1600/1200 19:55:38 INFO - PROCESS | 1785 | colorDepth:24 19:55:38 INFO - PROCESS | 1785 | Browser inner width/height: 1024/663 19:55:38 INFO - PROCESS | 1785 | __metrics 19:55:38 ERROR - PROCESS | 1785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:55:38 INFO - TEST-INFO | 1785: exit 0 19:55:38 INFO - Browser initialized. 19:55:38 INFO - Running cycle 1/1 for kraken test... 19:55:38 INFO - TEST-INFO | started process 1787 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpCm_HPi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:51 INFO - PROCESS | 1787 | RSS: Main: 268259328 19:55:51 INFO - PROCESS | 1787 | 19:55:54 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 19:55:55 INFO - PROCESS | 1787 | RSS: Main: 278892544 19:55:55 INFO - PROCESS | 1787 | 19:55:57 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 19:55:58 INFO - PROCESS | 1787 | RSS: Main: 287588352 19:55:58 INFO - PROCESS | 1787 | 19:56:02 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 19:56:02 INFO - PROCESS | 1787 | RSS: Main: 287834112 19:56:02 INFO - PROCESS | 1787 | 19:56:04 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 19:56:05 INFO - PROCESS | 1787 | RSS: Main: 288477184 19:56:05 INFO - PROCESS | 1787 | 19:56:07 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:08 INFO - PROCESS | 1787 | RSS: Main: 289423360 19:56:08 INFO - PROCESS | 1787 | 19:56:11 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:11 INFO - PROCESS | 1787 | RSS: Main: 288866304 19:56:11 INFO - PROCESS | 1787 | 19:56:14 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:15 INFO - PROCESS | 1787 | RSS: Main: 289280000 19:56:15 INFO - PROCESS | 1787 | 19:56:18 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 19:56:19 INFO - PROCESS | 1787 | RSS: Main: 289255424 19:56:19 INFO - PROCESS | 1787 | 19:56:20 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:21 INFO - PROCESS | 1787 | RSS: Main: 289312768 19:56:21 INFO - PROCESS | 1787 | 19:56:23 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:23 INFO - PROCESS | 1787 | RSS: Main: 289546240 19:56:23 INFO - PROCESS | 1787 | 19:56:25 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:26 INFO - PROCESS | 1787 | RSS: Main: 289554432 19:56:26 INFO - PROCESS | 1787 | 19:56:29 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:30 INFO - PROCESS | 1787 | RSS: Main: 289497088 19:56:30 INFO - PROCESS | 1787 | 19:56:33 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:33 INFO - PROCESS | 1787 | RSS: Main: 289472512 19:56:33 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 19:56:35 INFO - PROCESS | 1787 | RSS: Main: 290533376 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | __start_tp_report 19:56:35 INFO - PROCESS | 1787 | _x_x_mozilla_page_load 19:56:35 INFO - PROCESS | 1787 | _x_x_mozilla_page_load_details 19:56:35 INFO - PROCESS | 1787 | |i|pagename|runs| 19:56:35 INFO - PROCESS | 1787 | |0;ai-astar;105;132;111;119;118;117;135;145;173;170 19:56:35 INFO - PROCESS | 1787 | |1;audio-beat-detection;142;112;128;193;143;131;128;142;174;111 19:56:35 INFO - PROCESS | 1787 | |2;audio-dft;249;194;271;193;264;195;285;289;198;195 19:56:35 INFO - PROCESS | 1787 | |3;audio-fft;83;77;79;174;50;53;50;51;158;49 19:56:35 INFO - PROCESS | 1787 | |4;audio-oscillator;71;71;118;73;71;94;114;71;73;121 19:56:35 INFO - PROCESS | 1787 | |5;imaging-gaussian-blur;77;122;135;132;88;85;94;86;136;88 19:56:35 INFO - PROCESS | 1787 | |6;imaging-darkroom;93;95;115;153;105;95;95;100;151;120 19:56:35 INFO - PROCESS | 1787 | |7;imaging-desaturate;90;93;93;89;95;91;92;93;112;151 19:56:35 INFO - PROCESS | 1787 | |8;json-parse-financial;56;56;56;56;56;55;57;56;56;55 19:56:35 INFO - PROCESS | 1787 | |9;json-stringify-tinderbox;68;74;74;80;76;76;78;72;77;73 19:56:35 INFO - PROCESS | 1787 | |10;stanford-crypto-aes;86;88;84;87;85;88;87;84;88;116 19:56:35 INFO - PROCESS | 1787 | |11;stanford-crypto-ccm;149;165;159;152;135;134;153;156;161;135 19:56:35 INFO - PROCESS | 1787 | |12;stanford-crypto-pbkdf2;170;170;166;167;168;169;165;168;164;167 19:56:35 INFO - PROCESS | 1787 | |13;stanford-crypto-sha256-iterative;69;69;67;71;75;66;86;66;66;70 19:56:35 INFO - PROCESS | 1787 | __end_tp_report 19:56:35 INFO - PROCESS | 1787 | __start_cc_report 19:56:35 INFO - PROCESS | 1787 | _x_x_mozilla_cycle_collect,1084 19:56:35 INFO - PROCESS | 1787 | __end_cc_report 19:56:35 INFO - PROCESS | 1787 | __startTimestamp1471056995650__endTimestamp 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | ------- Summary: start ------- 19:56:35 INFO - PROCESS | 1787 | Number of tests: 14 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#0] ai-astar Cycles:10 Average:132.50 Median:133.50 stddev:23.71 (17.8%) stddev-sans-first:22.97 19:56:35 INFO - PROCESS | 1787 | Values: 105.0 132.0 111.0 119.0 118.0 117.0 135.0 145.0 173.0 170.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:142.00 stddev:25.76 (18.1%) stddev-sans-first:27.32 19:56:35 INFO - PROCESS | 1787 | Values: 142.0 112.0 128.0 193.0 143.0 131.0 128.0 142.0 174.0 111.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#2] audio-dft Cycles:10 Average:233.30 Median:256.50 stddev:41.81 (16.3%) stddev-sans-first:43.96 19:56:35 INFO - PROCESS | 1787 | Values: 249.0 194.0 271.0 193.0 264.0 195.0 285.0 289.0 198.0 195.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#3] audio-fft Cycles:10 Average:82.40 Median:52.00 stddev:46.20 (88.9%) stddev-sans-first:49.01 19:56:35 INFO - PROCESS | 1787 | Values: 83.0 77.0 79.0 174.0 50.0 53.0 50.0 51.0 158.0 49.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:71.00 stddev:21.87 (30.8%) stddev-sans-first:22.35 19:56:35 INFO - PROCESS | 1787 | Values: 71.0 71.0 118.0 73.0 71.0 94.0 114.0 71.0 73.0 121.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#5] imaging-gaussian-blur Cycles:10 Average:104.30 Median:85.50 stddev:23.85 (27.9%) stddev-sans-first:23.16 19:56:35 INFO - PROCESS | 1787 | Values: 77.0 122.0 135.0 132.0 88.0 85.0 94.0 86.0 136.0 88.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#6] imaging-darkroom Cycles:10 Average:112.20 Median:123.00 stddev:22.84 (18.6%) stddev-sans-first:23.15 19:56:35 INFO - PROCESS | 1787 | Values: 93.0 95.0 115.0 153.0 105.0 95.0 95.0 100.0 151.0 120.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:92.50 stddev:19.10 (20.6%) stddev-sans-first:19.92 19:56:35 INFO - PROCESS | 1787 | Values: 90.0 93.0 93.0 89.0 95.0 91.0 92.0 93.0 112.0 151.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 19:56:35 INFO - PROCESS | 1787 | Values: 56.0 56.0 56.0 56.0 56.0 55.0 57.0 56.0 56.0 55.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:76.00 stddev:3.39 (4.5%) stddev-sans-first:2.55 19:56:35 INFO - PROCESS | 1787 | Values: 68.0 74.0 74.0 80.0 76.0 76.0 78.0 72.0 77.0 73.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:87.00 stddev:9.51 (10.9%) stddev-sans-first:10.01 19:56:35 INFO - PROCESS | 1787 | Values: 86.0 88.0 84.0 87.0 85.0 88.0 87.0 84.0 88.0 116.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:154.50 stddev:11.46 (7.4%) stddev-sans-first:12.16 19:56:35 INFO - PROCESS | 1787 | Values: 149.0 165.0 159.0 152.0 135.0 134.0 153.0 156.0 161.0 135.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:2.01 (1.2%) stddev-sans-first:1.90 19:56:35 INFO - PROCESS | 1787 | Values: 170.0 170.0 166.0 167.0 168.0 169.0 165.0 168.0 164.0 167.0 19:56:35 INFO - PROCESS | 1787 | 19:56:35 INFO - PROCESS | 1787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:69.50 stddev:6.13 (8.8%) stddev-sans-first:6.48 19:56:35 INFO - PROCESS | 1787 | Values: 69.0 69.0 67.0 71.0 75.0 66.0 86.0 66.0 66.0 70.0 19:56:35 INFO - PROCESS | 1787 | -------- Summary: end -------- 19:56:35 INFO - PROCESS | 1787 | 19:56:36 INFO - TEST-INFO | 1787: exit 0 19:56:36 INFO - TEST-OK | kraken | took 61024ms 19:56:36 INFO - SUITE-END | took 1174s 19:56:36 INFO - Completed test suite (00:19:34) 19:56:36 INFO - javascript benchmark 19:56:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7363.011720916192, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2711.9322016949577, 3218.5011323244903, 3244.3673483670664, 3288.7862288951233, 3346.615139258985, 5085.23721441783, 5348.117560602501, 5604.355499117602, 5686.317641882974, 5727.513161381283, 5682.096497673285, 5739.397363276858, 5772.220750198722, 5780.682062486561, 5832.737526811293, 5181.0, 5293.311869456965, 5303.0, 5373.838784836461, 5375.838724838261, 5311.601629877755, 5330.973345133269, 5394.487523685244, 5400.972995135038, 5425.9186112208345, 5088.54203121719, 5135.768890399941, 5205.089109405839, 5260.500252476008, 5283.973580132075, 5207.218917162456, 5216.5305122538775, 5220.425753167148, 5238.92141617876, 5257.395399529065, 5156.149235376196, 5204.011237864794, 5247.921281180786, 5260.026895024433, 5277.656952298088, 5476.2333273341765, 5639.379668236491, 5696.2594862668, 5738.684372359518, 5831.979403604395, 5321.909008653217, 6086.0, 6256.311805701369, 6263.87472250557, 6264.154339164245, 6138.081874382042, 6313.116163737081, 6316.96841515794, 6322.209723784527, 6329.968350158266, 5770.047942089592, 5803.129530570448, 5804.868050730067, 5829.213056237396, 5947.1079338099635, 5230.97384513075, 5343.545798607084, 6285.779997700059, 6297.527685423612, 6310.148130002391, 5252.789888404497, 5813.854653633608, 6114.266288045463, 6201.976673848764, 6233.532485063638, 5189.221616757441, 6110.3765049759795, 6117.888303246575, 6140.749659041545, 6183.598066125687, 6121.117656725397, 6142.222533142085, 6231.376862313823, 6233.407826256498, 6245.063240513869, 5591.916121258185, 5890.2342695449315, 6184.907226391608, 6210.161628180228, 6263.530235232376, 4873.780679869415, 4898.4121905371585, 4912.04215178044, 4940.827071052496, 4947.529984651453, 3915.882523524299, 4053.858114965962, 4389.144116897238, 4452.799624016927, 4467.888302792456, 5495.505404513533, 5768.769249229984, 5795.884082318415, 5835.35811060783, 5856.180134781134, 6106.794380079898, 6185.381461853779, 6195.2255968004, 6210.31686514483, 6220.191375121205, 5788.623739456922, 5865.20819689345, 5878.882422351529, 5890.204822348928, 5925.614835035709, 4866.46468888422, 5508.55931525477, 5510.9448905510435, 5520.337559492807, 5527.39198688144, 6180.969095154495, 6216.502679785697, 6262.09199666055, 6282.120503129657, 6349.365063493614, 6276.089966954857, 6288.119663247057, 6293.874122517615, 6302.842428939313, 6310.6213627182515, 6323.177986861862, 6332.968335158294, 6340.239171299474, 6341.27075386318, 6355.872882542416, 6082.939170608414, 6115.296740874856, 6118.314626315779, 6145.033589251397, 6202.472789812917, 5141.791678955517, 6274.341194174546, 6275.215598050244, 6283.560150789401, 6311.0, 5739.282589676291, 6158.0147176451555, 6169.259688837368, 6170.660613666291, 6174.66039367839, 6047.576669633084, 6099.461111717743, 6112.0171844544475, 6122.938770612237, 6147.0, 5014.774335155, 5770.076787713946, 6043.909341359795, 6076.51387888959, 6094.14681944537, 6132.448079672851, 6140.201773769381, 6168.753249870135, 6199.194104766351, 6219.689015549114, 5865.824025279248, 5948.434898684618, 5949.881002379841, 5962.433568810956, 6059.454649081604], "value": 5656.188415559072, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.1672256827982, 501.3006855436666, 518.1864472777738, 529.1718460609146, 574.4772257245907, 38548.229035419274, 41150.79424602877, 41151.76544703656, 41162.58837411625, 41194.176116477654, 36679.449808252895, 41053.74204418756, 42545.14909701804, 42858.35712464315, 42907.78546107273, 9636.229101671885, 9830.311878168532, 9852.458114803683, 9861.654842080528, 9865.506724663774, 9726.027397260254, 9796.804063918717, 9817.95091024544, 9838.311318207729, 9857.605695772161, 8292.37807164462, 9704.563294651722, 9796.314258001943, 9832.852507212398, 9847.60609575616, 8328.916710832875, 8359.874601880916, 9810.166135878459, 9835.852462213108, 9864.60541578336, 8653.740387788377, 9681.41911485306, 9690.903090969141, 9740.269479789044, 9744.976777438409, 38176.80911595452, 38392.65625703115, 40129.19741605181, 40261.19477610431, 40536.0, 2591.313301974978, 2663.893444262227, 3216.64616892144, 3305.949912266706, 3401.914952126192, 31027.84486077578, 31293.530597041063, 31428.0, 32111.715531378715, 32466.863659772032, 2694.8652567371555, 3089.644690860557, 3111.797733147338, 3143.5913331267016, 3149.6377916539664, 424283.0, 428094.0, 430659.0, 431230.0, 433483.0, 34416.31167376639, 34484.96545103651, 34550.96347109591, 34583.0229523608, 34794.47808282878, 32730.0, 35733.82133089318, 35757.46363804545, 35872.82063589717, 35909.10227244288, 16102.516924492284, 16212.0, 16253.593660158354, 16257.837421625869, 16294.592635183979, 12139.757204855854, 12276.140670153003, 12288.877111228774, 12292.815607765891, 12302.138850280573, 19901.203951841766, 20097.59804803896, 20123.893185874625, 20136.798632013786, 20137.09383077765, 7813.296803287732, 8010.0, 8017.559034253172, 8021.679132834738, 8064.959675201587, 860.6428332242175, 999.1806718490913, 1044.289882879634, 1073.581303291717, 1103.757173421846, 31131.533027004614, 31177.688223117933, 31271.374572508423, 31389.843050785057, 31662.841685791424, 948.5589201021559, 999.2256001598673, 1034.403646846421, 1071.223363061774, 1106.2256420505678, 11847.76304473923, 13727.931360343135, 15404.845951540565, 15476.845231547766, 15914.0, 680564.0, 689592.0, 697961.0, 703965.0, 707489.4625526839, 48112.0, 60009.0, 60520.48698782566, 60646.393536064956, 60666.0, 1323.7021670124145, 1333.5732565578921, 1380.8964327675465, 1386.8197134372467, 1393.6376542098924, 27788.166355009384, 30100.84949575238, 30124.849375753856, 30420.695793041785, 30787.846060769552, 51396.0, 51631.48368516267, 51799.0, 51888.48111518836, 52068.21897671462, 588590.0, 592919.0, 593527.0, 594810.0, 598704.0, 26654.466910662068, 27499.45001100007, 27698.723012769613, 27700.861495692392, 27799.0, 47716.284255736886, 48296.275555867396, 48824.0, 49321.76695582639, 49653.00693986028, 40429.39355909605, 40534.0, 40680.98297542467, 40919.0, 41932.0, 39361.80319098386, 40927.1814563713, 40952.590474094875, 41048.1790364197, 42169.578304216564, 38161.23677526489, 38605.613943861325, 39187.41218881662, 39226.80386598049, 39466.0, 28849.56725649075, 34652.30695386128, 35861.0, 36467.45298820573, 36574.817125914204, 26394.868025659747, 26423.94304227886, 26676.733232667426, 26841.597376039765, 26879.059232926753], "value": 19465.44884497871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.8814708462948, 380.4046666966198, 385.84631950468093, 393.2901113490149, 408.37110849292094, 19191.61616767664, 20970.26604068858, 21719.022643981018, 21816.236431724894, 22004.809302651127, 20220.494487637818, 20733.688994665055, 20796.48008799777, 20863.687044694343, 21042.36872893812, 5371.946280537184, 5959.374265702104, 6102.725377358008, 6171.660558669271, 6176.444120029197, 5967.403259674042, 6024.3674414186535, 6147.938520614782, 6202.906956395657, 6206.534509911752, 5914.142449344842, 6077.11881777142, 6086.847828804293, 6125.846853828668, 6135.631862088267, 5989.850253743648, 6023.909641355383, 6031.939680603182, 6080.209572755558, 6081.817545473643, 5213.348331458567, 5246.396664383607, 5254.4220135785035, 5261.921071183897, 5269.209618557209, 19253.51866203342, 20195.293164739163, 20318.882461464615, 23758.168464103674, 25661.230163095137, 2143.0570548958563, 2176.336217453692, 2383.9629761053825, 2570.7943364530793, 2583.4962182374443, 11456.599019034295, 14928.104313741102, 15497.767533487007, 15709.0, 15776.76334854978, 1574.9841352327685, 1722.2163915418455, 1837.9632407351912, 1894.6873765828623, 1917.8178073083034, 78661.06694665301, 108576.0, 114304.42847785707, 133303.0, 134324.32837835845, 9519.809603808024, 10675.359478431319, 11357.943210283896, 11656.30062196271, 11945.104117191246, 14625.853741462663, 14731.337089830984, 14739.778903316459, 14750.926245368704, 14771.261436928326, 6878.621675807779, 7094.326039026284, 8391.118932512121, 8450.450720703135, 8567.785805354915, 8038.799030024296, 8101.189881011969, 8216.383771217183, 8313.916860831314, 8352.8329433411, 4541.545845415432, 4653.488116307203, 4683.2038553446, 4709.893175103848, 4732.6687131900435, 1851.6204178143448, 1881.4543782302978, 1900.8859468431663, 1905.9714104288446, 1911.4838993471685, 819.6844214977158, 874.9912500874909, 981.5681100315838, 994.6469003503652, 1047.2512153810062, 20469.488262793253, 21327.907453419168, 21349.89325053365, 21380.824054676832, 21548.784512154678, 937.540605103508, 952.1288021460286, 958.7075941837807, 960.5389413081759, 975.7999610079917, 11231.438428078727, 11309.0, 11349.716257093474, 11457.770844583061, 11525.48135333912, 494526.0, 521715.0, 560652.0, 586198.0, 591029.0, 114343.0, 128026.0, 133898.0, 134720.65279347278, 144241.0, 979.5102448775613, 1002.6039714312951, 1007.4106647611083, 1028.2391030637275, 1030.6289735695143, 17412.73880891813, 18150.909245453688, 18665.253389864254, 19222.03889805532, 20101.89439580837, 32548.83725581357, 39078.0, 41506.37740433835, 43199.0, 55073.39119305709, 81692.0, 85060.72408913996, 85239.57380213059, 86382.56808715916, 86964.1303586956, 7815.53106813593, 8188.140245274399, 8392.16078392156, 8400.243978042006, 8551.957240213758, 12663.746725065263, 12699.936500317439, 13318.0, 13503.864961350653, 14117.505887293895, 11125.388103654377, 11422.885771142182, 11888.643340699793, 11980.46087926028, 12272.325022123869, 11480.0, 11545.826812597987, 11571.6528504145, 11833.940830296138, 11926.284422934652, 11266.774664506827, 11641.126915481203, 11646.767064658829, 11996.64010079699, 12114.273143611059, 6404.815109204812, 8099.554524501209, 8509.617067231866, 8607.612657430556, 8748.037715851378, 8443.95778021106, 10728.249022568345, 11771.646850594496, 11820.586279480176, 11846.822297665369], "value": 9658.252068791795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.3694611317137, 1525.740624093904, 1712.7582502685555, 1817.7636907202061, 1880.840128589069, 7964.561949092812, 8410.28512576431, 8540.975082990035, 8963.193312601865, 9000.954995225024, 7424.517406368595, 8757.43076700014, 8760.16778406052, 8776.91223087769, 8842.95578522108, 1815.8002619711854, 2181.727284089489, 2354.6585745066955, 2356.210669425736, 2364.810815134785, 1949.337225343383, 2045.8772473651554, 2345.6833327500826, 2359.976400235993, 2364.609839376501, 2346.460314127743, 2353.6587194856734, 2354.6350315701093, 2362.621980483123, 2367.337145599235, 2325.976740232593, 2330.8135349172026, 2337.824663150262, 2341.3678306857137, 2351.2123438648073, 2305.1931823861682, 2317.8493397929083, 2339.0994467130276, 2340.1458467659354, 2341.028473183627, 8866.290696744309, 8878.955605221932, 8896.19934205918, 8912.24245939096, 8918.10818918103, 5144.6913185209005, 5258.55302299305, 5290.312259406291, 5299.516135482071, 5310.654807437504, 3460.532828068229, 3489.098411855258, 3606.549181352331, 3611.458281257806, 3638.4542318652148, 1040.7658276887717, 1077.5582011375297, 1082.0640146273417, 1100.5047728522118, 1101.801675698374, 11496.827547586792, 11504.0, 11631.127665425127, 11649.718530961673, 11719.882801172049, 4554.567316104964, 4694.272387779832, 4789.185838407479, 4811.807527698923, 4813.638977076734, 9131.497767622712, 9851.852222216672, 9897.554610042565, 9948.651797187063, 9982.401055936667, 5324.866878328073, 5329.280547126088, 5349.946500535023, 5361.624686272002, 5368.677879327175, 4267.4025636410925, 4688.601468875116, 4900.926486102711, 4910.852674419773, 4918.827841025547, 3895.902602434962, 3951.4665520154986, 3988.3818008208773, 4039.4748682671066, 4091.1408604193452, 1274.216356940475, 1285.3830161522335, 1286.424130440222, 1292.1600959376292, 1295.740851829619, 735.1435577552091, 852.6759831264204, 900.1538553759445, 912.539167720297, 942.2697409507549, 5276.314079169683, 5756.30924289088, 5999.340072592011, 6036.758529658764, 6089.69551522431, 938.0900526489295, 945.7824700318965, 949.349695458613, 959.3668179001826, 995.0845222395413, 3506.281212351462, 3644.5079914211774, 3867.7099217558793, 3888.2806680764147, 3958.287508248485, 9197.63209471627, 10654.680359589225, 10900.34597924127, 10912.454377281105, 10923.3992130432, 10735.51690173944, 10791.730206744895, 10871.130309575216, 10874.565017399216, 10883.510242039127, 8060.9117769101595, 8195.590220488952, 8343.08226095129, 8356.0, 8399.572072747647, 5327.200919862052, 6016.067509536029, 6044.304904935989, 6057.182280392267, 6105.175801266772, 9496.0, 9775.266854986046, 10129.594816207564, 10138.290319677551, 10160.949195253976, 7801.492902961516, 8687.044425113107, 10147.289689721649, 10171.84742228882, 10198.541065651914, 6792.898106528307, 7356.963215184104, 7469.850602988018, 7519.586422746583, 7633.427492937941, 8460.873086903825, 8506.234438900528, 8529.232369086812, 8560.400771945904, 8561.529115898686, 5780.913286300624, 7482.401407887465, 7585.506942048749, 7671.808204794925, 7711.537307761552, 6061.454469097803, 7359.337659610661, 7362.9307978338875, 7380.77857664271, 7441.665125069493, 6939.722411103701, 6987.371136597731, 7060.117485314336, 7061.2585678505075, 7067.399271062018, 4962.131626965339, 4985.551300382983, 5002.224655178453, 5013.222950442687, 5072.82245121419, 4234.364845273234, 4325.653947684241, 4911.214205727067, 5109.897802044013, 5171.586273098068], "value": 4553.097101427115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.45654506705534, 306.7377392329558, 316.3877896270716, 317.61251273446385, 320.05423972162265, 5102.3366962294895, 5455.618106732531, 5465.852171044081, 5549.278593782813, 5711.314642242932, 4635.860924172281, 5555.611107222496, 5561.833145005657, 5648.548116150709, 5665.696889715357, 3611.368010598135, 4259.893502662428, 4327.221100201962, 4343.631755996851, 4362.629176519999, 4094.485040534991, 4189.706720529564, 4275.033484597074, 4293.162833247518, 4363.905325443789, 3670.1925576373287, 3882.5340959084806, 4264.104538047014, 4313.352997050436, 4323.632491238232, 3930.7051971102283, 4267.935980960288, 4275.508316543575, 4292.635126014293, 4319.805608747598, 3560.839762210707, 3693.353663108945, 3697.482352470656, 3718.2377612589353, 3741.607131251234, 4423.402840616508, 4943.975280123613, 5491.176323551459, 5541.141123125922, 5580.525655319303, 4731.124741922756, 4909.582685471739, 4946.851594452136, 4948.678335908155, 4970.801167953277, 5217.452167522393, 5511.311086114236, 5770.932377510132, 5958.40415958405, 6013.278406591194, 3368.4778859276853, 3599.31612993533, 3880.3597406427907, 3957.762534247954, 4071.3485842265095, 6410.487161027107, 6415.294317625057, 6421.197350331162, 6464.5798023128345, 6510.609363438209, 3509.2279698466295, 3537.380958332333, 3886.9805650971566, 4102.261592913304, 4200.096979149497, 3632.055665526982, 3927.6857851371824, 4186.853460128881, 4220.641245494167, 4271.3592961055465, 4924.60603151747, 4924.975375123101, 4949.0, 4969.304297398367, 4998.400191976913, 5758.0, 5766.481016708516, 6059.242594675666, 6119.5521791283845, 6122.969385153135, 1188.7206506470973, 1375.587323802855, 1390.9220354225354, 1427.186503692906, 1438.9136651800925, 802.9197080291924, 841.6885752271698, 870.5777697816554, 878.9452656811851, 879.9340049496313, 4518.593326600621, 4542.227821270392, 4688.507062238654, 4756.453007904135, 4759.358021482583, 5088.303199304374, 5106.004329155779, 5113.64204505681, 5231.032259032091, 5253.900198882678, 3922.4116382542275, 4162.771982265239, 4278.336857787048, 4500.887477813016, 4734.4081989751285, 2512.69847618287, 2531.822772405914, 2607.2438992692287, 2722.509948209302, 2764.8940423830627, 4943.083580687412, 4963.6277279204205, 4971.3957380898555, 5434.510894019557, 5466.972665136649, 4934.642973182404, 5215.7913683453, 5254.9752798204745, 5275.604329675213, 5401.702906340189, 4700.506446823103, 5015.498450154955, 5261.684578855286, 5367.0, 5444.40111587725, 4680.953190468052, 4913.336699545658, 4939.382127472445, 5083.542481176712, 5113.360829896263, 4042.586608158458, 4513.932291015703, 4516.848203708033, 4902.264660300983, 5097.745112744274, 4605.40129783126, 4917.778699958439, 5098.413682426569, 5234.659747116425, 5308.893822123458, 3458.4985177149674, 3495.8574089703784, 4047.4535937648043, 4152.730072545275, 4159.772867004181, 6072.360462674965, 6077.8974192419055, 6138.815835524942, 6169.167162433194, 6170.969145154246, 5203.531682148625, 5581.246531718166, 5964.701764911651, 5965.313988891333, 5971.1486091471625, 5871.944819313207, 5893.911591326219, 5954.0, 5974.581779275409, 5984.162217289496, 5041.42023667283, 5496.972515137559, 5505.247376311844, 5810.506106980785, 5864.472197502245, 4935.432425271139, 5582.036753904773, 5642.774289028393, 5839.153322768259, 5930.555208359304, 5765.827025189251, 5818.214541036906, 5844.15259787337, 5861.501772349398, 5880.647161170344], "value": 4109.781014707583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.3550373889199, 696.3454352908266, 697.4176562570253, 774.7520793346124, 780.0950896959528, 12431.68920776981, 15688.686226275482, 15943.760843587355, 15944.601384965381, 15960.201989900517, 14290.14259144452, 14410.0, 14432.20622865742, 14434.0, 14511.927440362784, 681.8602186551769, 833.7290380626321, 833.9617176615108, 862.4480332587149, 864.2999170671744, 854.9572521373938, 860.9655613775473, 870.5081628879663, 873.5239294584435, 876.3383645347785, 919.843626583479, 921.1985572551856, 923.9029901860308, 924.085155695863, 927.5686805635378, 898.7393655839865, 907.9636814527411, 910.968116115936, 917.9311551633655, 919.3013309884469, 653.0922018394435, 661.4476911778622, 678.7726111752569, 691.640347019552, 697.5953946710896, 12854.228746275254, 14514.056586321962, 14677.853221467756, 14848.554543363716, 14926.253687315699, 12400.937995309965, 14387.928060359736, 14755.26223688822, 14798.630034249123, 15032.17323047232, 11514.790946950618, 11669.94165029178, 12005.93997030018, 12221.511139554406, 12301.077419193596, 3671.320805650963, 3872.8257228424786, 3876.592957739453, 3889.2027134437653, 4057.3102572562734, 114660.0, 115702.0, 117161.0, 117301.0, 120347.0, 11340.489677964511, 11502.424878756028, 11582.015528679987, 11603.129765267639, 11771.470283837249, 23643.172488963148, 23679.816009199472, 23801.40496487567, 23959.16142935024, 24054.87972560126, 7524.398048156135, 7536.397088232929, 7585.469017168855, 7661.770146895602, 7780.8832867507035, 4370.694051416371, 4534.161180181677, 4574.245249533789, 4578.221702310615, 4612.561806628365, 3603.873864414733, 3674.65090816372, 3683.2817600567632, 3709.7588656737225, 3717.7211709121925, 677.4174210179242, 711.7935798618446, 713.5468977199412, 713.5611598866764, 716.1308983552923, 586.5278450847109, 686.8488932434856, 697.7488104282454, 700.5901547594714, 707.398711095575, 9216.769580760534, 9862.408255504693, 9868.0, 9887.653932112342, 9986.951370106179, 580.6632153351046, 667.1292624900854, 678.5080816408164, 679.6601699150425, 681.5910453727823, 4524.615407690383, 4838.588719958843, 4840.419149702058, 4848.587870031016, 4852.902941941142, 94378.52810735903, 129124.35437822939, 147838.0, 149114.0, 163568.18215908844, 142823.0, 143124.0, 143952.0, 144876.0, 147840.0, 105711.0, 119630.0, 121609.78390216161, 122839.77160228461, 124640.0, 8750.218057667009, 9541.071847646339, 10158.238132140266, 10174.13519850821, 10253.33353332031, 59685.70157149187, 61537.076943844986, 63268.0, 63953.36046639474, 64788.67605661941, 73870.63064684642, 87660.68508972244, 95006.0, 96333.81162600977, 100284.0, 13235.073544851768, 13291.534796282083, 13357.53248636293, 13360.064795464225, 13439.596812095653, 14990.475333363716, 15092.54722358331, 15133.243337833284, 15500.0, 15593.454229101926, 13594.252316122313, 13692.041557090908, 13703.794443083163, 13884.791728124288, 14375.353109109907, 12846.807297890353, 13003.544875929298, 13818.930905345811, 13942.930285348508, 14076.225807580682, 13373.598792036255, 13692.315384230948, 13751.037427379988, 14135.15189088658, 14303.07030043044, 11266.436678165896, 11427.371494567878, 11562.248453850472, 11891.583794567148, 12114.970227530759, 10656.200784941006, 11412.543498259976, 11434.599789007345, 11692.590759323382, 11696.415179240834], "value": 8007.096948676613, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 132.0, 111.0, 119.0, 118.0, 117.0, 135.0, 145.0, 173.0, 170.0], "value": 132.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 128.0, 193.0, 143.0, 131.0, 128.0, 142.0, 174.0, 111.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [249.0, 194.0, 271.0, 193.0, 264.0, 195.0, 285.0, 289.0, 198.0, 195.0], "value": 233.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 79.0, 174.0, 50.0, 53.0, 50.0, 51.0, 158.0, 49.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 118.0, 73.0, 71.0, 94.0, 114.0, 71.0, 73.0, 121.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 122.0, 135.0, 132.0, 88.0, 85.0, 94.0, 86.0, 136.0, 88.0], "value": 104.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 115.0, 153.0, 105.0, 95.0, 95.0, 100.0, 151.0, 120.0], "value": 112.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 93.0, 89.0, 95.0, 91.0, 92.0, 93.0, 112.0, 151.0], "value": 99.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 57.0, 56.0, 56.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 74.0, 80.0, 76.0, 76.0, 78.0, 72.0, 77.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 84.0, 87.0, 85.0, 88.0, 87.0, 84.0, 88.0, 116.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 165.0, 159.0, 152.0, 135.0, 134.0, 153.0, 156.0, 161.0, 135.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 167.0, 168.0, 169.0, 165.0, 168.0, 164.0, 167.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 71.0, 75.0, 66.0, 86.0, 66.0, 66.0, 70.0], "value": 70.5, "unit": "score"}]}]} 19:56:36 INFO - Return code: 0 19:56:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:56:36 ERROR - # TBPL SUCCESS # 19:56:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:56:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:56:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:56:36 INFO - 2016-08-12 19:56:36.959 screenresolution[1798:10508] starting screenresolution argv=screenresolution get 19:56:36 INFO - 2016-08-12 19:56:36.961 screenresolution[1798:10508] Display 0: 1600x1200x32@60 19:56:36 INFO - 2016-08-12 19:56:36.967 screenresolution[1799:10511] starting screenresolution argv=screenresolution list 19:56:36 INFO - Available Modes on Display 0 19:56:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:56:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:56:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:56:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:56:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:56:37 INFO - Intel Iris: 19:56:37 INFO - Chipset Model: Intel Iris 19:56:37 INFO - Type: GPU 19:56:37 INFO - Bus: Built-In 19:56:37 INFO - VRAM (Dynamic, Max): 1536 MB 19:56:37 INFO - Vendor: Intel (0x8086) 19:56:37 INFO - Device ID: 0x0a2e 19:56:37 INFO - Revision ID: 0x0009 19:56:37 INFO - Displays: 19:56:37 INFO - Display: 19:56:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:56:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:56:37 INFO - Display Serial Number: 1600x1200 60 19:56:37 INFO - Main Display: Yes 19:56:37 INFO - Mirror: Off 19:56:37 INFO - Online: Yes 19:56:37 INFO - Rotation: Supported 19:56:37 INFO - Return code: 0 19:56:37 INFO - Running post-action listener: _resource_record_post_action 19:56:37 INFO - [mozharness: 2016-08-13 02:56:37.203239Z] Finished run-tests step (success) 19:56:37 INFO - Running post-run listener: _resource_record_post_run 19:56:37 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37118976; Write bytes: 709075456; Read time: 235; Write time: 2044 19:56:37 INFO - TinderboxPrint: CPU usage
54.6% 19:56:37 INFO - TinderboxPrint: I/O read bytes / time
37,118,976 / 235 19:56:37 INFO - TinderboxPrint: I/O write bytes / time
709,075,456 / 2,044 19:56:37 INFO - TinderboxPrint: CPU idle
2,196.3 (45.4%) 19:56:37 INFO - TinderboxPrint: CPU system
977.0 (20.2%) 19:56:37 INFO - TinderboxPrint: CPU user
1,664.1 (34.4%) 19:56:37 INFO - TinderboxPrint: Swap in / out
441,208,832 / 0 19:56:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401816064; Write bytes: 396781056; Read time: 29982; Write time: 809 19:56:37 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 34427904; Write bytes: 300223488; Read time: 211; Write time: 1197 19:56:37 INFO - Running post-run listener: _upload_blobber_files 19:56:37 INFO - Blob upload gear active. 19:56:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:37 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 19:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:56:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:56:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:38 INFO - (blobuploader) - INFO - Done attempting. 19:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:39 INFO - (blobuploader) - INFO - Done attempting. 19:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:42 INFO - (blobuploader) - INFO - Done attempting. 19:56:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:42 INFO - Return code: 0 19:56:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f640e045e3c4cc382eaec6d95de22bdbd64e85657d33ec5a35252aa380c4f1a49fc1d41a7c5e941d1c7d5578648bb6f94a132c194f6e7df0a2ad26b5e3f1d521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62685aa9ec116b62102625d4faa834522fb5174445aa719d38b50895aea5bc8315640bf0ffc43093d044be71f521de5e7284573d053d322a670aaebc83ea4a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6303d22ec121fca2d4a367177230d62dff49027c419d05bbb49c4c0adbf247a76bbe359815c847706b5eb906252b0ff067ee66b88f1c2cfea1de768005f9bf2e"} 19:56:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:42 INFO - Contents: 19:56:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f640e045e3c4cc382eaec6d95de22bdbd64e85657d33ec5a35252aa380c4f1a49fc1d41a7c5e941d1c7d5578648bb6f94a132c194f6e7df0a2ad26b5e3f1d521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62685aa9ec116b62102625d4faa834522fb5174445aa719d38b50895aea5bc8315640bf0ffc43093d044be71f521de5e7284573d053d322a670aaebc83ea4a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6303d22ec121fca2d4a367177230d62dff49027c419d05bbb49c4c0adbf247a76bbe359815c847706b5eb906252b0ff067ee66b88f1c2cfea1de768005f9bf2e"} 19:56:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:42 INFO - Copying logs to upload dir... 19:56:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.752489 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-12 19:56:42.514644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 19:56:42.517890) ========= 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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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/Autoland/sha512/f640e045e3c4cc382eaec6d95de22bdbd64e85657d33ec5a35252aa380c4f1a49fc1d41a7c5e941d1c7d5578648bb6f94a132c194f6e7df0a2ad26b5e3f1d521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62685aa9ec116b62102625d4faa834522fb5174445aa719d38b50895aea5bc8315640bf0ffc43093d044be71f521de5e7284573d053d322a670aaebc83ea4a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6303d22ec121fca2d4a367177230d62dff49027c419d05bbb49c4c0adbf247a76bbe359815c847706b5eb906252b0ff067ee66b88f1c2cfea1de768005f9bf2e"} build_url:https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/T-gKn8ViSxKLNDEABgz-nw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f640e045e3c4cc382eaec6d95de22bdbd64e85657d33ec5a35252aa380c4f1a49fc1d41a7c5e941d1c7d5578648bb6f94a132c194f6e7df0a2ad26b5e3f1d521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62685aa9ec116b62102625d4faa834522fb5174445aa719d38b50895aea5bc8315640bf0ffc43093d044be71f521de5e7284573d053d322a670aaebc83ea4a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6303d22ec121fca2d4a367177230d62dff49027c419d05bbb49c4c0adbf247a76bbe359815c847706b5eb906252b0ff067ee66b88f1c2cfea1de768005f9bf2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 19:56:42.551179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:56:42.551536) ========= 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.GwfsYJzu6x/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.rbmHnNoeGX/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005134 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:56:42.600266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 19:56:42.600595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 19:56:42.601094) ========= ========= Total master_lag: 0.18 =========