builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0153 starttime: 1462984628.42 results: success (0) buildid: 20160511073313 builduid: 73b49a8590bd4827b913da1aeaa29cdc revision: 67b57ffeed5352ce93c403094185d9ccd4348cc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.418343) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.418940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.419334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.438905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.439425) ========= 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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-05-11 09:37:08-- 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% 8.29M=0.001s 2016-05-11 09:37:08 (8.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.569703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.570197) ========= 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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.020595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:08.620888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 09:37:08.621495) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 67b57ffeed5352ce93c403094185d9ccd4348cc4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 67b57ffeed5352ce93c403094185d9ccd4348cc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-05-11 09:37:08,700 truncating revision to first 12 chars 2016-05-11 09:37:08,700 Setting DEBUG logging. 2016-05-11 09:37:08,700 attempt 1/10 2016-05-11 09:37:08,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/67b57ffeed53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 09:37:10,011 unpacking tar archive at: mozilla-beta-67b57ffeed53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.562280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 09:37:10.203217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:10.203672) ========= script_repo_revision: 67b57ffeed5352ce93c403094185d9ccd4348cc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:10.204228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:10.204674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 09:37:10.220044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-11 09:37:10.220646) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:10 INFO - MultiFileLogger online at 20160511 09:37:10 in /builds/slave/test 09:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:10 INFO - {'append_to_log': False, 09:37:10 INFO - 'base_work_dir': '/builds/slave/test', 09:37:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:10 INFO - 'branch': 'Mozilla-Beta', 09:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:10 INFO - 'config_files': ('talos/mac_config.py',), 09:37:10 INFO - 'default_actions': ('clobber', 09:37:10 INFO - 'read-buildbot-config', 09:37:10 INFO - 'download-and-extract', 09:37:10 INFO - 'populate-webroot', 09:37:10 INFO - 'create-virtualenv', 09:37:10 INFO - 'install', 09:37:10 INFO - 'run-tests'), 09:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:10 INFO - 'download_minidump_stackwalk': True, 09:37:10 INFO - 'download_symbols': 'ondemand', 09:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:10 INFO - 'installer_path': 'installer.exe', 09:37:10 INFO - 'log_level': 'info', 09:37:10 INFO - 'log_name': 'talos', 09:37:10 INFO - 'log_to_console': True, 09:37:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:37:10 INFO - 'opt_config_files': (), 09:37:10 INFO - 'pip_index': False, 09:37:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:10 INFO - 'cmd': ('bash', 09:37:10 INFO - '-c', 09:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:10 INFO - 'enabled': True, 09:37:10 INFO - 'halt_on_failure': False, 09:37:10 INFO - 'name': 'check_screen_resolution'},), 09:37:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:10 INFO - 'cmd': ('bash', 09:37:10 INFO - '-c', 09:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:10 INFO - 'enabled': True, 09:37:10 INFO - 'halt_on_failure': False, 09:37:10 INFO - 'name': 'check_screen_resolution'},), 09:37:10 INFO - 'run_cmd_checks_enabled': True, 09:37:10 INFO - 'sps_profile': False, 09:37:10 INFO - 'sps_profile_interval': 0, 09:37:10 INFO - 'suite': 'dromaeojs', 09:37:10 INFO - 'system_bits': '32', 09:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:10 INFO - 'title': 't-yosemite-r7-0153', 09:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:10 INFO - 'use_talos_json': True, 09:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:10 INFO - 'work_dir': 'build'} 09:37:10 INFO - ##### 09:37:10 INFO - ##### Running clobber step. 09:37:10 INFO - ##### 09:37:10 INFO - Running pre-action listener: _resource_record_pre_action 09:37:10 INFO - Running main action method: clobber 09:37:10 INFO - rmtree: /builds/slave/test/build 09:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:11 INFO - Running post-action listener: _resource_record_post_action 09:37:11 INFO - ##### 09:37:11 INFO - ##### Running read-buildbot-config step. 09:37:11 INFO - ##### 09:37:11 INFO - Running pre-action listener: _resource_record_pre_action 09:37:11 INFO - Running main action method: read_buildbot_config 09:37:11 INFO - Using buildbot properties: 09:37:11 INFO - { 09:37:11 INFO - "project": "", 09:37:11 INFO - "product": "firefox", 09:37:11 INFO - "script_repo_revision": "production", 09:37:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:37:11 INFO - "repository": "", 09:37:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:37:11 INFO - "buildid": "20160511073313", 09:37:11 INFO - "pgo_build": "False", 09:37:11 INFO - "basedir": "/builds/slave/test", 09:37:11 INFO - "buildnumber": 6, 09:37:11 INFO - "slavename": "t-yosemite-r7-0153", 09:37:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:37:11 INFO - "platform": "yosemite_r7", 09:37:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:37:11 INFO - "branch": "mozilla-beta", 09:37:11 INFO - "repo_path": "releases/mozilla-beta", 09:37:11 INFO - "revision": "67b57ffeed5352ce93c403094185d9ccd4348cc4", 09:37:11 INFO - "stage_platform": "macosx64", 09:37:11 INFO - "builduid": "73b49a8590bd4827b913da1aeaa29cdc", 09:37:11 INFO - "slavebuilddir": "test" 09:37:11 INFO - } 09:37:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 09:37:11 INFO - Running post-action listener: _resource_record_post_action 09:37:11 INFO - ##### 09:37:11 INFO - ##### Running download-and-extract step. 09:37:11 INFO - ##### 09:37:11 INFO - Running pre-action listener: _resource_record_pre_action 09:37:11 INFO - Running main action method: download_and_extract 09:37:11 INFO - mkdir: /builds/slave/test/build/tests 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:11 INFO - https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:37:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:37:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:37:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 09:37:12 INFO - Downloaded 1241 bytes. 09:37:12 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:37:12 INFO - Using the following test package requirements: 09:37:12 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:37:12 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 09:37:12 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 09:37:12 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:37:12 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 09:37:12 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:37:12 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 09:37:12 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 09:37:12 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 09:37:12 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:37:12 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:37:12 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 09:37:12 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 09:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:12 INFO - https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:37:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:37:13 INFO - Downloaded 17747480 bytes. 09:37:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:37:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:37:16 INFO - Return code: 0 09:37:16 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:16 INFO - https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:37:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:37:17 INFO - Downloaded 17747480 bytes. 09:37:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:37:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:37:21 INFO - Return code: 0 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:21 INFO - https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 09:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 09:37:22 INFO - Downloaded 10845194 bytes. 09:37:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:37:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:37:22 INFO - Return code: 0 09:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:22 INFO - https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:37:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:37:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:37:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 09:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 09:37:25 INFO - Downloaded 88379584 bytes. 09:37:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:37:25 INFO - mkdir: /builds/slave/test/properties 09:37:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:25 INFO - Contents: 09:37:25 INFO - build_url:https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:37:26 INFO - Running post-action listener: _resource_record_post_action 09:37:26 INFO - Running post-action listener: set_extra_try_arguments 09:37:26 INFO - ##### 09:37:26 INFO - ##### Running populate-webroot step. 09:37:26 INFO - ##### 09:37:26 INFO - Running pre-action listener: _resource_record_pre_action 09:37:26 INFO - Running main action method: populate_webroot 09:37:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:26 INFO - '--tppagecycles', 09:37:26 INFO - '7'], 09:37:26 INFO - 'tests': ['tsvgm']}}, 09:37:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:37:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:37:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'tests': ['damp', 'tps']}, 09:37:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['damp', 'tps']}, 09:37:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:37:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:26 INFO - 'other': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other_l64': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'other_nol64': {'tests': ['a11yr', 09:37:26 INFO - 'ts_paint', 09:37:26 INFO - 'tpaint', 09:37:26 INFO - 'sessionrestore', 09:37:26 INFO - 'sessionrestore_no_auto_restore', 09:37:26 INFO - 'tabpaint']}, 09:37:26 INFO - 'svgr': {'tests': ['tsvgx', 09:37:26 INFO - 'tsvgr_opacity', 09:37:26 INFO - 'tart', 09:37:26 INFO - 'tscrollx', 09:37:26 INFO - 'cart']}, 09:37:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['tsvgx', 09:37:26 INFO - 'tsvgr_opacity', 09:37:26 INFO - 'tart', 09:37:26 INFO - 'tscrollx', 09:37:26 INFO - 'cart']}, 09:37:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'tests': ['tp5o']}, 09:37:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'talos_options': ['--e10s'], 09:37:26 INFO - 'tests': ['tp5o']}, 09:37:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'talos_options': ['--xperf_path', 09:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:26 INFO - 'tests': ['tp5n']}, 09:37:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:26 INFO - 'talos_options': ['--e10s', 09:37:26 INFO - '--xperf_path', 09:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:26 INFO - 'tests': ['tp5n']}}, 09:37:26 INFO - 'talos.zip': {'path': '', 09:37:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:26 INFO - Running post-action listener: _resource_record_post_action 09:37:26 INFO - ##### 09:37:26 INFO - ##### Running create-virtualenv step. 09:37:26 INFO - ##### 09:37:26 INFO - Running pre-action listener: _resource_record_pre_action 09:37:26 INFO - Running main action method: create_virtualenv 09:37:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:26 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 09:37:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:26 INFO - Using real prefix '/tools/python27' 09:37:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:30 INFO - Installing pip.................done. 09:37:30 INFO - Return code: 0 09:37:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:30 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 09:37:30 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 09:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:30 INFO - 'HOME': '/Users/cltbld', 09:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:30 INFO - 'LOGNAME': 'cltbld', 09:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:30 INFO - 'MOZ_NO_REMOTE': '1', 09:37:30 INFO - 'NO_EM_RESTART': '1', 09:37:30 INFO - 'PAGER': '/bin/cat', 09:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:30 INFO - 'PWD': '/builds/slave/test', 09:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:30 INFO - 'SHELL': '/bin/bash', 09:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:30 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:30 INFO - 'USER': 'cltbld', 09:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:30 INFO - 'XPC_FLAGS': '0x0', 09:37:30 INFO - 'XPC_SERVICE_NAME': '0', 09:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:30 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 09:37:30 INFO - Cleaning up... 09:37:30 INFO - Return code: 0 09:37:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:37:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:30 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:30 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>=0.7.1'] in /builds/slave/test/build 09:37:30 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>=0.7.1 09:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:30 INFO - 'HOME': '/Users/cltbld', 09:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:30 INFO - 'LOGNAME': 'cltbld', 09:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:30 INFO - 'MOZ_NO_REMOTE': '1', 09:37:30 INFO - 'NO_EM_RESTART': '1', 09:37:30 INFO - 'PAGER': '/bin/cat', 09:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:30 INFO - 'PWD': '/builds/slave/test', 09:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:30 INFO - 'SHELL': '/bin/bash', 09:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:30 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:30 INFO - 'USER': 'cltbld', 09:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:30 INFO - 'XPC_FLAGS': '0x0', 09:37:30 INFO - 'XPC_SERVICE_NAME': '0', 09:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:30 INFO - Downloading/unpacking psutil>=0.7.1 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:33 INFO - Installing collected packages: psutil 09:37:33 INFO - Running setup.py install for psutil 09:37:34 INFO - building 'psutil._psutil_osx' extension 09:37:34 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 09:37:34 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 09:37:34 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 09:37:34 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 09:37:34 INFO - building 'psutil._psutil_posix' extension 09:37:34 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 09:37:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:37:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:37:34 INFO - ^ 09:37:34 INFO - 1 warning generated. 09:37:34 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 09:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:34 INFO - Successfully installed psutil 09:37:34 INFO - Cleaning up... 09:37:34 INFO - Return code: 0 09:37:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:34 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:34 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.0.0'] in /builds/slave/test/build 09:37:34 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.0.0 09:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:34 INFO - 'HOME': '/Users/cltbld', 09:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:34 INFO - 'LOGNAME': 'cltbld', 09:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:34 INFO - 'MOZ_NO_REMOTE': '1', 09:37:34 INFO - 'NO_EM_RESTART': '1', 09:37:34 INFO - 'PAGER': '/bin/cat', 09:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:34 INFO - 'PWD': '/builds/slave/test', 09:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:34 INFO - 'SHELL': '/bin/bash', 09:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:34 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:34 INFO - 'USER': 'cltbld', 09:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:34 INFO - 'XPC_FLAGS': '0x0', 09:37:34 INFO - 'XPC_SERVICE_NAME': '0', 09:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:37:35 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 09:37:35 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 09:37:35 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 09:37:35 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 09:37:35 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 09:37:35 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 09:37:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:37:37 INFO - Installing collected packages: mozsystemmonitor 09:37:37 INFO - Running setup.py install for mozsystemmonitor 09:37:37 INFO - Successfully installed mozsystemmonitor 09:37:37 INFO - Cleaning up... 09:37:37 INFO - Return code: 0 09:37:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:37 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:37 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 09:37:37 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 09:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:37 INFO - 'HOME': '/Users/cltbld', 09:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:37 INFO - 'LOGNAME': 'cltbld', 09:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:37 INFO - 'MOZ_NO_REMOTE': '1', 09:37:37 INFO - 'NO_EM_RESTART': '1', 09:37:37 INFO - 'PAGER': '/bin/cat', 09:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:37 INFO - 'PWD': '/builds/slave/test', 09:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:37 INFO - 'SHELL': '/bin/bash', 09:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:37 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:37 INFO - 'USER': 'cltbld', 09:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:37 INFO - 'XPC_FLAGS': '0x0', 09:37:37 INFO - 'XPC_SERVICE_NAME': '0', 09:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:38 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 09:37:38 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 09:37:38 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 09:37:38 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 09:37:38 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 09:37:38 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 09:37:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:41 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 09:37:41 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 09:37:41 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 09:37:41 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 09:37:41 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 09:37:41 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 09:37:41 INFO - Downloading docopt-0.6.1.tar.gz 09:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:41 INFO - Running setup.py install for blobuploader 09:37:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:41 INFO - Running setup.py install for requests 09:37:42 INFO - Running setup.py install for docopt 09:37:42 INFO - Successfully installed blobuploader requests docopt 09:37:42 INFO - Cleaning up... 09:37:42 INFO - Return code: 0 09:37:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:42 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:42 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 09:37:42 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 09:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:42 INFO - 'HOME': '/Users/cltbld', 09:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:42 INFO - 'LOGNAME': 'cltbld', 09:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:42 INFO - 'MOZ_NO_REMOTE': '1', 09:37:42 INFO - 'NO_EM_RESTART': '1', 09:37:42 INFO - 'PAGER': '/bin/cat', 09:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:42 INFO - 'PWD': '/builds/slave/test', 09:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:42 INFO - 'SHELL': '/bin/bash', 09:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:42 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:42 INFO - 'USER': 'cltbld', 09:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:42 INFO - 'XPC_FLAGS': '0x0', 09:37:42 INFO - 'XPC_SERVICE_NAME': '0', 09:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:42 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-kA09R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-KUN6qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Q6xtc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-w1c7oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-3BtZIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ydIL7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-13Irbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5syR9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Sx6zmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:43 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ojH47M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ToEErh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QO_Jhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Kz3JEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_I2cCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-54RFlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4zRxka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:44 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-uqfSxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:44 INFO - Running setup.py install for manifestparser 09:37:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:44 INFO - Running setup.py install for mozcrash 09:37:45 INFO - Running setup.py install for mozdebug 09:37:45 INFO - Running setup.py install for mozdevice 09:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Running setup.py install for mozfile 09:37:45 INFO - Running setup.py install for mozhttpd 09:37:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Running setup.py install for mozinfo 09:37:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Running setup.py install for mozInstall 09:37:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:45 INFO - Running setup.py install for mozleak 09:37:46 INFO - Running setup.py install for mozlog 09:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for moznetwork 09:37:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozprocess 09:37:46 INFO - Running setup.py install for mozprofile 09:37:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozrunner 09:37:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:46 INFO - Running setup.py install for mozscreenshot 09:37:47 INFO - Running setup.py install for moztest 09:37:47 INFO - Running setup.py install for mozversion 09:37:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:47 INFO - Cleaning up... 09:37:47 INFO - Return code: 0 09:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:47 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:47 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 09:37:47 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 09:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:47 INFO - 'HOME': '/Users/cltbld', 09:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:47 INFO - 'LOGNAME': 'cltbld', 09:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:47 INFO - 'MOZ_NO_REMOTE': '1', 09:37:47 INFO - 'NO_EM_RESTART': '1', 09:37:47 INFO - 'PAGER': '/bin/cat', 09:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:47 INFO - 'PWD': '/builds/slave/test', 09:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:47 INFO - 'SHELL': '/bin/bash', 09:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:47 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:47 INFO - 'USER': 'cltbld', 09:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:47 INFO - 'XPC_FLAGS': '0x0', 09:37:47 INFO - 'XPC_SERVICE_NAME': '0', 09:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:47 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4W9wF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:47 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)) 09:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:47 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VIdUjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:47 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)) 09:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:47 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-S2SLGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:47 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)) 09:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:47 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AsfnUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-A1qLa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-eTIK3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-YXFLIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-knPxdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7tIqCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0ngVmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EJ70So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-2w_iCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:48 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XBaYzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:48 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)) 09:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:49 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fFlth2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:49 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ktHnkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:49 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-HXCaug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:49 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)) 09:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:49 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-RulgrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:49 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)) 09:37:49 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)) 09:37:49 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)) 09:37:49 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)) 09:37:49 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)) 09:37:49 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)) 09:37:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:49 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 09:37:49 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 09:37:49 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 09:37:49 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 09:37:49 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 09:37:49 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 09:37:51 INFO - Downloading blessings-1.6.tar.gz 09:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:51 INFO - Installing collected packages: blessings 09:37:51 INFO - Running setup.py install for blessings 09:37:52 INFO - Successfully installed blessings 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:52 INFO - Reading from file tmpfile_stdout 09:37:52 INFO - Current package versions: 09:37:52 INFO - blessings == 1.6 09:37:52 INFO - blobuploader == 1.2.4 09:37:52 INFO - docopt == 0.6.1 09:37:52 INFO - manifestparser == 1.1 09:37:52 INFO - mozInstall == 1.12 09:37:52 INFO - mozcrash == 0.17 09:37:52 INFO - mozdebug == 0.1 09:37:52 INFO - mozdevice == 0.48 09:37:52 INFO - mozfile == 1.2 09:37:52 INFO - mozhttpd == 0.7 09:37:52 INFO - mozinfo == 0.9 09:37:52 INFO - mozleak == 0.1 09:37:52 INFO - mozlog == 3.1 09:37:52 INFO - moznetwork == 0.27 09:37:52 INFO - mozprocess == 0.22 09:37:52 INFO - mozprofile == 0.28 09:37:52 INFO - mozrunner == 6.11 09:37:52 INFO - mozscreenshot == 0.1 09:37:52 INFO - mozsystemmonitor == 0.0 09:37:52 INFO - moztest == 0.7 09:37:52 INFO - mozversion == 1.4 09:37:52 INFO - psutil == 3.1.1 09:37:52 INFO - requests == 1.2.3 09:37:52 INFO - wsgiref == 0.1.2 09:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:52 INFO - 'HOME': '/Users/cltbld', 09:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PAGER': '/bin/cat', 09:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:52 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - 'XPC_FLAGS': '0x0', 09:37:52 INFO - 'XPC_SERVICE_NAME': '0', 09:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 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)) 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:52 INFO - 'HOME': '/Users/cltbld', 09:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PAGER': '/bin/cat', 09:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:52 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - 'XPC_FLAGS': '0x0', 09:37:52 INFO - 'XPC_SERVICE_NAME': '0', 09:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 INFO - Downloading/unpacking jsonschema 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:55 INFO - Downloading/unpacking functools32 (from jsonschema) 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 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 09:37:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:55 INFO - warning: no files found matching '*.txt' 09:37:55 INFO - no previously-included directories found matching 'build' 09:37:55 INFO - no previously-included directories found matching 'dist' 09:37:55 INFO - no previously-included directories found matching '.git*' 09:37:55 INFO - Installing collected packages: jsonschema, functools32 09:37:55 INFO - Running setup.py install for functools32 09:37:56 INFO - warning: no files found matching '*.txt' 09:37:56 INFO - no previously-included directories found matching 'build' 09:37:56 INFO - no previously-included directories found matching 'dist' 09:37:56 INFO - no previously-included directories found matching '.git*' 09:37:56 INFO - Successfully installed jsonschema functools32 09:37:56 INFO - Cleaning up... 09:37:56 INFO - Return code: 0 09:37:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:56 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8e3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8ea4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9322ca5760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, '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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:37:56 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', 'flake8'] in /builds/slave/test/build 09:37:56 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 flake8 09:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:56 INFO - 'HOME': '/Users/cltbld', 09:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:56 INFO - 'LOGNAME': 'cltbld', 09:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:56 INFO - 'MOZ_NO_REMOTE': '1', 09:37:56 INFO - 'NO_EM_RESTART': '1', 09:37:56 INFO - 'PAGER': '/bin/cat', 09:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:56 INFO - 'PWD': '/builds/slave/test', 09:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:56 INFO - 'SHELL': '/bin/bash', 09:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:37:56 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:56 INFO - 'USER': 'cltbld', 09:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:56 INFO - 'XPC_FLAGS': '0x0', 09:37:56 INFO - 'XPC_SERVICE_NAME': '0', 09:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:56 INFO - Downloading/unpacking flake8 09:37:56 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 09:37:56 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 09:37:56 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 09:37:56 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 09:37:56 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 09:37:56 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 09:37:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:37:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:37:58 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 09:37:58 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 09:37:58 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 09:37:58 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 09:37:58 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 09:37:58 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 09:37:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:37:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:38:00 INFO - no previously-included directories found matching 'docs/_build' 09:38:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:38:00 INFO - Running setup.py install for pep8 09:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:38:00 INFO - no previously-included directories found matching 'docs/_build' 09:38:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:38:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:38:00 INFO - Cleaning up... 09:38:00 INFO - Return code: 0 09:38:00 INFO - Running post-action listener: _resource_record_post_action 09:38:00 INFO - Running post-action listener: _start_resource_monitoring 09:38:00 INFO - Starting resource monitoring. 09:38:00 INFO - ##### 09:38:00 INFO - ##### Running install step. 09:38:00 INFO - ##### 09:38:00 INFO - Running pre-action listener: _resource_record_pre_action 09:38:00 INFO - Running main action method: install 09:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:01 INFO - Reading from file tmpfile_stdout 09:38:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:01 INFO - Reading from file tmpfile_stdout 09:38:01 INFO - Output received: 09:38:01 INFO - Usage: mozinstall [options] installer 09:38:01 INFO - Options: 09:38:01 INFO - -h, --help show this help message and exit 09:38:01 INFO - -d DEST, --destination=DEST 09:38:01 INFO - Directory to install application into. [default: 09:38:01 INFO - "/builds/slave/test"] 09:38:01 INFO - --app=APP Application being installed. [default: firefox] 09:38:01 INFO - mkdir: /builds/slave/test/build/application 09:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:38:23 INFO - Reading from file tmpfile_stdout 09:38:23 INFO - Output received: 09:38:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:38:23 INFO - Running post-action listener: _resource_record_post_action 09:38:23 INFO - ##### 09:38:23 INFO - ##### Running run-tests step. 09:38:23 INFO - ##### 09:38:23 INFO - Running pre-action listener: _resource_record_pre_action 09:38:23 INFO - Running main action method: run_tests 09:38:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:23 INFO - 2016-05-11 09:38:23.936 screenresolution[7129:132368] starting screenresolution argv=screenresolution get 09:38:23 INFO - 2016-05-11 09:38:23.939 screenresolution[7129:132368] Display 0: 1600x1200x32@60 09:38:23 INFO - 2016-05-11 09:38:23.945 screenresolution[7130:132370] starting screenresolution argv=screenresolution list 09:38:23 INFO - Available Modes on Display 0 09:38:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:24 INFO - Intel Iris: 09:38:24 INFO - Chipset Model: Intel Iris 09:38:24 INFO - Type: GPU 09:38:24 INFO - Bus: Built-In 09:38:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:24 INFO - Vendor: Intel (0x8086) 09:38:24 INFO - Device ID: 0x0a2e 09:38:24 INFO - Revision ID: 0x0009 09:38:24 INFO - Displays: 09:38:24 INFO - Display: 09:38:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:24 INFO - Display Serial Number: 1600x1200 60 09:38:24 INFO - Main Display: Yes 09:38:24 INFO - Mirror: Off 09:38:24 INFO - Online: Yes 09:38:24 INFO - Rotation: Supported 09:38:24 INFO - Return code: 0 09:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:24 INFO - Python 2.7.3 09:38:24 INFO - Return code: 0 09:38:24 INFO - grabbing minidump binary from tooltool 09:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:24 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e787d30>, '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 0x10e5ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:24 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 09:38:24 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 09:38:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:24 INFO - Return code: 0 09:38:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:38:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:38:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:38:25 INFO - Return code: 0 09:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y5RfEmdNLm/Render', 09:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:25 INFO - 'HOME': '/Users/cltbld', 09:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:25 INFO - 'LOGNAME': 'cltbld', 09:38:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:25 INFO - 'MOZ_NO_REMOTE': '1', 09:38:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:25 INFO - 'NO_EM_RESTART': '1', 09:38:25 INFO - 'PAGER': '/bin/cat', 09:38:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:25 INFO - 'PWD': '/builds/slave/test', 09:38:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:25 INFO - 'SHELL': '/bin/bash', 09:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1rQIdSOGoT/Listeners', 09:38:25 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:25 INFO - 'USER': 'cltbld', 09:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:25 INFO - 'XPC_FLAGS': '0x0', 09:38:25 INFO - 'XPC_SERVICE_NAME': '0', 09:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:38:25 INFO - mozversion application_buildid: 20160511073313 09:38:25 INFO - mozversion application_changeset: 67b57ffeed5352ce93c403094185d9ccd4348cc4 09:38:25 INFO - mozversion application_display_name: Firefox 09:38:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:25 INFO - mozversion application_name: Firefox 09:38:25 INFO - mozversion application_remotingname: firefox 09:38:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:38:25 INFO - mozversion application_vendor: Mozilla 09:38:25 INFO - mozversion application_version: 47.0 09:38:25 INFO - mozversion platform_buildid: 20160511073313 09:38:25 INFO - mozversion platform_changeset: 67b57ffeed5352ce93c403094185d9ccd4348cc4 09:38:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:38:25 INFO - mozversion platform_version: 47.0 09:38:25 INFO - using testdate: 1462984705 09:38:25 INFO - actual date: 1462984705 09:38:25 INFO - starting webserver on 'localhost:63765' 09:38:25 INFO - SUITE-START | Running 2 tests 09:38:25 INFO - TEST-START | dromaeo_css 09:38:25 INFO - operating with platform_type : mac_ 09:38:25 INFO - Initialising browser for dromaeo_css test... 09:38:25 INFO - TEST-INFO | started process 7148 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpnKe3r6/profile http://localhost:63765/getInfo.html) 09:38:27 INFO - PROCESS | 7148 | __metrics Screen width/height:1600/1200 09:38:27 INFO - PROCESS | 7148 | colorDepth:24 09:38:27 INFO - PROCESS | 7148 | Browser inner width/height: 1024/689 09:38:27 INFO - PROCESS | 7148 | __metrics 09:38:27 INFO - PROCESS | 7148 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:27 INFO - PROCESS | 7148 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:28 INFO - TEST-INFO | 7148: exit 0 09:38:28 INFO - Browser initialized. 09:38:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:28 INFO - TEST-INFO | started process 7151 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpnKe3r6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:40 INFO - PROCESS | 7151 | RSS: Main: 156823552 09:38:40 INFO - PROCESS | 7151 | 09:39:31 INFO - PROCESS | 7151 | 1462984771222 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] 09:41:41 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63765/tests/dromaeo/cssquery-ext.html) 09:41:43 INFO - PROCESS | 7151 | RSS: Main: 278138880 09:41:43 INFO - PROCESS | 7151 | 09:44:45 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-ext.html (next: http://localhost:63765/tests/dromaeo/cssquery-jquery.html) 09:44:46 INFO - PROCESS | 7151 | RSS: Main: 290770944 09:44:46 INFO - PROCESS | 7151 | 09:47:47 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63765/tests/dromaeo/cssquery-mootools.html) 09:47:48 INFO - PROCESS | 7151 | RSS: Main: 289984512 09:47:48 INFO - PROCESS | 7151 | 09:50:50 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63765/tests/dromaeo/cssquery-prototype.html) 09:50:50 INFO - PROCESS | 7151 | RSS: Main: 253087744 09:50:50 INFO - PROCESS | 7151 | 09:53:53 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63765/tests/dromaeo/cssquery-yui.html) 09:53:54 INFO - PROCESS | 7151 | RSS: Main: 255258624 09:53:54 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:63765/tests/dromaeo/cssquery-yui.html (next: http://localhost:63765/tests/dromaeo/cssquery-dojo.html) 09:56:57 INFO - PROCESS | 7151 | RSS: Main: 300576768 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | __start_tp_report 09:56:57 INFO - PROCESS | 7151 | _x_x_mozilla_page_load 09:56:57 INFO - PROCESS | 7151 | _x_x_mozilla_page_load_details 09:56:57 INFO - PROCESS | 7151 | |i|pagename|runs| 09:56:57 INFO - PROCESS | 7151 | |0;dojo.html;3294.357600267948;3627.947895110418;3663.358912190366;3675.6875665568427;3676.246369494254;6002.879942401155;6030.427109424603;6049.969750151254;6067.848303792407;6068.848278793027;6010.308814486335;6055.5761096723245;6061;6067.362926892668;6100.2679678438535;5169.121249387613;5361.195820626898;5384.1923711443205;5403.78384864606;5433.4566543345545;5455.263539422187;5474.616776825604;5482.095454250044;5482.698451585161;5488.725563721818;5411.594130440233;5465.398806131322;5474.452554744534;5513.751881165357;5523.420040895709;5454.400015998237;5477.5070243677865;5498.257735205756;5500.257465242221;5504.366997795225;4304.397384366192;5172.431032586413;5407.459254074601;5419.701916394597;5429.4027656957705;5851.356350801409;5867.14926335679;5940.198073260098;5944.375840536724;5977.91033134499;6261.812145635638;6385.361463853624;6390.329015453403;6394.9360506394805;6399.36006399361;6332.493400527993;6408.871822563523;6453.257875344349;6494.642794646293;6505.0892874997535;6193.4425901669065;6195.783147589813;6198.070289456573;6208;6212.689365531705;6404.199475065617;6496.935030649727;6585.86828263432;6592.406683398422;6604.438622717123;5166.896662066738;6319.9368006320265;6323.810285691437;6334.461570766536;6337.809865704036;6412.5190610704385;6434.292227854932;6453.741850325934;6467.191601049869;6479.870402591921;6268.435840774352;6275.874482510416;6292.622442653455;6367.808965731036;6383.106365108889;6293.685315734195;6295.087212354183;6303.2751233607805;6309.905351419732;6322.430981211713;5138.04946084968;5140.717260550631;5151.201563757623;5153.123968925292;5173.741312934339;4519.593236608721;4598.356230127785;4629.421322334708;4650.255959046536;4654.743989080565;6123.326434092246;6144.678894037804;6168.0439531872635;6173.56785025044;6179.969100154471;6393.1369265148605;6471.061696054046;6472.514561407913;6473.643949582818;6479.060536222221;6012.098185272157;6103.6032657877095;6151.5386346024225;6183.5671502994355;6192.195014648067;5612.747426365823;5615.241942337814;5616.66300022;5618;5658.434156584309;6594.10979517759;6665.733370665119;6666.866662666816;6671.566348187353;6682.231543372477;6277.18396608438;6425.5502114851515;6442.226932768098;6476.417122459001;6477.8704425912165;6660.134182556237;6670.799876003728;6690.933090669226;6711.395974362331;6719.496037797087;5886.735096920564;6230.283517395557;6236.438720515175;6397.648129352744;6416.037594360883;6216.689165541615;6296.433321001132;6309.432151106423;6381.457576106083;6381.521385895983;6308.968455157695;6324.494040476843;6331.683415829098;6337.144485494584;6346.1432706585865;6243.906341404791;6271.153394291895;6291.370862913672;6319.936800631935;6324.557280990287;6252.812415627538;6259;6289.559730818799;6310.968445157745;6315.810525684236;6274.247090349005;6316.305206427382;6326.715297811702;6328.841778955379;6343.55595108338;6145.67867908384;6218.81343559694;6289.119523266655;6313.210848643919;6313.463355614824 09:56:57 INFO - PROCESS | 7151 | |1;ext.html;481.72060205081056;578.3204734437036;587.8030859662013;665.9966700166499;673.111492829465;32581.67418325816;42083.36874946875;42325;42335;42349.15301693964;45000.77499612505;45884.77057614716;45890.54109458905;46144.3078353825;46309.53690463094;9864.358816676911;10025;10100.696979090602;10108.646197383094;10116.241281903849;9887.505624718735;10043;10045.146162576153;10047.246456515753;10057.849132263022;9989;10158.96820635872;10162.796744065114;10170.542325595328;10175.643852465166;10071.949640251789;10140.29017968735;10142.290039697224;10156.035176658206;10158.796824063551;10006.49967501622;10130.189584833195;10139.340942838691;10142.695719128438;10161.847572286348;42507;42517.78741106306;42519.787401063106;42561.57438425607;43540;3309.5532103166006;3479.1476088358263;3589.569251689788;3862.5944275851193;4061;25588.97644094234;29067;29941.850290748625;30170.245743856358;30220.69779302201;2850.372917958046;2873.396586716792;2891.840948747818;2925.254060214653;2927.1218634409593;475536;481140;485534;487038;487817;50986;51045.489545104814;51052.23421648678;51169.97660046853;78850;50818.74590627023;50839.491605084215;50844.74577627088;51802;51894.22158667623;17721.645567088584;17813.643727125385;17933;17935.282588696566;17951.461456156336;14051.929740351234;14115.153090814583;14187.78718319226;14204.928975355264;14550.854491455162;16190;16496.83503164953;16502.66994660124;16537.421190258283;16573.66852662964;7113.359797618239;7170.964145179345;7199.316064973819;7238.819029524198;7252.963735181291;989.6882482018141;1066.4880857188593;1146.7935771561033;1149.350616901448;1179.2983175011027;30551.8472407641;31188;31454.056378308687;31649.36701265962;31758.841205794284;1252.5678640868887;1283.9679008024686;1285.993570032144;1303.1203937342445;1346.3873937358674;10849.837252441219;15935.521934341989;15992.600184995468;16267.918660406622;16320.918395408184;542931;546593;547508;547723;548269;64497;64698;64831.35168648253;64999;65063.024054639216;1425.4939496478808;1446.305773228856;1527.3661430506215;1535.1249787620948;1535.2016951185544;30154.84922575373;32566.511502327012;33301.50047749237;33365.499517506774;33751;60344;60967.085493718514;62334.68832655808;62560.06159907514;62737.68631156815;301730;396266;399431;399798;400378;38423.80788096042;46877;47188;47526.287105692754;48640.783980400774;46653.30020049634;46657;46876;48316;48377;37457.43813842849;37764.05589860275;38260.61739382682;38782.4182637255;39644;35654;36981.81509092437;39831.402528962666;39882.2023559533;41198;35463.11342216465;38252;40500.39249411202;40945.79527102345;41876.790616046725;32738.672613274513;33557.496637549964;34261.657383425845;34265.65734342724;34582.82708586441;26173.869130654224;26313.86843065849;26332.3416914571;26397.472050559267;26841 09:56:57 INFO - PROCESS | 7151 | |2;jquery.html;383.3865814696486;384.3216722484815;385.08926389089805;391.22537375995546;394.9190415964726;16541;21897.452563685914;22050.88974555127;22826.771732282672;22826.88586557069;21738.239161629346;21984.89007554964;22035.559288814213;22455.32634020982;22799.31602051937;5730.885382292373;5745.138229265613;5980.222571065756;5981.222441082653;6019.578629495937;5808.941910580882;5887.23465949426;5912.7930522431725;5913.2608423947;5931.258592675916;5638.661680299175;5815;5839.0949402842625;5858.238429004245;5863.824085277449;5820.679862607555;5883.088121341156;5905.114232865061;5908.143319218732;5914.4381283777975;5079.873003174913;5147.871303217412;5151.124308867502;5154.30416893722;5159.406668233126;26856.194314170607;26911.788969496418;27120.59319110215;27289.86355068232;27388.726112738816;2158.568286342738;2182.181681869299;2201.9779802202092;2290.576243394961;2304.873231972241;15003.32485038165;15425.537233883002;15653.608659783597;15803.762943555856;15841.366345346172;1788.4366424576347;1869.6073824496873;1871.2514994002372;1948.6784680527696;1950.2783969931074;96461.51769241178;100616.49691751495;102395.97604023939;103063;103164.48417757938;11247.381394023407;11323.60367387154;11529.654110376534;11593.24643898144;11704.70738231551;14306.213158276394;14343.139411635335;14367;14407.279636018156;14414.063085899383;8921.241694455914;8967.058458861857;8974.641014359484;9004.774880628036;9075.773105672411;9267.304952128483;9267.490288034223;9269.72190834276;9271.258299336037;9332.4867132307;4516.503184649686;4543.750093744876;4560.429946256718;4577.862664120082;4612.7001744886475;1900.5438694713168;1935.806419358081;1954.9218031278874;1964.646363654556;1992.1234656750983;953.4708236928572;977.1254727019278;1027.4992554353191;1126.6676330482528;1130.46867972053;20348.456442944633;20854.791452085286;21062;21118.683219751714;21175.894120529298;1030.2440970404139;1035.6012935020071;1059.592057058038;1084.8589683341115;1093.9398333091756;10244;11191.440427978569;11335.943320283512;11343.319400835977;11461.598844040418;586844;591304;625498;667566;668846;87084;101551.49224253831;106765.46617267019;108331.91668083219;109723.80552388908;896.4576431259125;1056.1920131099714;1058.2697938422464;1061.7451811565168;1083.7940791249637;17953.371631992817;18505.35231266899;18717;18755;18940.621187576446;51066.48933510618;51074.48925510697;51717;52629;54305;73196.63401683171;73438;74626.62686686532;75448.87544887484;76171;7869.213078692085;8233.17668233172;8256.380771442045;8273.627686753991;8298.958505207434;9450.810983780424;10388.613306079536;13096.803547946598;13305.135166214164;13371.197728136343;7235.2041275458605;10316.27786054969;11196.552137914718;11500.597479088192;11592.710182245512;9740.172085372822;10926.180536459638;11107.166962478008;11469;11786.233894796811;11433;11482.425878706199;11649.301041937171;11932.701682458008;12195.268283902995;7641.465097443125;8205.261526462407;8390.119037500974;8452;8576.656933722581;11496.850314968437;12133.939330303645;12260.816087758512;12333;12335.198212116184 09:56:57 INFO - PROCESS | 7151 | |3;mootools.html;1507.6984603079386;1620.7163746344388;1651.7852679151713;2003.8597298189134;2097.2974053692014;8377.58112094395;8608.483490990537;9013.909860901396;9237;9250.953745231282;9075.63697452101;9141.817163656722;9276.53617319133;9284.953575232114;9284.953575232114;2608.7782538484253;2639.2214296782495;2642.0712879597904;2643.70919198888;2644.9735502645017;2570.7686308232255;2640.5379058664753;2645.1667724666668;2645.616385624093;2645.933851653705;2624.3570325270334;2630.5265052290674;2659.494696007762;2659.7473240042164;2660.5344064788683;2172.2397160993683;2603.1669865643003;2630.079472184739;2649.1787545860843;2651.5890037044287;2594.4032872439257;2627.093652689819;2628.3691913940706;2646.087099950514;2659.1490722968656;9306.53467326631;9322.673706420243;9361;9367;9381.343305968585;5617.241672374259;5805.88388232233;5844.386339434341;5848.152017957373;5858.8242352729485;3447.482877568385;3674.6325367463305;3749.4750734897134;3820.732548721591;3825.062859599388;1079.13129930406;1092.3336764573603;1094.1465656787639;1122.7249323915612;1139.6865861887964;12046.518139274418;12374.319412432313;12593.622191334274;12601.36993150348;12658.923991460737;4402.8679139625865;4939.040053747508;5068.695878247317;5171.456997015334;5180.274761533388;10625.990530899553;10635.680929572125;10665.973465041618;10675.359478431319;10698.679039628823;5802.854928626733;5827.35899051104;5854;5862.384449632812;5888.998870192077;4683.063387322549;4807.278908163804;5061.746912654353;5269.71016594091;5292.782659988225;4099.441208877712;4105.055837157411;4132.194222126656;4182.937255941163;4211.957880421218;1359.4290398032651;1384.1694983010113;1385.0443194195973;1395.7836535336835;1397.2454874367727;1399.433229542037;1420.3821337718125;1438.8489208633152;1442.3004842651305;1457.5627311806627;7124.679389427488;8662.436941598777;8690.913090869137;8701.869471957925;8719.04090550039;540.2895192821427;549.1405949688724;551.5229326632434;557.0557904352165;558.020673717623;6406.23125224976;6423.13287706163;6460.709268082947;6466.5473416861305;6493.480521558264;11094.833577496343;11482.425878706032;11636.418179091012;11640.476178571984;11661.6501504955;11142.777144457228;11166.883311668767;11287.548498059985;11329.2069555132;11348.602798902164;8670.306375489945;8865.911340886638;8883.911160888438;8902.198802107841;8912.287017038621;8339.041010283894;8378.99452065756;8418.536980465888;8501.0223824261;8514.914850851412;9996.400215987063;10092.949535252277;10204.4387558685;10295.897041029793;10389.220808439548;10190.031946965026;10400.011998860096;10705.197110216921;10711.785764284516;10832.783344332911;7118.323759242864;7287.526310789782;7566.205548417337;7583.924160758322;7678.424118191047;8642.481451112953;8660.870086948828;8707.47755134694;8725;8726.345524085846;7536.057992750906;7583.355414789805;7655.69377224927;7692.076950765944;7750.612469376621;7431.182569917413;7512.849743005;7527.962360188383;7626.084869815658;7658.234176582298;8034.035915690155;8144.83710325802;8169.346452283922;8173.509589424416;8192.877106843283;7203.279672032755;7333.449991250571;7379.667914943948;7415.4809163360205;7421.2949769771785;7497.10034795828;7523.398128149625;7552.773416797505;7557.470977031555;7558.319751222416 09:56:57 INFO - PROCESS | 7151 | |4;prototype.html;337.58477073199964;341.8171278366073;349.50544978854913;349.5386090360725;353.5739433982052;5671.432856714332;6794.762183323584;6842.213145488264;6842.828929276777;6871.175458944921;6727.125473688414;6750;6753.257141714407;6760.121184246041;6776.424003959657;4745.288206768978;4867.975660121712;4871.098846713352;4997.60019198465;5051.595872330223;4955.727434991074;4960.2559616057515;4961.5286547777905;4980.7758650860615;5006.4492905780335;4956.330895329121;4978.751062446881;4980.1782705853675;4981.676191047589;4991.525805048533;4711.151992641323;4786.329913812069;4913.484084171182;4934.580560652349;4952.158133117378;4223.1975924574235;4243.87268381946;4248.808803603845;4253.532111467736;4271.658267338606;5448.964696707652;6514.77198298062;6517.315681853384;6526.738930442777;6550.7707230246715;5793.391693872125;5982.162497250389;5991.730372133265;6000.879982400371;6006.699665016776;7036.73338799016;7229.132504099489;7243.818904527429;7253.057102576631;7262.564246145248;4795.736234507101;4847.563719265283;4867.36724225852;4874.2201247800185;4878;7562.243775622449;7584.393248540158;7591.696332146707;7594.5822979736095;7597.734079307253;4902.583280421133;4918.286848407032;4924.162892308316;4925.7783399747095;4927.704337739676;5006.3992320921725;5007.774650140679;5015.874603134878;5020.196768517019;5027.773750181251;5985.790497332572;5986.431289027535;5994.1608174855555;6001.549883758736;6005.639661620229;7010.894836577456;7242.45681573884;7279.89080163798;7290.9635451822405;7355.52189107717;1724.7067998440295;1769.6814573376657;1769.955751106207;1771.76081229035;1775.5827380565556;1068.5031460370965;1118.2060736876747;1130.8756036835941;1131.5417256011328;1159.5042395310124;5593.636413633101;6526.41262286387;6669.7332106715185;6711.664416779142;6714.832129196711;7384.667689953965;7385.335319821134;7386.519876208029;7387.224341444178;7393.408527317802;6671;6697.09589205451;6700.631465269457;6728.966355168192;6736.865262694719;3789.5263092113487;3889.3776995680555;3924.5486769021927;3935.134270460494;3936.075022369741;7694.269044440769;7696.7306144284685;7700;7707.499012564277;7735.265149810759;6527.792358413613;7220.927790722026;7530.472866899265;7598.088229412506;7606.429517786189;7641.732539361095;7646.273604007611;7661.318538511477;7664.808379790438;7673.846523069507;7101.893471598033;7378.077740282465;7381.557106573623;7394.7781566553085;7403.777886663409;7183.568985860865;7257.927420725937;7280.708771649075;7289.817754556178;7290.890636640561;7644.961775191088;7645.120811106572;7665.19515450892;7667.243050905128;7674.501157424749;4968.056069346812;4979.551840334388;4984.252362145708;4986.12742770021;4991.301217829579;7111.7866464006165;7362.7423040193335;7366.889496657447;7383.372413344926;7389.667464963982;5647.322321321468;7076.221615622175;7131.8930216045765;7142.321479459443;7155.534890232118;7094.9290507094265;7105.82235444118;7117.074780278531;7118.715251389886;7133.357997780225;6924.688389022607;6936.479764017819;6945.617991010543;6947.201071876799;6959.338862808025;7030.472714546328;7047.471439641945;7153.177384600837;7312.0128782613665;7398.48331092114;6863.691133898887;7006.159260888726;7012.894806577803;7134.785956421316;7204.603746793977 09:56:57 INFO - PROCESS | 7151 | |5;yui.html;682.8736683713513;728.8979542864;789.0570767932323;795.6419611174971;804.7947773317804;15148.545543633694;15534.844651553482;15554;15568.84431155688;15578.376864925403;14514.983951123426;14575.979681422305;14581.416743330281;14597.905157113233;14607.415703371853;808.0949336742841;826.4751882554591;972.0668158567784;978.3054031637546;979.1677074486665;967.8741763570761;977.452626529146;977.7360112769584;978.7699890525721;999.7750506136098;1029.402946291153;1030.0986636692894;1030.7577719235974;1032.8863824979246;1049.7218237167158;860.849351363512;1040.1003132290589;1040.3705758016442;1041.0838462153333;1042.5256508288749;765.8544876473508;766.854297683444;768.0207735137689;773.2963003666637;781.5232708048086;15562.22188890551;15609.92195039029;15666.06003639774;15753.921230393775;15918.124503152321;12970.416331265022;13046.347682615831;13166.934165329112;13279.336033198302;13575.52485662997;10135.75202430665;10307.484625768757;10325.32885362449;10638.202134839841;11048.447577621168;3574.070741607175;3585;3612.0789198754414;3668.779873207616;3837.6354246346555;65099.02351464732;85164.57417712934;86959.13040869574;87626;87681.56159219227;9914.058164474363;9938.254630902711;9995.600175992879;9997.400155990665;10276.280660353854;23231.651525227135;23234.767652323597;23247.18634847772;23270;23313.533729325318;7423.183449820515;7481.7755467336065;7558.58427786466;7697.153313135551;7782.49413788102;4154.50145982484;4247.277962746341;4268.765217913045;4362.520122786491;4519.457665080211;3621.9818900905325;3697.279030589063;3698.4082546792383;3706.2772759311674;3711.2391959648207;580.3007376111775;634.4670476799511;654.4666097130823;706.7067167125688;713.710947066439;538.37548443805;583.4253260538367;596.5555661032558;606.3421188011057;653.3466533466534;7746.690132394754;8064.193580642006;8236.217559331853;8597.951122323042;8674.86987695185;553.9723013849291;576.7519966414399;602.340437221242;609.8261995331309;618.6999305336908;4007.338789099824;4042.15114825884;4068.5931406859077;4085.816138273785;4176.444851040136;95522;96197;99579;100858;101279.98720012853;80491.19508804836;81063;81569;81840.59079704563;84562;72426.63786681033;73198.26801732021;73699.63150184322;74468.62765686246;75159;7867.055953285642;7931.762047138595;8059;8151.5924203790755;8185.8772118419465;50663;50758.746206268734;50939;51888.740556298486;54728.45271547233;67400;73936;74324.25675743174;75333.24666753481;75448;11378.54485820591;11409;11473.655790326304;11761.41220935197;11842.881571184178;12338.198017128858;12402.317872516738;12598.937005314914;12642.683932901751;13123.081384303388;9104.863427048733;11852.70368240801;12055.483986937601;12397;12644.513707019543;11889.762204756029;12187.634370968884;12254.693632659255;12650;12680.809787853004;12230.694232644255;12568.497260109492;12594.496220151092;12611.621651350475;12665.683357916127;10252.43611601369;10348.896511035095;10350.689479315633;10396.116330112025;10620.946895265473;10363.533640986325;10385.63650272237;10396.116330112025;10400.323978941344;10424.374537527772 09:56:57 INFO - PROCESS | 7151 | __end_tp_report 09:56:57 INFO - PROCESS | 7151 | __start_cc_report 09:56:57 INFO - PROCESS | 7151 | _x_x_mozilla_cycle_collect,1104 09:56:57 INFO - PROCESS | 7151 | __end_cc_report 09:56:57 INFO - PROCESS | 7151 | __startTimestamp1462985817491__endTimestamp 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | ------- Summary: start ------- 09:56:57 INFO - PROCESS | 7151 | Number of tests: 6 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#0] dojo.html Cycles:165 Average:5975.28 Median:6243.91 stddev:655.03 (10.5%) stddev-sans-first:622.36 09:56:57 INFO - PROCESS | 7151 | Values: 3294.4 3627.9 3663.4 3675.7 3676.2 6002.9 6030.4 6050.0 6067.8 6068.8 6010.3 6055.6 6061.0 6067.4 6100.3 5169.1 5361.2 5384.2 5403.8 5433.5 5455.3 5474.6 5482.1 5482.7 5488.7 5411.6 5465.4 5474.5 5513.8 5523.4 5454.4 5477.5 5498.3 5500.3 5504.4 4304.4 5172.4 5407.5 5419.7 5429.4 5851.4 5867.1 5940.2 5944.4 5977.9 6261.8 6385.4 6390.3 6394.9 6399.4 6332.5 6408.9 6453.3 6494.6 6505.1 6193.4 6195.8 6198.1 6208.0 6212.7 6404.2 6496.9 6585.9 6592.4 6604.4 5166.9 6319.9 6323.8 6334.5 6337.8 6412.5 6434.3 6453.7 6467.2 6479.9 6268.4 6275.9 6292.6 6367.8 6383.1 6293.7 6295.1 6303.3 6309.9 6322.4 5138.0 5140.7 5151.2 5153.1 5173.7 4519.6 4598.4 4629.4 4650.3 4654.7 6123.3 6144.7 6168.0 6173.6 6180.0 6393.1 6471.1 6472.5 6473.6 6479.1 6012.1 6103.6 6151.5 6183.6 6192.2 5612.7 5615.2 5616.7 5618.0 5658.4 6594.1 6665.7 6666.9 6671.6 6682.2 6277.2 6425.6 6442.2 6476.4 6477.9 6660.1 6670.8 6690.9 6711.4 6719.5 5886.7 6230.3 6236.4 6397.6 6416.0 6216.7 6296.4 6309.4 6381.5 6381.5 6309.0 6324.5 6331.7 6337.1 6346.1 6243.9 6271.2 6291.4 6319.9 6324.6 6252.8 6259.0 6289.6 6311.0 6315.8 6274.2 6316.3 6326.7 6328.8 6343.6 6145.7 6218.8 6289.1 6313.2 6313.5 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#1] ext.html Cycles:180 Average:63001.90 Median:35558.56 stddev:126173.53 (354.8%) stddev-sans-first:126440.16 09:56:57 INFO - PROCESS | 7151 | Values: 481.7 578.3 587.8 666.0 673.1 32581.7 42083.4 42325.0 42335.0 42349.2 45000.8 45884.8 45890.5 46144.3 46309.5 9864.4 10025.0 10100.7 10108.6 10116.2 9887.5 10043.0 10045.1 10047.2 10057.8 9989.0 10159.0 10162.8 10170.5 10175.6 10071.9 10140.3 10142.3 10156.0 10158.8 10006.5 10130.2 10139.3 10142.7 10161.8 42507.0 42517.8 42519.8 42561.6 43540.0 3309.6 3479.1 3589.6 3862.6 4061.0 25589.0 29067.0 29941.9 30170.2 30220.7 2850.4 2873.4 2891.8 2925.3 2927.1 475536.0 481140.0 485534.0 487038.0 487817.0 50986.0 51045.5 51052.2 51170.0 78850.0 50818.7 50839.5 50844.7 51802.0 51894.2 17721.6 17813.6 17933.0 17935.3 17951.5 14051.9 14115.2 14187.8 14204.9 14550.9 16190.0 16496.8 16502.7 16537.4 16573.7 7113.4 7171.0 7199.3 7238.8 7253.0 989.7 1066.5 1146.8 1149.4 1179.3 30551.8 31188.0 31454.1 31649.4 31758.8 1252.6 1284.0 1286.0 1303.1 1346.4 10849.8 15935.5 15992.6 16267.9 16320.9 542931.0 546593.0 547508.0 547723.0 548269.0 64497.0 64698.0 64831.4 64999.0 65063.0 1425.5 1446.3 1527.4 1535.1 1535.2 30154.8 32566.5 33301.5 33365.5 33751.0 60344.0 60967.1 62334.7 62560.1 62737.7 301730.0 396266.0 399431.0 399798.0 400378.0 38423.8 46877.0 47188.0 47526.3 48640.8 46653.3 46657.0 46876.0 48316.0 48377.0 37457.4 37764.1 38260.6 38782.4 39644.0 35654.0 36981.8 39831.4 39882.2 41198.0 35463.1 38252.0 40500.4 40945.8 41876.8 32738.7 33557.5 34261.7 34265.7 34582.8 26173.9 26313.9 26332.3 26397.5 26841.0 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#2] jquery.html Cycles:180 Average:34881.43 Median:22253.11 stddev:103745.87 (466.2%) stddev-sans-first:104004.56 09:56:57 INFO - PROCESS | 7151 | Values: 383.4 384.3 385.1 391.2 394.9 16541.0 21897.5 22050.9 22826.8 22826.9 21738.2 21984.9 22035.6 22455.3 22799.3 5730.9 5745.1 5980.2 5981.2 6019.6 5808.9 5887.2 5912.8 5913.3 5931.3 5638.7 5815.0 5839.1 5858.2 5863.8 5820.7 5883.1 5905.1 5908.1 5914.4 5079.9 5147.9 5151.1 5154.3 5159.4 26856.2 26911.8 27120.6 27289.9 27388.7 2158.6 2182.2 2202.0 2290.6 2304.9 15003.3 15425.5 15653.6 15803.8 15841.4 1788.4 1869.6 1871.3 1948.7 1950.3 96461.5 100616.5 102396.0 103063.0 103164.5 11247.4 11323.6 11529.7 11593.2 11704.7 14306.2 14343.1 14367.0 14407.3 14414.1 8921.2 8967.1 8974.6 9004.8 9075.8 9267.3 9267.5 9269.7 9271.3 9332.5 4516.5 4543.8 4560.4 4577.9 4612.7 1900.5 1935.8 1954.9 1964.6 1992.1 953.5 977.1 1027.5 1126.7 1130.5 20348.5 20854.8 21062.0 21118.7 21175.9 1030.2 1035.6 1059.6 1084.9 1093.9 10244.0 11191.4 11335.9 11343.3 11461.6 586844.0 591304.0 625498.0 667566.0 668846.0 87084.0 101551.5 106765.5 108331.9 109723.8 896.5 1056.2 1058.3 1061.7 1083.8 17953.4 18505.4 18717.0 18755.0 18940.6 51066.5 51074.5 51717.0 52629.0 54305.0 73196.6 73438.0 74626.6 75448.9 76171.0 7869.2 8233.2 8256.4 8273.6 8299.0 9450.8 10388.6 13096.8 13305.1 13371.2 7235.2 10316.3 11196.6 11500.6 11592.7 9740.2 10926.2 11107.2 11469.0 11786.2 11433.0 11482.4 11649.3 11932.7 12195.3 7641.5 8205.3 8390.1 8452.0 8576.7 11496.9 12133.9 12260.8 12333.0 12335.2 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#3] mootools.html Cycles:180 Average:6371.36 Median:5175.87 stddev:3386.61 (65.4%) stddev-sans-first:3376.38 09:56:57 INFO - PROCESS | 7151 | Values: 1507.7 1620.7 1651.8 2003.9 2097.3 8377.6 8608.5 9013.9 9237.0 9251.0 9075.6 9141.8 9276.5 9285.0 9285.0 2608.8 2639.2 2642.1 2643.7 2645.0 2570.8 2640.5 2645.2 2645.6 2645.9 2624.4 2630.5 2659.5 2659.7 2660.5 2172.2 2603.2 2630.1 2649.2 2651.6 2594.4 2627.1 2628.4 2646.1 2659.1 9306.5 9322.7 9361.0 9367.0 9381.3 5617.2 5805.9 5844.4 5848.2 5858.8 3447.5 3674.6 3749.5 3820.7 3825.1 1079.1 1092.3 1094.1 1122.7 1139.7 12046.5 12374.3 12593.6 12601.4 12658.9 4402.9 4939.0 5068.7 5171.5 5180.3 10626.0 10635.7 10666.0 10675.4 10698.7 5802.9 5827.4 5854.0 5862.4 5889.0 4683.1 4807.3 5061.7 5269.7 5292.8 4099.4 4105.1 4132.2 4182.9 4212.0 1359.4 1384.2 1385.0 1395.8 1397.2 1399.4 1420.4 1438.8 1442.3 1457.6 7124.7 8662.4 8690.9 8701.9 8719.0 540.3 549.1 551.5 557.1 558.0 6406.2 6423.1 6460.7 6466.5 6493.5 11094.8 11482.4 11636.4 11640.5 11661.7 11142.8 11166.9 11287.5 11329.2 11348.6 8670.3 8865.9 8883.9 8902.2 8912.3 8339.0 8379.0 8418.5 8501.0 8514.9 9996.4 10092.9 10204.4 10295.9 10389.2 10190.0 10400.0 10705.2 10711.8 10832.8 7118.3 7287.5 7566.2 7583.9 7678.4 8642.5 8660.9 8707.5 8725.0 8726.3 7536.1 7583.4 7655.7 7692.1 7750.6 7431.2 7512.8 7528.0 7626.1 7658.2 8034.0 8144.8 8169.3 8173.5 8192.9 7203.3 7333.4 7379.7 7415.5 7421.3 7497.1 7523.4 7552.8 7557.5 7558.3 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#4] prototype.html Cycles:180 Average:5900.01 Median:6720.98 stddev:1837.31 (27.3%) stddev-sans-first:1794.40 09:56:57 INFO - PROCESS | 7151 | Values: 337.6 341.8 349.5 349.5 353.6 5671.4 6794.8 6842.2 6842.8 6871.2 6727.1 6750.0 6753.3 6760.1 6776.4 4745.3 4868.0 4871.1 4997.6 5051.6 4955.7 4960.3 4961.5 4980.8 5006.4 4956.3 4978.8 4980.2 4981.7 4991.5 4711.2 4786.3 4913.5 4934.6 4952.2 4223.2 4243.9 4248.8 4253.5 4271.7 5449.0 6514.8 6517.3 6526.7 6550.8 5793.4 5982.2 5991.7 6000.9 6006.7 7036.7 7229.1 7243.8 7253.1 7262.6 4795.7 4847.6 4867.4 4874.2 4878.0 7562.2 7584.4 7591.7 7594.6 7597.7 4902.6 4918.3 4924.2 4925.8 4927.7 5006.4 5007.8 5015.9 5020.2 5027.8 5985.8 5986.4 5994.2 6001.5 6005.6 7010.9 7242.5 7279.9 7291.0 7355.5 1724.7 1769.7 1770.0 1771.8 1775.6 1068.5 1118.2 1130.9 1131.5 1159.5 5593.6 6526.4 6669.7 6711.7 6714.8 7384.7 7385.3 7386.5 7387.2 7393.4 6671.0 6697.1 6700.6 6729.0 6736.9 3789.5 3889.4 3924.5 3935.1 3936.1 7694.3 7696.7 7700.0 7707.5 7735.3 6527.8 7220.9 7530.5 7598.1 7606.4 7641.7 7646.3 7661.3 7664.8 7673.8 7101.9 7378.1 7381.6 7394.8 7403.8 7183.6 7257.9 7280.7 7289.8 7290.9 7645.0 7645.1 7665.2 7667.2 7674.5 4968.1 4979.6 4984.3 4986.1 4991.3 7111.8 7362.7 7366.9 7383.4 7389.7 5647.3 7076.2 7131.9 7142.3 7155.5 7094.9 7105.8 7117.1 7118.7 7133.4 6924.7 6936.5 6945.6 6947.2 6959.3 7030.5 7047.5 7153.2 7312.0 7398.5 6863.7 7006.2 7012.9 7134.8 7204.6 09:56:57 INFO - PROCESS | 7151 | 09:56:57 INFO - PROCESS | 7151 | [#5] yui.html Cycles:180 Average:19252.78 Median:4165.47 stddev:27127.48 (651.2%) stddev-sans-first:27167.74 09:56:57 INFO - PROCESS | 7151 | Values: 682.9 728.9 789.1 795.6 804.8 15148.5 15534.8 15554.0 15568.8 15578.4 14515.0 14576.0 14581.4 14597.9 14607.4 808.1 826.5 972.1 978.3 979.2 967.9 977.5 977.7 978.8 999.8 1029.4 1030.1 1030.8 1032.9 1049.7 860.8 1040.1 1040.4 1041.1 1042.5 765.9 766.9 768.0 773.3 781.5 15562.2 15609.9 15666.1 15753.9 15918.1 12970.4 13046.3 13166.9 13279.3 13575.5 10135.8 10307.5 10325.3 10638.2 11048.4 3574.1 3585.0 3612.1 3668.8 3837.6 65099.0 85164.6 86959.1 87626.0 87681.6 9914.1 9938.3 9995.6 9997.4 10276.3 23231.7 23234.8 23247.2 23270.0 23313.5 7423.2 7481.8 7558.6 7697.2 7782.5 4154.5 4247.3 4268.8 4362.5 4519.5 3622.0 3697.3 3698.4 3706.3 3711.2 580.3 634.5 654.5 706.7 713.7 538.4 583.4 596.6 606.3 653.3 7746.7 8064.2 8236.2 8598.0 8674.9 554.0 576.8 602.3 609.8 618.7 4007.3 4042.2 4068.6 4085.8 4176.4 95522.0 96197.0 99579.0 100858.0 101280.0 80491.2 81063.0 81569.0 81840.6 84562.0 72426.6 73198.3 73699.6 74468.6 75159.0 7867.1 7931.8 8059.0 8151.6 8185.9 50663.0 50758.7 50939.0 51888.7 54728.5 67400.0 73936.0 74324.3 75333.2 75448.0 11378.5 11409.0 11473.7 11761.4 11842.9 12338.2 12402.3 12598.9 12642.7 13123.1 9104.9 11852.7 12055.5 12397.0 12644.5 11889.8 12187.6 12254.7 12650.0 12680.8 12230.7 12568.5 12594.5 12611.6 12665.7 10252.4 10348.9 10350.7 10396.1 10620.9 10363.5 10385.6 10396.1 10400.3 10424.4 09:56:57 INFO - PROCESS | 7151 | -------- Summary: end -------- 09:56:57 INFO - PROCESS | 7151 | 09:56:58 INFO - TEST-INFO | 7151: exit 0 09:56:58 INFO - TEST-OK | dromaeo_css | took 1112366ms 09:56:58 INFO - TEST-START | kraken 09:56:58 INFO - operating with platform_type : mac_ 09:56:58 INFO - Initialising browser for kraken test... 09:56:58 INFO - TEST-INFO | started process 7156 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpNDFg9K/profile http://localhost:63765/getInfo.html) 09:57:00 INFO - PROCESS | 7156 | __metrics Screen width/height:1600/1200 09:57:00 INFO - PROCESS | 7156 | colorDepth:24 09:57:00 INFO - PROCESS | 7156 | Browser inner width/height: 1024/689 09:57:00 INFO - PROCESS | 7156 | __metrics 09:57:00 INFO - PROCESS | 7156 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:00 INFO - PROCESS | 7156 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:00 INFO - TEST-INFO | 7156: exit 0 09:57:00 INFO - Browser initialized. 09:57:00 INFO - Running cycle 1/1 for kraken test... 09:57:00 INFO - TEST-INFO | started process 7160 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpNDFg9K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:12 INFO - PROCESS | 7160 | RSS: Main: 156938240 09:57:12 INFO - PROCESS | 7160 | 09:57:15 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63765/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:15 INFO - PROCESS | 7160 | RSS: Main: 212578304 09:57:15 INFO - PROCESS | 7160 | 09:57:18 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63765/tests/kraken/driver.html?testName=audio-dft) 09:57:18 INFO - PROCESS | 7160 | RSS: Main: 223358976 09:57:18 INFO - PROCESS | 7160 | 09:57:22 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63765/tests/kraken/driver.html?testName=audio-fft) 09:57:22 INFO - PROCESS | 7160 | RSS: Main: 213688320 09:57:22 INFO - PROCESS | 7160 | 09:57:24 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63765/tests/kraken/driver.html?testName=audio-oscillator) 09:57:25 INFO - PROCESS | 7160 | RSS: Main: 214740992 09:57:25 INFO - PROCESS | 7160 | 09:57:27 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:27 INFO - PROCESS | 7160 | RSS: Main: 215740416 09:57:27 INFO - PROCESS | 7160 | 09:57:30 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63765/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:31 INFO - PROCESS | 7160 | RSS: Main: 217088000 09:57:31 INFO - PROCESS | 7160 | 09:57:34 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63765/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:34 INFO - PROCESS | 7160 | RSS: Main: 215740416 09:57:34 INFO - PROCESS | 7160 | 09:57:37 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63765/tests/kraken/driver.html?testName=json-parse-financial) 09:57:37 INFO - PROCESS | 7160 | RSS: Main: 216059904 09:57:37 INFO - PROCESS | 7160 | 09:57:39 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:40 INFO - PROCESS | 7160 | RSS: Main: 249950208 09:57:40 INFO - PROCESS | 7160 | 09:57:41 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:42 INFO - PROCESS | 7160 | RSS: Main: 249761792 09:57:42 INFO - PROCESS | 7160 | 09:57:44 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:45 INFO - PROCESS | 7160 | RSS: Main: 254738432 09:57:45 INFO - PROCESS | 7160 | 09:57:47 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:48 INFO - PROCESS | 7160 | RSS: Main: 256356352 09:57:48 INFO - PROCESS | 7160 | 09:57:50 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:51 INFO - PROCESS | 7160 | RSS: Main: 256208896 09:57:51 INFO - PROCESS | 7160 | 09:57:52 INFO - PROCESS | 7160 | Cycle 1(1): loaded http://localhost:63765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63765/tests/kraken/driver.html?testName=ai-astar) 09:57:53 INFO - PROCESS | 7160 | RSS: Main: 319647744 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | __start_tp_report 09:57:53 INFO - PROCESS | 7160 | _x_x_mozilla_page_load 09:57:53 INFO - PROCESS | 7160 | _x_x_mozilla_page_load_details 09:57:53 INFO - PROCESS | 7160 | |i|pagename|runs| 09:57:53 INFO - PROCESS | 7160 | |0;ai-astar;112;107;110;110;112;111;121;111;110;110 09:57:53 INFO - PROCESS | 7160 | |1;audio-beat-detection;157;118;146;155;117;139;117;151;149;118 09:57:53 INFO - PROCESS | 7160 | |2;audio-dft;183;186;186;247;256;184;186;186;185;184 09:57:53 INFO - PROCESS | 7160 | |3;audio-fft;76;72;77;118;55;59;56;59;127;56 09:57:53 INFO - PROCESS | 7160 | |4;audio-oscillator;91;93;128;78;79;85;119;75;78;121 09:57:53 INFO - PROCESS | 7160 | |5;imaging-gaussian-blur;89;87;89;86;89;85;90;87;89;85 09:57:53 INFO - PROCESS | 7160 | |6;imaging-darkroom;94;96;94;95;95;101;95;95;94;94 09:57:53 INFO - PROCESS | 7160 | |7;imaging-desaturate;87;87;87;84;85;85;87;85;86;85 09:57:53 INFO - PROCESS | 7160 | |8;json-parse-financial;53;58;55;57;57;56;57;56;53;53 09:57:53 INFO - PROCESS | 7160 | |9;json-stringify-tinderbox;61;63;69;69;77;74;68;67;68;68 09:57:53 INFO - PROCESS | 7160 | |10;stanford-crypto-aes;82;81;81;80;79;79;79;75;77;84 09:57:53 INFO - PROCESS | 7160 | |11;stanford-crypto-ccm;129;127;129;117;119;114;116;116;117;127 09:57:53 INFO - PROCESS | 7160 | |12;stanford-crypto-pbkdf2;154;130;134;134;133;122;134;135;131;133 09:57:53 INFO - PROCESS | 7160 | |13;stanford-crypto-sha256-iterative;68;65;68;64;65;65;64;67;64;63 09:57:53 INFO - PROCESS | 7160 | __end_tp_report 09:57:53 INFO - PROCESS | 7160 | __start_cc_report 09:57:53 INFO - PROCESS | 7160 | _x_x_mozilla_cycle_collect,1164 09:57:53 INFO - PROCESS | 7160 | __end_cc_report 09:57:53 INFO - PROCESS | 7160 | __startTimestamp1462985873067__endTimestamp 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | ------- Summary: start ------- 09:57:53 INFO - PROCESS | 7160 | Number of tests: 14 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.66 (3.3%) stddev-sans-first:3.87 09:57:53 INFO - PROCESS | 7160 | Values: 112.0 107.0 110.0 110.0 112.0 111.0 121.0 111.0 110.0 110.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:147.50 stddev:17.22 (11.7%) stddev-sans-first:16.63 09:57:53 INFO - PROCESS | 7160 | Values: 157.0 118.0 146.0 155.0 117.0 139.0 117.0 151.0 149.0 118.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#2] audio-dft Cycles:10 Average:198.30 Median:186.00 stddev:28.14 (15.1%) stddev-sans-first:29.30 09:57:53 INFO - PROCESS | 7160 | Values: 183.0 186.0 186.0 247.0 256.0 184.0 186.0 186.0 185.0 184.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#3] audio-fft Cycles:10 Average:75.50 Median:59.00 stddev:26.24 (44.5%) stddev-sans-first:27.83 09:57:53 INFO - PROCESS | 7160 | Values: 76.0 72.0 77.0 118.0 55.0 59.0 56.0 59.0 127.0 56.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:78.50 stddev:20.26 (25.8%) stddev-sans-first:21.44 09:57:53 INFO - PROCESS | 7160 | Values: 91.0 93.0 128.0 78.0 79.0 85.0 119.0 75.0 78.0 121.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:89.00 stddev:1.84 (2.1%) stddev-sans-first:1.88 09:57:53 INFO - PROCESS | 7160 | Values: 89.0 87.0 89.0 86.0 89.0 85.0 90.0 87.0 89.0 85.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:2.11 (2.2%) stddev-sans-first:2.19 09:57:53 INFO - PROCESS | 7160 | Values: 94.0 96.0 94.0 95.0 95.0 101.0 95.0 95.0 94.0 94.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.50 stddev:1.14 (1.3%) stddev-sans-first:1.12 09:57:53 INFO - PROCESS | 7160 | Values: 87.0 87.0 87.0 84.0 85.0 85.0 87.0 85.0 86.0 85.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:1.90 (3.4%) stddev-sans-first:1.79 09:57:53 INFO - PROCESS | 7160 | Values: 53.0 58.0 55.0 57.0 57.0 56.0 57.0 56.0 53.0 53.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:4.62 (6.7%) stddev-sans-first:4.06 09:57:53 INFO - PROCESS | 7160 | Values: 61.0 63.0 69.0 69.0 77.0 74.0 68.0 67.0 68.0 68.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.50 stddev:2.54 (3.2%) stddev-sans-first:2.55 09:57:53 INFO - PROCESS | 7160 | Values: 82.0 81.0 81.0 80.0 79.0 79.0 79.0 75.0 77.0 84.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:6.10 (5.0%) stddev-sans-first:5.76 09:57:53 INFO - PROCESS | 7160 | Values: 129.0 127.0 129.0 117.0 119.0 114.0 116.0 116.0 117.0 127.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.00 Median:134.00 stddev:7.97 (5.9%) stddev-sans-first:3.99 09:57:53 INFO - PROCESS | 7160 | Values: 154.0 130.0 134.0 134.0 133.0 122.0 134.0 135.0 131.0 133.0 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - PROCESS | 7160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.58 09:57:53 INFO - PROCESS | 7160 | Values: 68.0 65.0 68.0 64.0 65.0 65.0 64.0 67.0 64.0 63.0 09:57:53 INFO - PROCESS | 7160 | -------- Summary: end -------- 09:57:53 INFO - PROCESS | 7160 | 09:57:53 INFO - TEST-INFO | 7160: exit 0 09:57:53 INFO - TEST-OK | kraken | took 55753ms 09:57:53 INFO - SUITE-END | took 1168s 09:57:54 INFO - Completed test suite (00:19:28) 09:57:54 INFO - javascript benchmark 09:57:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3294.357600267948, 3627.947895110418, 3663.358912190366, 3675.6875665568427, 3676.246369494254, 6002.879942401155, 6030.427109424603, 6049.969750151254, 6067.848303792407, 6068.848278793027, 6010.308814486335, 6055.5761096723245, 6061.0, 6067.362926892668, 6100.2679678438535, 5169.121249387613, 5361.195820626898, 5384.1923711443205, 5403.78384864606, 5433.4566543345545, 5455.263539422187, 5474.616776825604, 5482.095454250044, 5482.698451585161, 5488.725563721818, 5411.594130440233, 5465.398806131322, 5474.452554744534, 5513.751881165357, 5523.420040895709, 5454.400015998237, 5477.5070243677865, 5498.257735205756, 5500.257465242221, 5504.366997795225, 4304.397384366192, 5172.431032586413, 5407.459254074601, 5419.701916394597, 5429.4027656957705, 5851.356350801409, 5867.14926335679, 5940.198073260098, 5944.375840536724, 5977.91033134499, 6261.812145635638, 6385.361463853624, 6390.329015453403, 6394.9360506394805, 6399.36006399361, 6332.493400527993, 6408.871822563523, 6453.257875344349, 6494.642794646293, 6505.0892874997535, 6193.4425901669065, 6195.783147589813, 6198.070289456573, 6208.0, 6212.689365531705, 6404.199475065617, 6496.935030649727, 6585.86828263432, 6592.406683398422, 6604.438622717123, 5166.896662066738, 6319.9368006320265, 6323.810285691437, 6334.461570766536, 6337.809865704036, 6412.5190610704385, 6434.292227854932, 6453.741850325934, 6467.191601049869, 6479.870402591921, 6268.435840774352, 6275.874482510416, 6292.622442653455, 6367.808965731036, 6383.106365108889, 6293.685315734195, 6295.087212354183, 6303.2751233607805, 6309.905351419732, 6322.430981211713, 5138.04946084968, 5140.717260550631, 5151.201563757623, 5153.123968925292, 5173.741312934339, 4519.593236608721, 4598.356230127785, 4629.421322334708, 4650.255959046536, 4654.743989080565, 6123.326434092246, 6144.678894037804, 6168.0439531872635, 6173.56785025044, 6179.969100154471, 6393.1369265148605, 6471.061696054046, 6472.514561407913, 6473.643949582818, 6479.060536222221, 6012.098185272157, 6103.6032657877095, 6151.5386346024225, 6183.5671502994355, 6192.195014648067, 5612.747426365823, 5615.241942337814, 5616.66300022, 5618.0, 5658.434156584309, 6594.10979517759, 6665.733370665119, 6666.866662666816, 6671.566348187353, 6682.231543372477, 6277.18396608438, 6425.5502114851515, 6442.226932768098, 6476.417122459001, 6477.8704425912165, 6660.134182556237, 6670.799876003728, 6690.933090669226, 6711.395974362331, 6719.496037797087, 5886.735096920564, 6230.283517395557, 6236.438720515175, 6397.648129352744, 6416.037594360883, 6216.689165541615, 6296.433321001132, 6309.432151106423, 6381.457576106083, 6381.521385895983, 6308.968455157695, 6324.494040476843, 6331.683415829098, 6337.144485494584, 6346.1432706585865, 6243.906341404791, 6271.153394291895, 6291.370862913672, 6319.936800631935, 6324.557280990287, 6252.812415627538, 6259.0, 6289.559730818799, 6310.968445157745, 6315.810525684236, 6274.247090349005, 6316.305206427382, 6326.715297811702, 6328.841778955379, 6343.55595108338, 6145.67867908384, 6218.81343559694, 6289.119523266655, 6313.210848643919, 6313.463355614824], "unit": "score", "name": "dojo.html", "value": 5934.501286389586}, {"lowerIsBetter": false, "replicates": [481.72060205081056, 578.3204734437036, 587.8030859662013, 665.9966700166499, 673.111492829465, 32581.67418325816, 42083.36874946875, 42325.0, 42335.0, 42349.15301693964, 45000.77499612505, 45884.77057614716, 45890.54109458905, 46144.3078353825, 46309.53690463094, 9864.358816676911, 10025.0, 10100.696979090602, 10108.646197383094, 10116.241281903849, 9887.505624718735, 10043.0, 10045.146162576153, 10047.246456515753, 10057.849132263022, 9989.0, 10158.96820635872, 10162.796744065114, 10170.542325595328, 10175.643852465166, 10071.949640251789, 10140.29017968735, 10142.290039697224, 10156.035176658206, 10158.796824063551, 10006.49967501622, 10130.189584833195, 10139.340942838691, 10142.695719128438, 10161.847572286348, 42507.0, 42517.78741106306, 42519.787401063106, 42561.57438425607, 43540.0, 3309.5532103166006, 3479.1476088358263, 3589.569251689788, 3862.5944275851193, 4061.0, 25588.97644094234, 29067.0, 29941.850290748625, 30170.245743856358, 30220.69779302201, 2850.372917958046, 2873.396586716792, 2891.840948747818, 2925.254060214653, 2927.1218634409593, 475536.0, 481140.0, 485534.0, 487038.0, 487817.0, 50986.0, 51045.489545104814, 51052.23421648678, 51169.97660046853, 78850.0, 50818.74590627023, 50839.491605084215, 50844.74577627088, 51802.0, 51894.22158667623, 17721.645567088584, 17813.643727125385, 17933.0, 17935.282588696566, 17951.461456156336, 14051.929740351234, 14115.153090814583, 14187.78718319226, 14204.928975355264, 14550.854491455162, 16190.0, 16496.83503164953, 16502.66994660124, 16537.421190258283, 16573.66852662964, 7113.359797618239, 7170.964145179345, 7199.316064973819, 7238.819029524198, 7252.963735181291, 989.6882482018141, 1066.4880857188593, 1146.7935771561033, 1149.350616901448, 1179.2983175011027, 30551.8472407641, 31188.0, 31454.056378308687, 31649.36701265962, 31758.841205794284, 1252.5678640868887, 1283.9679008024686, 1285.993570032144, 1303.1203937342445, 1346.3873937358674, 10849.837252441219, 15935.521934341989, 15992.600184995468, 16267.918660406622, 16320.918395408184, 542931.0, 546593.0, 547508.0, 547723.0, 548269.0, 64497.0, 64698.0, 64831.35168648253, 64999.0, 65063.024054639216, 1425.4939496478808, 1446.305773228856, 1527.3661430506215, 1535.1249787620948, 1535.2016951185544, 30154.84922575373, 32566.511502327012, 33301.50047749237, 33365.499517506774, 33751.0, 60344.0, 60967.085493718514, 62334.68832655808, 62560.06159907514, 62737.68631156815, 301730.0, 396266.0, 399431.0, 399798.0, 400378.0, 38423.80788096042, 46877.0, 47188.0, 47526.287105692754, 48640.783980400774, 46653.30020049634, 46657.0, 46876.0, 48316.0, 48377.0, 37457.43813842849, 37764.05589860275, 38260.61739382682, 38782.4182637255, 39644.0, 35654.0, 36981.81509092437, 39831.402528962666, 39882.2023559533, 41198.0, 35463.11342216465, 38252.0, 40500.39249411202, 40945.79527102345, 41876.790616046725, 32738.672613274513, 33557.496637549964, 34261.657383425845, 34265.65734342724, 34582.82708586441, 26173.869130654224, 26313.86843065849, 26332.3416914571, 26397.472050559267, 26841.0], "unit": "score", "name": "ext.html", "value": 20601.140357981443}, {"lowerIsBetter": false, "replicates": [383.3865814696486, 384.3216722484815, 385.08926389089805, 391.22537375995546, 394.9190415964726, 16541.0, 21897.452563685914, 22050.88974555127, 22826.771732282672, 22826.88586557069, 21738.239161629346, 21984.89007554964, 22035.559288814213, 22455.32634020982, 22799.31602051937, 5730.885382292373, 5745.138229265613, 5980.222571065756, 5981.222441082653, 6019.578629495937, 5808.941910580882, 5887.23465949426, 5912.7930522431725, 5913.2608423947, 5931.258592675916, 5638.661680299175, 5815.0, 5839.0949402842625, 5858.238429004245, 5863.824085277449, 5820.679862607555, 5883.088121341156, 5905.114232865061, 5908.143319218732, 5914.4381283777975, 5079.873003174913, 5147.871303217412, 5151.124308867502, 5154.30416893722, 5159.406668233126, 26856.194314170607, 26911.788969496418, 27120.59319110215, 27289.86355068232, 27388.726112738816, 2158.568286342738, 2182.181681869299, 2201.9779802202092, 2290.576243394961, 2304.873231972241, 15003.32485038165, 15425.537233883002, 15653.608659783597, 15803.762943555856, 15841.366345346172, 1788.4366424576347, 1869.6073824496873, 1871.2514994002372, 1948.6784680527696, 1950.2783969931074, 96461.51769241178, 100616.49691751495, 102395.97604023939, 103063.0, 103164.48417757938, 11247.381394023407, 11323.60367387154, 11529.654110376534, 11593.24643898144, 11704.70738231551, 14306.213158276394, 14343.139411635335, 14367.0, 14407.279636018156, 14414.063085899383, 8921.241694455914, 8967.058458861857, 8974.641014359484, 9004.774880628036, 9075.773105672411, 9267.304952128483, 9267.490288034223, 9269.72190834276, 9271.258299336037, 9332.4867132307, 4516.503184649686, 4543.750093744876, 4560.429946256718, 4577.862664120082, 4612.7001744886475, 1900.5438694713168, 1935.806419358081, 1954.9218031278874, 1964.646363654556, 1992.1234656750983, 953.4708236928572, 977.1254727019278, 1027.4992554353191, 1126.6676330482528, 1130.46867972053, 20348.456442944633, 20854.791452085286, 21062.0, 21118.683219751714, 21175.894120529298, 1030.2440970404139, 1035.6012935020071, 1059.592057058038, 1084.8589683341115, 1093.9398333091756, 10244.0, 11191.440427978569, 11335.943320283512, 11343.319400835977, 11461.598844040418, 586844.0, 591304.0, 625498.0, 667566.0, 668846.0, 87084.0, 101551.49224253831, 106765.46617267019, 108331.91668083219, 109723.80552388908, 896.4576431259125, 1056.1920131099714, 1058.2697938422464, 1061.7451811565168, 1083.7940791249637, 17953.371631992817, 18505.35231266899, 18717.0, 18755.0, 18940.621187576446, 51066.48933510618, 51074.48925510697, 51717.0, 52629.0, 54305.0, 73196.63401683171, 73438.0, 74626.62686686532, 75448.87544887484, 76171.0, 7869.213078692085, 8233.17668233172, 8256.380771442045, 8273.627686753991, 8298.958505207434, 9450.810983780424, 10388.613306079536, 13096.803547946598, 13305.135166214164, 13371.197728136343, 7235.2041275458605, 10316.27786054969, 11196.552137914718, 11500.597479088192, 11592.710182245512, 9740.172085372822, 10926.180536459638, 11107.166962478008, 11469.0, 11786.233894796811, 11433.0, 11482.425878706199, 11649.301041937171, 11932.701682458008, 12195.268283902995, 7641.465097443125, 8205.261526462407, 8390.119037500974, 8452.0, 8576.656933722581, 11496.850314968437, 12133.939330303645, 12260.816087758512, 12333.0, 12335.198212116184], "unit": "score", "name": "jquery.html", "value": 9746.260245687721}, {"lowerIsBetter": false, "replicates": [1507.6984603079386, 1620.7163746344388, 1651.7852679151713, 2003.8597298189134, 2097.2974053692014, 8377.58112094395, 8608.483490990537, 9013.909860901396, 9237.0, 9250.953745231282, 9075.63697452101, 9141.817163656722, 9276.53617319133, 9284.953575232114, 9284.953575232114, 2608.7782538484253, 2639.2214296782495, 2642.0712879597904, 2643.70919198888, 2644.9735502645017, 2570.7686308232255, 2640.5379058664753, 2645.1667724666668, 2645.616385624093, 2645.933851653705, 2624.3570325270334, 2630.5265052290674, 2659.494696007762, 2659.7473240042164, 2660.5344064788683, 2172.2397160993683, 2603.1669865643003, 2630.079472184739, 2649.1787545860843, 2651.5890037044287, 2594.4032872439257, 2627.093652689819, 2628.3691913940706, 2646.087099950514, 2659.1490722968656, 9306.53467326631, 9322.673706420243, 9361.0, 9367.0, 9381.343305968585, 5617.241672374259, 5805.88388232233, 5844.386339434341, 5848.152017957373, 5858.8242352729485, 3447.482877568385, 3674.6325367463305, 3749.4750734897134, 3820.732548721591, 3825.062859599388, 1079.13129930406, 1092.3336764573603, 1094.1465656787639, 1122.7249323915612, 1139.6865861887964, 12046.518139274418, 12374.319412432313, 12593.622191334274, 12601.36993150348, 12658.923991460737, 4402.8679139625865, 4939.040053747508, 5068.695878247317, 5171.456997015334, 5180.274761533388, 10625.990530899553, 10635.680929572125, 10665.973465041618, 10675.359478431319, 10698.679039628823, 5802.854928626733, 5827.35899051104, 5854.0, 5862.384449632812, 5888.998870192077, 4683.063387322549, 4807.278908163804, 5061.746912654353, 5269.71016594091, 5292.782659988225, 4099.441208877712, 4105.055837157411, 4132.194222126656, 4182.937255941163, 4211.957880421218, 1359.4290398032651, 1384.1694983010113, 1385.0443194195973, 1395.7836535336835, 1397.2454874367727, 1399.433229542037, 1420.3821337718125, 1438.8489208633152, 1442.3004842651305, 1457.5627311806627, 7124.679389427488, 8662.436941598777, 8690.913090869137, 8701.869471957925, 8719.04090550039, 540.2895192821427, 549.1405949688724, 551.5229326632434, 557.0557904352165, 558.020673717623, 6406.23125224976, 6423.13287706163, 6460.709268082947, 6466.5473416861305, 6493.480521558264, 11094.833577496343, 11482.425878706032, 11636.418179091012, 11640.476178571984, 11661.6501504955, 11142.777144457228, 11166.883311668767, 11287.548498059985, 11329.2069555132, 11348.602798902164, 8670.306375489945, 8865.911340886638, 8883.911160888438, 8902.198802107841, 8912.287017038621, 8339.041010283894, 8378.99452065756, 8418.536980465888, 8501.0223824261, 8514.914850851412, 9996.400215987063, 10092.949535252277, 10204.4387558685, 10295.897041029793, 10389.220808439548, 10190.031946965026, 10400.011998860096, 10705.197110216921, 10711.785764284516, 10832.783344332911, 7118.323759242864, 7287.526310789782, 7566.205548417337, 7583.924160758322, 7678.424118191047, 8642.481451112953, 8660.870086948828, 8707.47755134694, 8725.0, 8726.345524085846, 7536.057992750906, 7583.355414789805, 7655.69377224927, 7692.076950765944, 7750.612469376621, 7431.182569917413, 7512.849743005, 7527.962360188383, 7626.084869815658, 7658.234176582298, 8034.035915690155, 8144.83710325802, 8169.346452283922, 8173.509589424416, 8192.877106843283, 7203.279672032755, 7333.449991250571, 7379.667914943948, 7415.4809163360205, 7421.2949769771785, 7497.10034795828, 7523.398128149625, 7552.773416797505, 7557.470977031555, 7558.319751222416], "unit": "score", "name": "mootools.html", "value": 5114.819635189757}, {"lowerIsBetter": false, "replicates": [337.58477073199964, 341.8171278366073, 349.50544978854913, 349.5386090360725, 353.5739433982052, 5671.432856714332, 6794.762183323584, 6842.213145488264, 6842.828929276777, 6871.175458944921, 6727.125473688414, 6750.0, 6753.257141714407, 6760.121184246041, 6776.424003959657, 4745.288206768978, 4867.975660121712, 4871.098846713352, 4997.60019198465, 5051.595872330223, 4955.727434991074, 4960.2559616057515, 4961.5286547777905, 4980.7758650860615, 5006.4492905780335, 4956.330895329121, 4978.751062446881, 4980.1782705853675, 4981.676191047589, 4991.525805048533, 4711.151992641323, 4786.329913812069, 4913.484084171182, 4934.580560652349, 4952.158133117378, 4223.1975924574235, 4243.87268381946, 4248.808803603845, 4253.532111467736, 4271.658267338606, 5448.964696707652, 6514.77198298062, 6517.315681853384, 6526.738930442777, 6550.7707230246715, 5793.391693872125, 5982.162497250389, 5991.730372133265, 6000.879982400371, 6006.699665016776, 7036.73338799016, 7229.132504099489, 7243.818904527429, 7253.057102576631, 7262.564246145248, 4795.736234507101, 4847.563719265283, 4867.36724225852, 4874.2201247800185, 4878.0, 7562.243775622449, 7584.393248540158, 7591.696332146707, 7594.5822979736095, 7597.734079307253, 4902.583280421133, 4918.286848407032, 4924.162892308316, 4925.7783399747095, 4927.704337739676, 5006.3992320921725, 5007.774650140679, 5015.874603134878, 5020.196768517019, 5027.773750181251, 5985.790497332572, 5986.431289027535, 5994.1608174855555, 6001.549883758736, 6005.639661620229, 7010.894836577456, 7242.45681573884, 7279.89080163798, 7290.9635451822405, 7355.52189107717, 1724.7067998440295, 1769.6814573376657, 1769.955751106207, 1771.76081229035, 1775.5827380565556, 1068.5031460370965, 1118.2060736876747, 1130.8756036835941, 1131.5417256011328, 1159.5042395310124, 5593.636413633101, 6526.41262286387, 6669.7332106715185, 6711.664416779142, 6714.832129196711, 7384.667689953965, 7385.335319821134, 7386.519876208029, 7387.224341444178, 7393.408527317802, 6671.0, 6697.09589205451, 6700.631465269457, 6728.966355168192, 6736.865262694719, 3789.5263092113487, 3889.3776995680555, 3924.5486769021927, 3935.134270460494, 3936.075022369741, 7694.269044440769, 7696.7306144284685, 7700.0, 7707.499012564277, 7735.265149810759, 6527.792358413613, 7220.927790722026, 7530.472866899265, 7598.088229412506, 7606.429517786189, 7641.732539361095, 7646.273604007611, 7661.318538511477, 7664.808379790438, 7673.846523069507, 7101.893471598033, 7378.077740282465, 7381.557106573623, 7394.7781566553085, 7403.777886663409, 7183.568985860865, 7257.927420725937, 7280.708771649075, 7289.817754556178, 7290.890636640561, 7644.961775191088, 7645.120811106572, 7665.19515450892, 7667.243050905128, 7674.501157424749, 4968.056069346812, 4979.551840334388, 4984.252362145708, 4986.12742770021, 4991.301217829579, 7111.7866464006165, 7362.7423040193335, 7366.889496657447, 7383.372413344926, 7389.667464963982, 5647.322321321468, 7076.221615622175, 7131.8930216045765, 7142.321479459443, 7155.534890232118, 7094.9290507094265, 7105.82235444118, 7117.074780278531, 7118.715251389886, 7133.357997780225, 6924.688389022607, 6936.479764017819, 6945.617991010543, 6947.201071876799, 6959.338862808025, 7030.472714546328, 7047.471439641945, 7153.177384600837, 7312.0128782613665, 7398.48331092114, 6863.691133898887, 7006.159260888726, 7012.894806577803, 7134.785956421316, 7204.603746793977], "unit": "score", "name": "prototype.html", "value": 5291.002614180156}, {"lowerIsBetter": false, "replicates": [682.8736683713513, 728.8979542864, 789.0570767932323, 795.6419611174971, 804.7947773317804, 15148.545543633694, 15534.844651553482, 15554.0, 15568.84431155688, 15578.376864925403, 14514.983951123426, 14575.979681422305, 14581.416743330281, 14597.905157113233, 14607.415703371853, 808.0949336742841, 826.4751882554591, 972.0668158567784, 978.3054031637546, 979.1677074486665, 967.8741763570761, 977.452626529146, 977.7360112769584, 978.7699890525721, 999.7750506136098, 1029.402946291153, 1030.0986636692894, 1030.7577719235974, 1032.8863824979246, 1049.7218237167158, 860.849351363512, 1040.1003132290589, 1040.3705758016442, 1041.0838462153333, 1042.5256508288749, 765.8544876473508, 766.854297683444, 768.0207735137689, 773.2963003666637, 781.5232708048086, 15562.22188890551, 15609.92195039029, 15666.06003639774, 15753.921230393775, 15918.124503152321, 12970.416331265022, 13046.347682615831, 13166.934165329112, 13279.336033198302, 13575.52485662997, 10135.75202430665, 10307.484625768757, 10325.32885362449, 10638.202134839841, 11048.447577621168, 3574.070741607175, 3585.0, 3612.0789198754414, 3668.779873207616, 3837.6354246346555, 65099.02351464732, 85164.57417712934, 86959.13040869574, 87626.0, 87681.56159219227, 9914.058164474363, 9938.254630902711, 9995.600175992879, 9997.400155990665, 10276.280660353854, 23231.651525227135, 23234.767652323597, 23247.18634847772, 23270.0, 23313.533729325318, 7423.183449820515, 7481.7755467336065, 7558.58427786466, 7697.153313135551, 7782.49413788102, 4154.50145982484, 4247.277962746341, 4268.765217913045, 4362.520122786491, 4519.457665080211, 3621.9818900905325, 3697.279030589063, 3698.4082546792383, 3706.2772759311674, 3711.2391959648207, 580.3007376111775, 634.4670476799511, 654.4666097130823, 706.7067167125688, 713.710947066439, 538.37548443805, 583.4253260538367, 596.5555661032558, 606.3421188011057, 653.3466533466534, 7746.690132394754, 8064.193580642006, 8236.217559331853, 8597.951122323042, 8674.86987695185, 553.9723013849291, 576.7519966414399, 602.340437221242, 609.8261995331309, 618.6999305336908, 4007.338789099824, 4042.15114825884, 4068.5931406859077, 4085.816138273785, 4176.444851040136, 95522.0, 96197.0, 99579.0, 100858.0, 101279.98720012853, 80491.19508804836, 81063.0, 81569.0, 81840.59079704563, 84562.0, 72426.63786681033, 73198.26801732021, 73699.63150184322, 74468.62765686246, 75159.0, 7867.055953285642, 7931.762047138595, 8059.0, 8151.5924203790755, 8185.8772118419465, 50663.0, 50758.746206268734, 50939.0, 51888.740556298486, 54728.45271547233, 67400.0, 73936.0, 74324.25675743174, 75333.24666753481, 75448.0, 11378.54485820591, 11409.0, 11473.655790326304, 11761.41220935197, 11842.881571184178, 12338.198017128858, 12402.317872516738, 12598.937005314914, 12642.683932901751, 13123.081384303388, 9104.863427048733, 11852.70368240801, 12055.483986937601, 12397.0, 12644.513707019543, 11889.762204756029, 12187.634370968884, 12254.693632659255, 12650.0, 12680.809787853004, 12230.694232644255, 12568.497260109492, 12594.496220151092, 12611.621651350475, 12665.683357916127, 10252.43611601369, 10348.896511035095, 10350.689479315633, 10396.116330112025, 10620.946895265473, 10363.533640986325, 10385.63650272237, 10396.116330112025, 10400.323978941344, 10424.374537527772], "unit": "score", "name": "yui.html", "value": 7246.892544435722}], "name": "dromaeo_css", "value": 7848.341444284366}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 110.0, 112.0, 111.0, 121.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [157.0, 118.0, 146.0, 155.0, 117.0, 139.0, 117.0, 151.0, 149.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 136.7}, {"lowerIsBetter": true, "replicates": [183.0, 186.0, 186.0, 247.0, 256.0, 184.0, 186.0, 186.0, 185.0, 184.0], "unit": "score", "name": "audio-dft", "value": 198.3}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 77.0, 118.0, 55.0, 59.0, 56.0, 59.0, 127.0, 56.0], "unit": "score", "name": "audio-fft", "value": 75.5}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 128.0, 78.0, 79.0, 85.0, 119.0, 75.0, 78.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 86.0, 89.0, 85.0, 90.0, 87.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 94.0, 95.0, 95.0, 101.0, 95.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 87.0, 84.0, 85.0, 85.0, 87.0, 85.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [53.0, 58.0, 55.0, 57.0, 57.0, 56.0, 57.0, 56.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 69.0, 69.0, 77.0, 74.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 81.0, 80.0, 79.0, 79.0, 79.0, 75.0, 77.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 129.0, 117.0, 119.0, 114.0, 116.0, 116.0, 117.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 134.0, 134.0, 133.0, 122.0, 134.0, 135.0, 131.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.0}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 68.0, 64.0, 65.0, 65.0, 64.0, 67.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1409.2999999999997}]} 09:57:54 INFO - Return code: 0 09:57:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:57:54 INFO - # TBPL SUCCESS # 09:57:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:54 INFO - 2016-05-11 09:57:54.388 screenresolution[7164:134527] starting screenresolution argv=screenresolution get 09:57:54 INFO - 2016-05-11 09:57:54.390 screenresolution[7164:134527] Display 0: 1600x1200x32@60 09:57:54 INFO - 2016-05-11 09:57:54.396 screenresolution[7165:134529] starting screenresolution argv=screenresolution list 09:57:54 INFO - Available Modes on Display 0 09:57:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:54 INFO - Intel Iris: 09:57:54 INFO - Chipset Model: Intel Iris 09:57:54 INFO - Type: GPU 09:57:54 INFO - Bus: Built-In 09:57:54 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:54 INFO - Vendor: Intel (0x8086) 09:57:54 INFO - Device ID: 0x0a2e 09:57:54 INFO - Revision ID: 0x0009 09:57:54 INFO - Displays: 09:57:54 INFO - Display: 09:57:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:54 INFO - Display Serial Number: 1600x1200 60 09:57:54 INFO - Main Display: Yes 09:57:54 INFO - Mirror: Off 09:57:54 INFO - Online: Yes 09:57:54 INFO - Rotation: Supported 09:57:54 INFO - Return code: 0 09:57:54 INFO - Running post-action listener: _resource_record_post_action 09:57:54 INFO - Running post-run listener: _resource_record_post_run 09:57:55 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 1015808; Write bytes: 508660224; Read time: 13; Write time: 1703 09:57:55 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 205883904; Write bytes: 205864960; Read time: 19082; Write time: 418 09:57:55 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 1015808; Write bytes: 301668864; Read time: 13; Write time: 1282 09:57:55 INFO - Running post-run listener: _upload_blobber_files 09:57:55 INFO - Blob upload gear active. 09:57:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:57:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:57:56 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:57 INFO - (blobuploader) - INFO - Done attempting. 09:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:58 INFO - (blobuploader) - INFO - Done attempting. 09:57:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:58 INFO - Return code: 0 09:57:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42f42fb34bcf75938ab96e8bbbbbd5b48df8e92e0570e0da75a73ca5c332a57e957f117c2e9fef9c2e76302378d7bb554e9bcc8124743e72132f32f354e6bd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0449dcf575e2f71940da7cf528a0de904362d3097b825578ad8d08a515519a7e5c10debc72b8cecc123434d149119881111accc73f256834b2a0eccf5652a619"} 09:57:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:58 INFO - Contents: 09:57:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42f42fb34bcf75938ab96e8bbbbbd5b48df8e92e0570e0da75a73ca5c332a57e957f117c2e9fef9c2e76302378d7bb554e9bcc8124743e72132f32f354e6bd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0449dcf575e2f71940da7cf528a0de904362d3097b825578ad8d08a515519a7e5c10debc72b8cecc123434d149119881111accc73f256834b2a0eccf5652a619"} 09:57:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:58 INFO - Copying logs to upload dir... 09:57:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.090088 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-11 09:57:58.343382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 09:57:58.347066) ========= 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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42f42fb34bcf75938ab96e8bbbbbd5b48df8e92e0570e0da75a73ca5c332a57e957f117c2e9fef9c2e76302378d7bb554e9bcc8124743e72132f32f354e6bd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0449dcf575e2f71940da7cf528a0de904362d3097b825578ad8d08a515519a7e5c10debc72b8cecc123434d149119881111accc73f256834b2a0eccf5652a619"} build_url:https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/GP0Vo4qGTvmk7t5vuXi_Nw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42f42fb34bcf75938ab96e8bbbbbd5b48df8e92e0570e0da75a73ca5c332a57e957f117c2e9fef9c2e76302378d7bb554e9bcc8124743e72132f32f354e6bd4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0449dcf575e2f71940da7cf528a0de904362d3097b825578ad8d08a515519a7e5c10debc72b8cecc123434d149119881111accc73f256834b2a0eccf5652a619"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 09:57:58.375042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:57:58.375381) ========= 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.Y5RfEmdNLm/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.1rQIdSOGoT/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 09:57:58.424647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 09:57:58.424966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 09:57:58.425327) ========= ========= Total master_lag: 0.16 =========