builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0198 starttime: 1461101757.98 results: success (0) buildid: 20160419123832 builduid: a1783ebad6b546558fb0488a272d61ad revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:57.980633) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:57.981090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:57.981374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:58.001945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:58.002324) ========= 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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-04-19 14:35:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-04-19 14:35:58 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127675 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:58.186595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:58.186961) ========= 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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.026005 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 14:35:58.228235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-19 14:35:58.228574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-04-19 14:35:58,303 truncating revision to first 12 chars 2016-04-19 14:35:58,303 Setting DEBUG logging. 2016-04-19 14:35:58,304 attempt 1/10 2016-04-19 14:35:58,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4ab4fd96f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 14:36:00,062 unpacking tar archive at: fx-team-f4ab4fd96f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.003220 ========= master_lag: 1.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-19 14:36:01.463603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 14:36:01.463941) ========= script_repo_revision: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 14:36:01.464332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 14:36:01.464597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 14:36:01.484851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-19 14:36:01.485213) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:01 INFO - MultiFileLogger online at 20160419 14:36:01 in /builds/slave/test 14:36:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:36:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:36:01 INFO - {'append_to_log': False, 14:36:01 INFO - 'base_work_dir': '/builds/slave/test', 14:36:01 INFO - 'blob_upload_branch': 'Fx-Team', 14:36:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:36:01 INFO - 'branch': 'Fx-Team', 14:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:36:01 INFO - 'config_files': ('talos/mac_config.py',), 14:36:01 INFO - 'default_actions': ('clobber', 14:36:01 INFO - 'read-buildbot-config', 14:36:01 INFO - 'download-and-extract', 14:36:01 INFO - 'populate-webroot', 14:36:01 INFO - 'create-virtualenv', 14:36:01 INFO - 'install', 14:36:01 INFO - 'run-tests'), 14:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:36:01 INFO - 'download_minidump_stackwalk': True, 14:36:01 INFO - 'download_symbols': 'ondemand', 14:36:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:36:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:36:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:36:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:36:01 INFO - 'installer_path': 'installer.exe', 14:36:01 INFO - 'log_level': 'info', 14:36:01 INFO - 'log_name': 'talos', 14:36:01 INFO - 'log_to_console': True, 14:36:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:36:01 INFO - 'opt_config_files': (), 14:36:01 INFO - 'pip_index': False, 14:36:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:36:01 INFO - 'cmd': ('bash', 14:36:01 INFO - '-c', 14:36:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:36:01 INFO - 'enabled': True, 14:36:01 INFO - 'halt_on_failure': False, 14:36:01 INFO - 'name': 'check_screen_resolution'},), 14:36:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:36:01 INFO - 'cmd': ('bash', 14:36:01 INFO - '-c', 14:36:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:36:01 INFO - 'enabled': True, 14:36:01 INFO - 'halt_on_failure': False, 14:36:01 INFO - 'name': 'check_screen_resolution'},), 14:36:01 INFO - 'run_cmd_checks_enabled': True, 14:36:01 INFO - 'sps_profile': False, 14:36:01 INFO - 'sps_profile_interval': 0, 14:36:01 INFO - 'suite': 'dromaeojs-e10s', 14:36:01 INFO - 'system_bits': '32', 14:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:36:01 INFO - 'title': 't-yosemite-r7-0198', 14:36:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:36:01 INFO - 'use_talos_json': True, 14:36:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:36:01 INFO - 'work_dir': 'build'} 14:36:01 INFO - ##### 14:36:01 INFO - ##### Running clobber step. 14:36:01 INFO - ##### 14:36:01 INFO - Running pre-action listener: _resource_record_pre_action 14:36:01 INFO - Running main action method: clobber 14:36:01 INFO - rmtree: /builds/slave/test/build 14:36:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:36:03 INFO - Running post-action listener: _resource_record_post_action 14:36:03 INFO - ##### 14:36:03 INFO - ##### Running read-buildbot-config step. 14:36:03 INFO - ##### 14:36:03 INFO - Running pre-action listener: _resource_record_pre_action 14:36:03 INFO - Running main action method: read_buildbot_config 14:36:03 INFO - Using buildbot properties: 14:36:03 INFO - { 14:36:03 INFO - "project": "", 14:36:03 INFO - "product": "firefox", 14:36:03 INFO - "script_repo_revision": "production", 14:36:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:36:03 INFO - "repository": "", 14:36:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:36:03 INFO - "buildid": "20160419123832", 14:36:03 INFO - "pgo_build": "False", 14:36:03 INFO - "basedir": "/builds/slave/test", 14:36:03 INFO - "buildnumber": 622, 14:36:03 INFO - "slavename": "t-yosemite-r7-0198", 14:36:03 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:36:03 INFO - "platform": "yosemite_r7", 14:36:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:36:03 INFO - "branch": "fx-team", 14:36:03 INFO - "repo_path": "integration/fx-team", 14:36:03 INFO - "revision": "f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35", 14:36:03 INFO - "stage_platform": "macosx64", 14:36:03 INFO - "builduid": "a1783ebad6b546558fb0488a272d61ad", 14:36:03 INFO - "slavebuilddir": "test" 14:36:03 INFO - } 14:36:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:36:03 INFO - Running post-action listener: _resource_record_post_action 14:36:03 INFO - ##### 14:36:03 INFO - ##### Running download-and-extract step. 14:36:03 INFO - ##### 14:36:03 INFO - Running pre-action listener: _resource_record_pre_action 14:36:03 INFO - Running main action method: download_and_extract 14:36:03 INFO - mkdir: /builds/slave/test/build/tests 14:36:03 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')]} 14:36:03 INFO - https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 14:36:04 INFO - Downloaded 1199 bytes. 14:36:04 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:36:04 INFO - Using the following test package requirements: 14:36:04 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:36:04 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:36:04 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:36:04 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'jsshell-mac.zip'], 14:36:04 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:36:04 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:36:04 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:36:04 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:36:04 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:36:04 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:36:04 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:36:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:04 INFO - https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:36:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:36:06 INFO - Downloaded 18095485 bytes. 14:36:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:36:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:36:09 INFO - Return code: 0 14:36:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:36:09 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')]} 14:36:09 INFO - https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:36:10 INFO - Downloaded 18095485 bytes. 14:36:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:36:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:36:13 INFO - Return code: 0 14:36:13 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')]} 14:36:13 INFO - https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:36:14 INFO - Downloaded 10845952 bytes. 14:36:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:36:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:36:15 INFO - Return code: 0 14:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:15 INFO - https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 14:36:18 INFO - Downloaded 109983849 bytes. 14:36:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:36:18 INFO - mkdir: /builds/slave/test/properties 14:36:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:36:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:36:18 INFO - Contents: 14:36:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:36:18 INFO - Running post-action listener: _resource_record_post_action 14:36:18 INFO - Running post-action listener: set_extra_try_arguments 14:36:18 INFO - ##### 14:36:18 INFO - ##### Running populate-webroot step. 14:36:18 INFO - ##### 14:36:18 INFO - Running pre-action listener: _resource_record_pre_action 14:36:18 INFO - Running main action method: populate_webroot 14:36:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:36:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:36:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:36:18 INFO - '--tppagecycles', 14:36:18 INFO - '7'], 14:36:18 INFO - 'tests': ['tsvgm']}}, 14:36:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:36:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:36:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:36:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:36:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:36:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:36:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['damp', 'tps']}, 14:36:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'tests': ['damp', 'tps']}, 14:36:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['dromaeo_dom']}, 14:36:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:36:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['a11yr', 14:36:18 INFO - 'ts_paint', 14:36:18 INFO - 'tpaint', 14:36:18 INFO - 'sessionrestore', 14:36:18 INFO - 'sessionrestore_no_auto_restore', 14:36:18 INFO - 'tabpaint']}, 14:36:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['tsvgx', 14:36:18 INFO - 'tsvgr_opacity', 14:36:18 INFO - 'tart', 14:36:18 INFO - 'tscrollx', 14:36:18 INFO - 'cart']}, 14:36:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:36:18 INFO - 'tsvgr_opacity', 14:36:18 INFO - 'tart', 14:36:18 INFO - 'tscrollx', 14:36:18 INFO - 'cart']}, 14:36:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'talos_options': ['--disable-e10s'], 14:36:18 INFO - 'tests': ['tp5o']}, 14:36:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'tests': ['tp5o']}, 14:36:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'talos_options': ['--disable-e10s', 14:36:18 INFO - '--xperf_path', 14:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:36:18 INFO - 'tests': ['tp5n']}, 14:36:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:18 INFO - 'talos_options': ['--xperf_path', 14:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:36:18 INFO - 'tests': ['tp5n']}}, 14:36:18 INFO - 'talos.zip': {'path': '', 14:36:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:36:18 INFO - Running post-action listener: _resource_record_post_action 14:36:18 INFO - ##### 14:36:18 INFO - ##### Running create-virtualenv step. 14:36:18 INFO - ##### 14:36:18 INFO - Running pre-action listener: _resource_record_pre_action 14:36:18 INFO - Running main action method: create_virtualenv 14:36:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:36:18 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 14:36:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:36:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:36:18 INFO - Using real prefix '/tools/python27' 14:36:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:36:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:36:22 INFO - Installing pip.................done. 14:36:22 INFO - Return code: 0 14:36:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:22 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:22 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 14:36:22 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 14:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:22 INFO - 'HOME': '/Users/cltbld', 14:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:22 INFO - 'LOGNAME': 'cltbld', 14:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:22 INFO - 'MOZ_NO_REMOTE': '1', 14:36:22 INFO - 'NO_EM_RESTART': '1', 14:36:22 INFO - 'PAGER': '/bin/cat', 14:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:22 INFO - 'PWD': '/builds/slave/test', 14:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:22 INFO - 'SHELL': '/bin/bash', 14:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:22 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:22 INFO - 'USER': 'cltbld', 14:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:22 INFO - 'XPC_FLAGS': '0x0', 14:36:22 INFO - 'XPC_SERVICE_NAME': '0', 14:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:22 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 14:36:22 INFO - Cleaning up... 14:36:22 INFO - Return code: 0 14:36:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:22 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:22 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 14:36:22 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 14:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:22 INFO - 'HOME': '/Users/cltbld', 14:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:22 INFO - 'LOGNAME': 'cltbld', 14:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:22 INFO - 'MOZ_NO_REMOTE': '1', 14:36:22 INFO - 'NO_EM_RESTART': '1', 14:36:22 INFO - 'PAGER': '/bin/cat', 14:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:22 INFO - 'PWD': '/builds/slave/test', 14:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:22 INFO - 'SHELL': '/bin/bash', 14:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:22 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:22 INFO - 'USER': 'cltbld', 14:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:22 INFO - 'XPC_FLAGS': '0x0', 14:36:22 INFO - 'XPC_SERVICE_NAME': '0', 14:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:23 INFO - Downloading/unpacking psutil>=0.7.1 14:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:36:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:25 INFO - Installing collected packages: psutil 14:36:25 INFO - Running setup.py install for psutil 14:36:26 INFO - building 'psutil._psutil_osx' extension 14:36:26 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 14:36:26 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 14:36:26 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 14:36:26 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 14:36:26 INFO - building 'psutil._psutil_posix' extension 14:36:26 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 14:36:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:36:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:36:26 INFO - ^ 14:36:26 INFO - 1 warning generated. 14:36:26 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 14:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:27 INFO - Successfully installed psutil 14:36:27 INFO - Cleaning up... 14:36:27 INFO - Return code: 0 14:36:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:27 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:27 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 14:36:27 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 14:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:27 INFO - 'HOME': '/Users/cltbld', 14:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:27 INFO - 'LOGNAME': 'cltbld', 14:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:27 INFO - 'MOZ_NO_REMOTE': '1', 14:36:27 INFO - 'NO_EM_RESTART': '1', 14:36:27 INFO - 'PAGER': '/bin/cat', 14:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:27 INFO - 'PWD': '/builds/slave/test', 14:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:27 INFO - 'SHELL': '/bin/bash', 14:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:27 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:27 INFO - 'USER': 'cltbld', 14:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:27 INFO - 'XPC_FLAGS': '0x0', 14:36:27 INFO - 'XPC_SERVICE_NAME': '0', 14:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:36:29 INFO - Installing collected packages: mozsystemmonitor 14:36:29 INFO - Running setup.py install for mozsystemmonitor 14:36:30 INFO - Successfully installed mozsystemmonitor 14:36:30 INFO - Cleaning up... 14:36:30 INFO - Return code: 0 14:36:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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', '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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:36: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 blobuploader==1.2.4 14:36:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:30 INFO - 'HOME': '/Users/cltbld', 14:36:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:30 INFO - 'LOGNAME': 'cltbld', 14:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:30 INFO - 'MOZ_NO_REMOTE': '1', 14:36:30 INFO - 'NO_EM_RESTART': '1', 14:36:30 INFO - 'PAGER': '/bin/cat', 14:36:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:30 INFO - 'PWD': '/builds/slave/test', 14:36:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:30 INFO - 'SHELL': '/bin/bash', 14:36:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:30 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:30 INFO - 'USER': 'cltbld', 14:36:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:30 INFO - 'XPC_FLAGS': '0x0', 14:36:30 INFO - 'XPC_SERVICE_NAME': '0', 14:36:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:36:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:36:32 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 14:36:32 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 14:36:32 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 14:36:32 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 14:36:32 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 14:36:32 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 14:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:36:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:36:33 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 14:36:33 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 14:36:33 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 14:36:33 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 14:36:33 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 14:36:33 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 14:36:33 INFO - Downloading docopt-0.6.1.tar.gz 14:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:36:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:36:34 INFO - Running setup.py install for blobuploader 14:36:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:36:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:36:34 INFO - Running setup.py install for requests 14:36:34 INFO - Running setup.py install for docopt 14:36:34 INFO - Successfully installed blobuploader requests docopt 14:36:34 INFO - Cleaning up... 14:36:34 INFO - Return code: 0 14:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:34 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:34 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 14:36:34 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 14:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:34 INFO - 'HOME': '/Users/cltbld', 14:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:34 INFO - 'LOGNAME': 'cltbld', 14:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:34 INFO - 'MOZ_NO_REMOTE': '1', 14:36:34 INFO - 'NO_EM_RESTART': '1', 14:36:34 INFO - 'PAGER': '/bin/cat', 14:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:34 INFO - 'PWD': '/builds/slave/test', 14:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:34 INFO - 'SHELL': '/bin/bash', 14:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:34 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:34 INFO - 'USER': 'cltbld', 14:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:34 INFO - 'XPC_FLAGS': '0x0', 14:36:34 INFO - 'XPC_SERVICE_NAME': '0', 14:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-pk_x3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-rFUt0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Z5qOqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-r6eDVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-347b2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-llEd6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-WtRSCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-2K7bQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:35 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-mYF1Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-UTCkHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-3m10dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-eMQzDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-b9exi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-mqei6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Ur59G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-MbPewZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:36 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-3kw33y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:36:36 INFO - Running setup.py install for manifestparser 14:36:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:36:37 INFO - Running setup.py install for mozcrash 14:36:37 INFO - Running setup.py install for mozdebug 14:36:37 INFO - Running setup.py install for mozdevice 14:36:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:36:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:36:37 INFO - Running setup.py install for mozfile 14:36:37 INFO - Running setup.py install for mozhttpd 14:36:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:36:37 INFO - Running setup.py install for mozinfo 14:36:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:36:37 INFO - Running setup.py install for mozInstall 14:36:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Running setup.py install for mozleak 14:36:38 INFO - Running setup.py install for mozlog 14:36:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Running setup.py install for moznetwork 14:36:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Running setup.py install for mozprocess 14:36:38 INFO - Running setup.py install for mozprofile 14:36:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:36:38 INFO - Running setup.py install for mozrunner 14:36:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:36:39 INFO - Running setup.py install for mozscreenshot 14:36:39 INFO - Running setup.py install for moztest 14:36:39 INFO - Running setup.py install for mozversion 14:36:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:36:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:36:39 INFO - Cleaning up... 14:36:39 INFO - Return code: 0 14:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:39 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:39 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 14:36:39 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 14:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:39 INFO - 'HOME': '/Users/cltbld', 14:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:39 INFO - 'LOGNAME': 'cltbld', 14:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:39 INFO - 'MOZ_NO_REMOTE': '1', 14:36:39 INFO - 'NO_EM_RESTART': '1', 14:36:39 INFO - 'PAGER': '/bin/cat', 14:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:39 INFO - 'PWD': '/builds/slave/test', 14:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:39 INFO - 'SHELL': '/bin/bash', 14:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:39 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:39 INFO - 'USER': 'cltbld', 14:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:39 INFO - 'XPC_FLAGS': '0x0', 14:36:39 INFO - 'XPC_SERVICE_NAME': '0', 14:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:39 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Wl27MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:39 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)) 14:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:39 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-yCcPV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:39 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)) 14:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:39 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-iVPiym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-FtEH8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ySxeGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-TfmTaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-kfKhR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-8oVSSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-upYC3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-HgM84S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9xAkiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:40 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-haxZ4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:40 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)) 14:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:41 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-LWmuYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:41 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)) 14:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:41 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Ebu2fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:41 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)) 14:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:41 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-q4sA_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:41 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)) 14:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:41 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-uB2aXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:41 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)) 14:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:41 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-FrQS7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:41 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)) 14:36:41 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)) 14:36:41 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)) 14:36:41 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)) 14:36:41 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)) 14:36:41 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)) 14:36:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36:43 INFO - Downloading blessings-1.6.tar.gz 14:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:36:43 INFO - Installing collected packages: blessings 14:36:43 INFO - Running setup.py install for blessings 14:36:44 INFO - Successfully installed blessings 14:36:44 INFO - Cleaning up... 14:36:44 INFO - Return code: 0 14:36:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:36:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:44 INFO - Reading from file tmpfile_stdout 14:36:44 INFO - Current package versions: 14:36:44 INFO - blessings == 1.6 14:36:44 INFO - blobuploader == 1.2.4 14:36:44 INFO - docopt == 0.6.1 14:36:44 INFO - manifestparser == 1.1 14:36:44 INFO - mozInstall == 1.12 14:36:44 INFO - mozcrash == 0.17 14:36:44 INFO - mozdebug == 0.1 14:36:44 INFO - mozdevice == 0.48 14:36:44 INFO - mozfile == 1.2 14:36:44 INFO - mozhttpd == 0.7 14:36:44 INFO - mozinfo == 0.9 14:36:44 INFO - mozleak == 0.1 14:36:44 INFO - mozlog == 3.1 14:36:44 INFO - moznetwork == 0.27 14:36:44 INFO - mozprocess == 0.22 14:36:44 INFO - mozprofile == 0.28 14:36:44 INFO - mozrunner == 6.11 14:36:44 INFO - mozscreenshot == 0.1 14:36:44 INFO - mozsystemmonitor == 0.0 14:36:44 INFO - moztest == 0.7 14:36:44 INFO - mozversion == 1.4 14:36:44 INFO - psutil == 3.1.1 14:36:44 INFO - requests == 1.2.3 14:36:44 INFO - wsgiref == 0.1.2 14:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:44 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:44 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 14:36:44 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 14:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:44 INFO - 'HOME': '/Users/cltbld', 14:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:44 INFO - 'LOGNAME': 'cltbld', 14:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:44 INFO - 'MOZ_NO_REMOTE': '1', 14:36:44 INFO - 'NO_EM_RESTART': '1', 14:36:44 INFO - 'PAGER': '/bin/cat', 14:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:44 INFO - 'PWD': '/builds/slave/test', 14:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:44 INFO - 'SHELL': '/bin/bash', 14:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:44 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:44 INFO - 'USER': 'cltbld', 14:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:44 INFO - 'XPC_FLAGS': '0x0', 14:36:44 INFO - 'XPC_SERVICE_NAME': '0', 14:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 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)) 14:36:44 INFO - Cleaning up... 14:36:44 INFO - Return code: 0 14:36:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:44 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:44 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 14:36:44 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 14:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:44 INFO - 'HOME': '/Users/cltbld', 14:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:44 INFO - 'LOGNAME': 'cltbld', 14:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:44 INFO - 'MOZ_NO_REMOTE': '1', 14:36:44 INFO - 'NO_EM_RESTART': '1', 14:36:44 INFO - 'PAGER': '/bin/cat', 14:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:44 INFO - 'PWD': '/builds/slave/test', 14:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:44 INFO - 'SHELL': '/bin/bash', 14:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:44 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:44 INFO - 'USER': 'cltbld', 14:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:44 INFO - 'XPC_FLAGS': '0x0', 14:36:44 INFO - 'XPC_SERVICE_NAME': '0', 14:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:45 INFO - Downloading/unpacking jsonschema 14:36:45 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 14:36:45 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 14:36:45 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 14:36:45 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 14:36:45 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 14:36:45 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 14:36:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:36:47 INFO - Downloading/unpacking functools32 (from jsonschema) 14:36:47 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 14:36:47 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 14:36:47 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 14:36:47 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 14:36:47 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 14:36:47 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 14:36:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:36:47 INFO - warning: no files found matching '*.txt' 14:36:47 INFO - no previously-included directories found matching 'build' 14:36:47 INFO - no previously-included directories found matching 'dist' 14:36:47 INFO - no previously-included directories found matching '.git*' 14:36:47 INFO - Installing collected packages: jsonschema, functools32 14:36:47 INFO - Running setup.py install for functools32 14:36:48 INFO - warning: no files found matching '*.txt' 14:36:48 INFO - no previously-included directories found matching 'build' 14:36:48 INFO - no previously-included directories found matching 'dist' 14:36:48 INFO - no previously-included directories found matching '.git*' 14:36:48 INFO - Successfully installed jsonschema functools32 14:36:48 INFO - Cleaning up... 14:36:48 INFO - Return code: 0 14:36:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:48 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 0x106502a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106512420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc883d90c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, '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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 14:36:48 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 14:36:48 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 14:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:48 INFO - 'HOME': '/Users/cltbld', 14:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:48 INFO - 'LOGNAME': 'cltbld', 14:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:48 INFO - 'MOZ_NO_REMOTE': '1', 14:36:48 INFO - 'NO_EM_RESTART': '1', 14:36:48 INFO - 'PAGER': '/bin/cat', 14:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:48 INFO - 'PWD': '/builds/slave/test', 14:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:48 INFO - 'SHELL': '/bin/bash', 14:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:36:48 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:48 INFO - 'USER': 'cltbld', 14:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:48 INFO - 'XPC_FLAGS': '0x0', 14:36:48 INFO - 'XPC_SERVICE_NAME': '0', 14:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:48 INFO - Downloading/unpacking flake8 14:36:48 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 14:36:48 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 14:36:48 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 14:36:48 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 14:36:48 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 14:36:48 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 14:36:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:36:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:36:50 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 14:36:50 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 14:36:50 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 14:36:50 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 14:36:50 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 14:36:50 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 14:36:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:36:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:51 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 14:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:36:52 INFO - no previously-included directories found matching 'docs/_build' 14:36:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:36:52 INFO - Running setup.py install for pep8 14:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:36:52 INFO - no previously-included directories found matching 'docs/_build' 14:36:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:36:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:36:52 INFO - Cleaning up... 14:36:52 INFO - Return code: 0 14:36:52 INFO - Running post-action listener: _resource_record_post_action 14:36:52 INFO - Running post-action listener: _start_resource_monitoring 14:36:52 INFO - Starting resource monitoring. 14:36:52 INFO - ##### 14:36:52 INFO - ##### Running install step. 14:36:52 INFO - ##### 14:36:52 INFO - Running pre-action listener: _resource_record_pre_action 14:36:52 INFO - Running main action method: install 14:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:52 INFO - Reading from file tmpfile_stdout 14:36:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:36:52 INFO - Reading from file tmpfile_stdout 14:36:52 INFO - Output received: 14:36:52 INFO - Usage: mozinstall [options] installer 14:36:52 INFO - Options: 14:36:52 INFO - -h, --help show this help message and exit 14:36:52 INFO - -d DEST, --destination=DEST 14:36:52 INFO - Directory to install application into. [default: 14:36:52 INFO - "/builds/slave/test"] 14:36:52 INFO - --app=APP Application being installed. [default: firefox] 14:36:52 INFO - mkdir: /builds/slave/test/build/application 14:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:37:26 INFO - Reading from file tmpfile_stdout 14:37:26 INFO - Output received: 14:37:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:37:26 INFO - Running post-action listener: _resource_record_post_action 14:37:26 INFO - ##### 14:37:26 INFO - ##### Running run-tests step. 14:37:26 INFO - ##### 14:37:26 INFO - Running pre-action listener: _resource_record_pre_action 14:37:26 INFO - Running main action method: run_tests 14:37:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:37:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:37:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:37:26 INFO - 2016-04-19 14:37:26.725 screenresolution[1638:7432] starting screenresolution argv=screenresolution get 14:37:26 INFO - 2016-04-19 14:37:26.728 screenresolution[1638:7432] Display 0: 1600x1200x32@60 14:37:26 INFO - 2016-04-19 14:37:26.733 screenresolution[1639:7434] starting screenresolution argv=screenresolution list 14:37:26 INFO - Available Modes on Display 0 14:37:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:37:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:37:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:37:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:37:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:37:26 INFO - Intel Iris: 14:37:26 INFO - Chipset Model: Intel Iris 14:37:26 INFO - Type: GPU 14:37:26 INFO - Bus: Built-In 14:37:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:37:26 INFO - Vendor: Intel (0x8086) 14:37:26 INFO - Device ID: 0x0a2e 14:37:26 INFO - Revision ID: 0x0009 14:37:26 INFO - Displays: 14:37:26 INFO - Display: 14:37:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:37:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:37:26 INFO - Display Serial Number: 1600x1200 60 14:37:26 INFO - Main Display: Yes 14:37:26 INFO - Mirror: Off 14:37:26 INFO - Online: Yes 14:37:26 INFO - Rotation: Supported 14:37:26 INFO - Return code: 0 14:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:37:26 INFO - Python 2.7.3 14:37:26 INFO - Return code: 0 14:37:26 INFO - grabbing minidump binary from tooltool 14:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:37:26 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 0x1063a1e00>, '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 0x10620adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10639cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:37:26 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 14:37:26 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 14:37:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:37:27 INFO - Return code: 0 14:37:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:37:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:37:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:37:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:37:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:37:28 INFO - Return code: 0 14:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0198 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VhlSjJFiA0/Render', 14:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:28 INFO - 'HOME': '/Users/cltbld', 14:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:28 INFO - 'LOGNAME': 'cltbld', 14:37:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:37:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:28 INFO - 'MOZ_NO_REMOTE': '1', 14:37:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:37:28 INFO - 'NO_EM_RESTART': '1', 14:37:28 INFO - 'PAGER': '/bin/cat', 14:37:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:28 INFO - 'PWD': '/builds/slave/test', 14:37:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:28 INFO - 'SHELL': '/bin/bash', 14:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5Yzeo2erhO/Listeners', 14:37:28 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 14:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:28 INFO - 'USER': 'cltbld', 14:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:28 INFO - 'XPC_FLAGS': '0x0', 14:37:28 INFO - 'XPC_SERVICE_NAME': '0', 14:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:37:28 INFO - mozversion application_buildid: 20160419123832 14:37:28 INFO - mozversion application_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 14:37:28 INFO - mozversion application_display_name: Nightly 14:37:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:37:28 INFO - mozversion application_name: Firefox 14:37:28 INFO - mozversion application_remotingname: firefox 14:37:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:37:28 INFO - mozversion application_vendor: Mozilla 14:37:28 INFO - mozversion application_version: 48.0a1 14:37:28 INFO - mozversion platform_buildid: 20160419123832 14:37:28 INFO - mozversion platform_changeset: f4ab4fd96f8ef68158a4cae1e5dae91e6b52da35 14:37:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:37:28 INFO - mozversion platform_version: 48.0a1 14:37:28 INFO - using testdate: 1461101848 14:37:28 INFO - actual date: 1461101848 14:37:28 INFO - starting webserver on 'localhost:49270' 14:37:28 INFO - SUITE-START | Running 2 tests 14:37:28 INFO - TEST-START | dromaeo_css 14:37:28 INFO - operating with platform_type : mac_ 14:37:28 INFO - Initialising browser for dromaeo_css test... 14:37:28 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpl6kMYe/profile http://localhost:49270/getInfo.html) 14:37:31 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:37:31 INFO - PROCESS | 1657 | colorDepth:24 14:37:31 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:37:31 INFO - PROCESS | 1657 | __metrics 14:37:31 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:37:32 INFO - TEST-INFO | 1657: exit 0 14:37:32 INFO - Browser initialized. 14:37:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:37:32 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpl6kMYe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:44 INFO - PROCESS | 1660 | RSS: Main: 247939072 14:37:44 INFO - PROCESS | 1660 | 14:38:33 INFO - PROCESS | 1660 | 1461101913904 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] 14:40:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:40:46 INFO - PROCESS | 1660 | RSS: Main: 259506176 14:40:46 INFO - PROCESS | 1660 | 14:43:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:43:49 INFO - PROCESS | 1660 | RSS: Main: 271446016 14:43:49 INFO - PROCESS | 1660 | 14:46:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:46:52 INFO - PROCESS | 1660 | RSS: Main: 273494016 14:46:52 INFO - PROCESS | 1660 | 14:49:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:49:54 INFO - PROCESS | 1660 | RSS: Main: 275070976 14:49:54 INFO - PROCESS | 1660 | 14:52:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:52:57 INFO - PROCESS | 1660 | RSS: Main: 277958656 14:52:57 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:56:00 INFO - PROCESS | 1660 | RSS: Main: 279187456 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | __start_tp_report 14:56:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 14:56:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 14:56:00 INFO - PROCESS | 1660 | |i|pagename|runs| 14:56:00 INFO - PROCESS | 1660 | |0;dojo.html;3472.9826350868243;3549.112721819545;3565.750397472178;3570.0539357070365;3629.909252268693;4475.418195634571;4535.56912093351;4579.908401831962;5827.6212046217015;6003.969980150098;5812.651240925547;5870.324912635048;5928.081147422156;5992.7303271352785;6038.758449662019;5213.426523082458;5289.788408463666;5306.7611957462;5326.067938110835;5348.759305831228;5432.511074003339;5455.618106732531;5458.208559758833;5483.835484935438;5485.204645326446;4355.216061108999;5190.247414124969;5231.398389185254;5327.334083239595;5329.25390445338;5282.735863206824;5307.867303317409;5311.123664595337;5321.707306098163;5341.43914888935;4323.82704691812;5287.656302340336;5324.520793128599;5330.440303768088;5356.35723713153;5652.943470565283;5682.829515114553;5789.681567513827;5828.41715828418;5835.912461313083;6245.531585131133;6248.094026366197;6254.909955151596;6283.96858015707;6312.715927783261;6223.097650840603;6347.682615869188;6350.523710721714;6383;6389.265234498;6027.246594175728;6099.085137229451;6108.755649774048;6118.663473508956;6144.2319710036245;6402.903956440658;6461.25695545009;6487.22153341602;6498.350164983463;6517.120188774549;6125.021800333928;6184;6293.622382657055;6307.842303942438;6329.145565348711;5170.405403378584;6218.06728990655;6313.147725057151;6324.841878953063;6338.778142764981;6197.163382943245;6241.126242326078;6313.936860631335;6320.462760665303;6323.30443651198;5721.828345149652;6195.597286176384;6221.751129954841;6273.309935907047;6330.670559182623;5007.474215207423;5029.170186919117;5040.36995375578;5040.420351659606;5081.2632168335385;4494.191045611821;4534.433195850519;4541.250693635579;4549.749763763025;4594.19601569724;5919.112133180058;5997.310309314485;6005.969970150209;6026.427489388501;6096.756129754849;6290.591111577733;6293.087502312231;6320.399562041599;6338.651374174465;6351.650659213695;5966.701664916737;6059.333473317932;6060;6063.818085457443;6065.696715164224;5435.619506634498;5505.03661859173;5555.166724991283;5574.08027675429;5598.10430331145;6546.247181574085;6565.606063636197;6574.276829548746;6583.670816459254;6586;6319.210098737658;6325.272593651604;6340.207474065742;6340.4293613575;6342.809715708536;6421.261554921244;6453.483721302191;6488.961766117399;6494.350564943468;6529.8694026120165;6196.225471816023;6318.905216421849;6321.905171422341;6350.269718982191;6355.491560675043;4758.857234282977;5220.817271395483;6013.7293821779;6308.369163083655;6333.113364128933;5125.487451254994;6121.331035925228;6124.441964285601;6267.5299352549655;6287.497000239879;4874.756262186947;6256.906146407899;6274.1843560336865;6283.02613094971;6291.433770960635;4818.494058123987;5274.997750427407;5472.26124473207;6035.728392222272;6156;6062.484688801501;6244.438000579969;6255.374462553708;6287.402696743802;6298.685065746786;6164.383561643979;6169.938300617116;6174.166487524127;6177.536684748752;6203.658798766111 14:56:00 INFO - PROCESS | 1660 | |1;ext.html;508;519.8830263190782;561.2058936604702;584.8742520358123;620.9503239740822;33117.83441082794;36562.8171859141;36587.085322866944;36609.81695091527;36636.63363366365;36828;37230.8138459308;37332.81333593335;37367.69213077543;37393.43909841348;9235.630574777018;9402.81194376112;9452.385594936342;9482.241420686329;9491.905080949171;9383.859242111374;9416.058394160598;9422.3875448096;9435.15083642472;9508.381955172927;9415.058494150564;9441.480718560477;9469.763255918622;9538.618455261781;9559.569819358145;8115.269625733683;9425.245980321557;9466.148046675798;9484.52577371132;9524.190443812215;9438.056194380575;9465.148136667663;9494.667686631004;9542.809143817085;9558.091981261769;36847.946725860136;37240.88277351684;37281.62718372809;37365.879023629335;37452;2527.4060595759984;3019.5168772996435;3087.367089746597;3150.984245078783;3374.240795820945;20560.79439205619;25192.118275860255;25892.87053564739;25907;25953.22140335793;2557.961630575543;2593.6498572692635;2604.8306860054035;2678.0894495871303;2693.878775455109;316505.8349416499;327821;364832;366192;368675;32606.836965815495;32972.83513582417;33276.334473310395;33293.83353083268;33648;34765;63938;64991;65999.34000660028;66439.66780166165;16227.756583651255;16353;16389.262483188046;16403.343866245217;16412.75380869288;10317.74205644865;12250.632481025583;12666.49334026647;12737.172083814523;12762.553310634083;18603.06984650762;18822.24711011544;18939.90530047341;19245.80754192468;19264.61470770577;8250.38122140842;8380.371472139614;8411.873821892677;8472.788180295542;8496.235338819535;957.6552441121191;974.6101559376165;1036.3108532825738;1056.4189695667353;1125.3472985668293;25970;27978.300542486602;28195.859020705175;29580.852095739385;29759.553606695918;1083.1551389915878;1102.6581759654532;1151.9596814111467;1203.6509412270518;1218.11686527267;14082;14392.06451580644;14902.70194596102;15185.088894666356;15483.148426836633;639658;722204;741247;741679.3328266917;742938;58005;58224.70887645535;58787.41212587905;58950.82098358009;59027.40972590305;1469.4122351059448;1490.7391206538812;1493.514607752463;1501.4894935721907;1502.4891536877515;27319;28811.56782648304;29188.416231675674;29846.403071938876;29930.85034574813;50207.995840082265;54088.729556351966;55764.88470230654;56577.15134272907;56638.7168064157;501540;567175;568969;576970;582000;40474.59525404826;41163;41666.58333416627;41775.37336940009;41828.790856045525;44662.10675786531;45040.54959450364;45218.32172517349;45380.546194538954;45774.54225457703;36117.45823812697;36821.19600931968;37019.25961480809;37046.25907481889;37523.06192345213;36785.26429471342;37042.8147859259;37765.24469510539;37771.43342849804;37811.432828507044;31381;35554.644453555135;36170.819145904105;38350.61649383471;38745.418818717175;25932.573708446216;31306.843465783437;31964;32070.83964580162;32127.357452850345;23641.52716945686;24272.271831844366;24372.878135609208;24474.75525244796;24525.754742452347 14:56:00 INFO - PROCESS | 1660 | |2;jquery.html;389.35172937059815;390.39683688700956;397.25118152282937;398.16981593377807;400.18761913315967;19493.902530487347;19721.30975415857;20218.59562808743;20330.593388132245;20836;19840.305589304342;20099.497512562193;20239.898800505976;20262.797372026274;20543.794562054376;4651.2790517469675;5623.718814059301;5750.683712395817;5777.0756678931375;5973.910391344122;5576.358718747335;5704.686242256675;5761.1358296255685;5819.67991760453;6008.579399442041;5841.415858414167;5972.432618901197;5982.282126144869;5996.520278377741;6014.669193194372;5524.1989911463015;5885.558583106263;5937.317208521033;6478.093066970628;6640.6015639061325;5081.780372710523;5732.31212254528;5850.327212370589;5853.414658534155;5883.352831188566;12812.61562153137;13305;13621.863781362159;13633.727325453436;13638.93180534101;1951.4731022623812;2195.637719776235;2205.1730601024615;2256.627656436686;2569.1907049279416;9830.262730295257;10214.591416343337;10246.487675616265;10266.538005789758;10449.373037617766;1718.67345204412;1720.1915099903151;1725.620363520036;1788.6333301673255;1835.577817102074;76456;108110.18898110205;123930;126423.73576264211;127404.36297818637;9134.771630709285;10058.446785426726;11831.585894493652;11859.762804743857;12024.639260822189;12773.042021848212;12971.286579238043;14476.565703028926;15122;15185.392584296504;8503.829923401498;8566.143385661384;8567.443116197428;8578.65685372578;8671.869921951176;8375.8324833503;8406.621702023423;8483.27892129176;8498;8559.058503564604;4582.702124361906;4669.789859456333;4671.1358398695675;4726.385569875963;4745.738984355894;1564.9530514084595;1657.7844880165742;1857.8327950484522;2027.9594408111755;2032.3699653107583;918.7381596245039;923.8983711791698;936.413536156519;1002.5538635307364;1012.099231683802;19882.304119355755;20427.87646679447;20470.692939605917;20569.177232910813;20693.379198624065;828.8093738440192;933.4679232837353;977.3451787302382;1019.6431249062917;1037.097724979273;8707.608157632922;9239.614057891371;10585.735356615993;10656.9875861793;10707.304025238334;198735;199678.001609991;485968;594619;601551;104649;126093;126907;134194.31611367717;134954;981.6858605246252;982.4841957971979;997.8403455447238;1001.5743309093606;1003.007023047178;13223.396237715631;16927.830721692626;17722.645547088727;17867.009026920572;18208.635827283117;47621.52378476309;49561.75219123881;50257.994840103725;50492.49507504878;50871;62980.68509657423;68602.31397685959;73484;73578.63210684127;76711.61644191743;8018.438709290293;8028.1169071403265;8104.83790324202;8192.426530143071;8428.45215061019;11167.050800682033;11451.942740286246;11829.408529573659;12549.811752823898;12683.11218214716;10549.103326217357;10673.839892401775;10677.626283080055;10985;11009.394483303495;9038.322125840457;10469.953004699773;10530.894691052992;10798.460076996276;10979.670609881716;10918.672439826818;10990.17573681993;11139.997400234019;11264.887351126385;11295.661130166109;8090.352771778126;8120.878186827321;8165.755027349189;8226.794330141794;8498.065212826461;8349.039860415887;10691.625793097204;10829.404382759023;11117.888821112008;11155.609553665583 14:56:00 INFO - PROCESS | 1660 | |3;mootools.html;1600.5598460423387;1636;1893.1480833624864;1976.2193933396318;1981.2669312354421;7849.48978316409;8071.434999550019;8667.739967800968;8920.553972301383;8948.597313120908;7744.380449564035;8656.437331573443;8678.39251252411;8793.736187914357;8811.735647930556;2419.3467763703834;2441.2066078524463;2450.644656524803;2451.3871532116973;2453.0187924830034;2418.238254949685;2421.9394515137087;2449.4243852694603;2451.4239153798844;2460.8031357491445;2044.1925439451409;2431.3070774829175;2433.452473193535;2448.6449464827588;2450.179189971353;2391.4021494626345;2415.4565222824813;2431.647411125377;2434.793042591382;2439.5852705040097;2378.488624945645;2415.4082249848725;2415.4806716556027;2418.3349578865777;2422.031187525004;8798.076201998761;8850;8871.822563548758;8880.777980550538;8899.421537600036;4292.399064131024;5359.464053594609;5387.461253874581;5433.510984011458;5449.264349312872;3542.2030043240065;3550.5384300041087;3630.945535816965;3687.50218720472;3711.406175012012;1024.2522958240452;1056.244784978736;1061.7929503746773;1068.028094434069;1073.5330131392868;11732.941335293353;11794.52821887132;11826.526938922432;11833.763324733543;11893.52425902963;3811.294910441577;4669.182892993713;4889.731064791471;4897.191963326011;4901;9991.500424978722;10014.64948726791;10027.247956403298;10037.949810250902;10038.347507411994;5304.2839216706025;5354.170103633943;5369.838904832861;5428.864278392993;5431.592630552725;4472.373867658531;4790.353302304214;4928.433230178575;4950.628702847301;4970.701757894538;3972.82122304497;4021.9945013746565;4057.736247143926;4095.5494895561465;4157.48031496063;1236.6104677026708;1359.395069194199;1383.3774801339437;1384.231751377995;1385.1550554161954;778.43174482628;830.8338332333436;897.2552781191596;914.4284821986258;931.2410385535767;5795.014847475939;5892.292924849045;5909.793157239476;5933.2286802716235;6019.638821670714;959.1607343574373;964.4068897627908;970.6166064404662;997.1374760831828;1004.5730564510054;2912.359280958186;3513.8243087845503;3753.343164946178;3777.905552361158;3957.4261732049267;9806.656767013263;10368.96310368957;10611.09805666527;10873.130149588014;11062.22564420499;10762.300450470695;10957.56169753201;11027.283226590245;11033.448327583588;11040.723981900355;8242.17578242183;8269.131741167212;8276.379271554657;8284.875726864102;8412.8317433651;5770.394108618535;5807.216025836627;5833.387494313036;5891.307277291702;5910.320313164041;9924.751881203028;10159.593616255266;10232.64185753495;10238.078572928473;10375.16998640122;10137.391756494633;10296;10386.844197336895;10410.739731506774;10473.63342283047;6396.42432181106;6779.72881084751;6908;7024;7030.824229394306;8215.589220539068;8242.340612751086;8271.379646526415;8277.337812974827;8410.201030902055;7233.132024157135;7351.963240183765;7386.96306518464;7472.850542989218;7527.397808175223;7233.457490688114;7251.963740181265;7301.744438944612;7316.926830731837;7350.77947661571;6945.888657814726;6960.47796415281;6960.930390696029;6966.651667416508;6980.930190698231;4761.785719642555;4811.687240329367;4858.732769697701;4905.313256144072;5068.70747959268;4846.80612775485;4899.902001960012;4909.116359055404;4998.6500944933505;5119.334486516729 14:56:00 INFO - PROCESS | 1660 | |4;prototype.html;316.8431626344959;317.8966835778371;322.9015150379135;327.0972116957198;327.9950800737991;5213.66111202772;5490.533304669108;5746.706990927045;5993.400659934005;6310.873782524358;5949.851253718648;6039.637621742688;6245.157678484847;6258.812235632927;6271;4386.429764130667;4388.771144079647;4471.463424389078;4477.283634618461;4594.448666160066;4222.218889505436;4563.201439748047;4628.352030715702;4650.581447669709;4672.532746725335;3944.678532691552;4613.284940834159;4618.468876079261;4643.744594047326;4660.627149828023;3968;4388.275934470808;4525.705829121097;4612.3542704021465;4637.350770892078;3287.342531493711;3977.2244412339605;4004.4193591929006;4006.2988976928923;4013.9363068786793;4635.1656701794;5100.285959965608;5459.481349271813;5993.850153746148;6057.575969682124;4147.523034851;4370.2570563004365;4589.829593453648;5272.92090618641;5501.614886957915;6499.447546958514;6514.185726784152;6546.279909209983;6548.410643042149;6589.571677840973;3885.892520631635;4058.939115913264;4113.25961326961;4339.956600433987;4349.69552131351;5980.551458640576;6573.474122070223;6728.42808361285;6837.760678376283;6956.408705260059;3634.5638523376833;3911.4523966644692;4343.652507799368;4377.277749171415;4387.583179597933;4129.009037830899;4421.137878113801;4424.203643344229;4435.385161093698;4455.353973673799;4344;4446.333050042519;4557.154352487248;4863.440704319049;5287.444818294024;5006.324146240284;5812.779316343615;6538.659574787157;6679.432248258855;6717.227518835299;1039.6017356655286;1345.4618152738788;1499.9550013499613;1548.3651702801797;1558.306553583667;752.3529764402609;875.1642181716445;959.5442164971582;987.6148302162162;995;5516.503514683698;6168.0439531872635;6178.938210617926;6179.938200618026;6181.81454556364;5847.883042339129;6545.262602269781;6793.388595026471;6829.326814930374;6831.555948863308;5136.486351364833;6115.205023346936;6144.78493252734;6152.846178845475;6175.44421002112;3227.193201699575;3473.662639883663;3620.8913732588067;3633.5094762206763;3638.7270954678506;6453.451456626145;6785.6428714257345;7099.680514376762;7119.89320160198;7334.889976650355;5725.282415275484;6393.611385965446;6750.594964302158;6764.797056088227;6862.451003919675;7105.96447017772;7267.38227250679;7276.599787011659;7303.48875578715;7305.4341036851965;5193.506616871391;6035.668038257762;6376.489880809431;6670.132882725215;6885.139357580302;6112.786052488142;6122.387761223842;6687.665616719048;6867.3476019778045;6894.0025873737195;5961.791337303173;7030.402415794715;7287.271272872882;7294.343509084208;7309.232530584212;3677.5035370225746;3807.7144214183495;4404.251277282934;4431.246688062973;4439.889002774957;6359.742291486641;6689.331066893272;6964.686589103401;6976.372126508639;6981.616011119234;5797.8550536236935;6213.502919766498;6719.899201512079;6754.3921047106;6756.256811750802;6406.775762848278;6687.665616719048;6709.93290067093;6729.730810767514;6757.594544327356;5801.883962320646;6225.408586184305;6287.717052732546;6498.830210562144;6524.902126468011;5515.145152501369;6513.9058947001695;6701.363370479991;6705.39651431354;6722.529422940347;5349.598780091431;6387.72245550901;6496.545241833026;6534.640594767334;6585.934140658532 14:56:00 INFO - PROCESS | 1660 | |5;yui.html;594.0465552787775;669.3574168797953;715.68867542619;726.7456390263405;729.9525530840498;14985;15048.322825472853;15087.396504139835;15187.848121518795;15299.770503442458;11648.184627076109;13866.791998120036;13965.44138234472;13994.930025349859;14664.266786660677;917.1058218237199;924.9491277979708;928.8467402878517;932.1377725603824;932.5197523275518;886.3573908916048;888.8133491966662;889.3063410539789;926.8841394825647;930.888293404789;948.369334392628;960.3133759362055;975.8194733974237;980.7744218829673;985.5318723606301;925.3984909808645;927.7216834949488;927.9907200928005;959.1799011844842;968.8740463739704;690.3062422265591;690.9827254318682;691.4848437913736;714.0681410758957;728.7449392712562;14292.928535357361;14605.70788584233;14726.779098313535;14752;14776.704465910729;10910.836337454944;12779.424925878358;12803.295818729966;13031.543895963596;13790.931045344809;10164.44095574743;10197.164510388127;10248.180145588334;10280.845787313121;10485.63300284494;3462.913427164341;3528.1003344147334;3565.358235517606;3598.5681718193982;3608.2603066371594;81951.590242049;83886;86390;87361.12638873594;87876.56061719714;9607.279454040974;9662.3719458235;9697.933227344987;9863.704088877344;9957.253206009578;21657.133714651554;22599.774002260096;22669.319920402413;22710.886445567667;23072.88463557705;7511.136219334737;7645.4648174628355;7645.4648174628355;7684.231576842271;7920.84158316842;4102.712810103324;4161.146964872194;4172.061286210578;4195.979020104941;4277.893052673646;3596.0650230940146;3628.582712987987;3698.7595806272507;3708.2212735325884;3731.626837316301;603.8218725475995;644.4103645164622;645.20639613275;659.85153340498;660.1022609251414;562.8846086552329;565.4712843491349;572.6792995922214;578.9189513468118;594.0020765114649;7891.447598668153;7965.442419030728;7982.361411087099;8145.877811832827;8216.178382161856;558.8295569851153;560.4479587606205;570.5963330207653;581.3082431906018;596.8000719758843;3288.5067239914206;3422.435298175773;3858.9421158682644;3861.7489863158803;3862.4978752761963;88872;89607;90315;90846;91966.16067678743;63043.6847815758;65829.68340633257;79742.40515189664;81556.59221703853;81912.62786349257;48745;67075;68754;69994.65002675056;71066.22334441578;5955.493783028491;8112.472689275178;8201.13888041771;8277.83444331122;8344.08215096351;43405.78297108494;43440.34839477347;43950.90122746957;44366.77816610896;45196.77401612971;62995.85020749036;65338.673306635064;65537.67231163813;65762;66593.66922157702;10974.835377469184;11078.889211107786;11140.777184456427;11353.602623908124;11451.48468318911;10232.846507302247;10848.825164912832;11762.647120586396;11788.646340609452;11825.822612660644;11257.21199516026;11467.31196128235;11552.075833933097;11632.18574699763;11997.76004479923;9597.47213903242;11037.337759734442;11265.380404077527;11522.769544608893;12352.197107188003;9715.125638692552;10954.726131846768;11103.16726245551;11169.994700476997;11710.414479275832;9206.769830754285;9303.023182565734;9389.577469013775;9399.248060155034;9637.036296370306;9013.233875120688;9526.52367381642;9548.952255238679;9565.378250413702;9584.28117891147 14:56:00 INFO - PROCESS | 1660 | __end_tp_report 14:56:00 INFO - PROCESS | 1660 | __start_cc_report 14:56:00 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,396 14:56:00 INFO - PROCESS | 1660 | __end_cc_report 14:56:00 INFO - PROCESS | 1660 | __startTimestamp1461102960672__endTimestamp 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | ------- Summary: start ------- 14:56:00 INFO - PROCESS | 1660 | Number of tests: 6 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5799.63 Median:6096.76 stddev:691.64 (11.3%) stddev-sans-first:669.24 14:56:00 INFO - PROCESS | 1660 | Values: 3473.0 3549.1 3565.8 3570.1 3629.9 4475.4 4535.6 4579.9 5827.6 6004.0 5812.7 5870.3 5928.1 5992.7 6038.8 5213.4 5289.8 5306.8 5326.1 5348.8 5432.5 5455.6 5458.2 5483.8 5485.2 4355.2 5190.2 5231.4 5327.3 5329.3 5282.7 5307.9 5311.1 5321.7 5341.4 4323.8 5287.7 5324.5 5330.4 5356.4 5652.9 5682.8 5789.7 5828.4 5835.9 6245.5 6248.1 6254.9 6284.0 6312.7 6223.1 6347.7 6350.5 6383.0 6389.3 6027.2 6099.1 6108.8 6118.7 6144.2 6402.9 6461.3 6487.2 6498.4 6517.1 6125.0 6184.0 6293.6 6307.8 6329.1 5170.4 6218.1 6313.1 6324.8 6338.8 6197.2 6241.1 6313.9 6320.5 6323.3 5721.8 6195.6 6221.8 6273.3 6330.7 5007.5 5029.2 5040.4 5040.4 5081.3 4494.2 4534.4 4541.3 4549.7 4594.2 5919.1 5997.3 6006.0 6026.4 6096.8 6290.6 6293.1 6320.4 6338.7 6351.7 5966.7 6059.3 6060.0 6063.8 6065.7 5435.6 5505.0 5555.2 5574.1 5598.1 6546.2 6565.6 6574.3 6583.7 6586.0 6319.2 6325.3 6340.2 6340.4 6342.8 6421.3 6453.5 6489.0 6494.4 6529.9 6196.2 6318.9 6321.9 6350.3 6355.5 4758.9 5220.8 6013.7 6308.4 6333.1 5125.5 6121.3 6124.4 6267.5 6287.5 4874.8 6256.9 6274.2 6283.0 6291.4 4818.5 5275.0 5472.3 6035.7 6156.0 6062.5 6244.4 6255.4 6287.4 6298.7 6164.4 6169.9 6174.2 6177.5 6203.7 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:66756.69 Median:202761.47 stddev:151370.18 (74.7%) stddev-sans-first:151713.09 14:56:00 INFO - PROCESS | 1660 | Values: 508.0 519.9 561.2 584.9 621.0 33117.8 36562.8 36587.1 36609.8 36636.6 36828.0 37230.8 37332.8 37367.7 37393.4 9235.6 9402.8 9452.4 9482.2 9491.9 9383.9 9416.1 9422.4 9435.2 9508.4 9415.1 9441.5 9469.8 9538.6 9559.6 8115.3 9425.2 9466.1 9484.5 9524.2 9438.1 9465.1 9494.7 9542.8 9558.1 36847.9 37240.9 37281.6 37365.9 37452.0 2527.4 3019.5 3087.4 3151.0 3374.2 20560.8 25192.1 25892.9 25907.0 25953.2 2558.0 2593.6 2604.8 2678.1 2693.9 316505.8 327821.0 364832.0 366192.0 368675.0 32606.8 32972.8 33276.3 33293.8 33648.0 34765.0 63938.0 64991.0 65999.3 66439.7 16227.8 16353.0 16389.3 16403.3 16412.8 10317.7 12250.6 12666.5 12737.2 12762.6 18603.1 18822.2 18939.9 19245.8 19264.6 8250.4 8380.4 8411.9 8472.8 8496.2 957.7 974.6 1036.3 1056.4 1125.3 25970.0 27978.3 28195.9 29580.9 29759.6 1083.2 1102.7 1152.0 1203.7 1218.1 14082.0 14392.1 14902.7 15185.1 15483.1 639658.0 722204.0 741247.0 741679.3 742938.0 58005.0 58224.7 58787.4 58950.8 59027.4 1469.4 1490.7 1493.5 1501.5 1502.5 27319.0 28811.6 29188.4 29846.4 29930.9 50208.0 54088.7 55764.9 56577.2 56638.7 501540.0 567175.0 568969.0 576970.0 582000.0 40474.6 41163.0 41666.6 41775.4 41828.8 44662.1 45040.5 45218.3 45380.5 45774.5 36117.5 36821.2 37019.3 37046.3 37523.1 36785.3 37042.8 37765.2 37771.4 37811.4 31381.0 35554.6 36170.8 38350.6 38745.4 25932.6 31306.8 31964.0 32070.8 32127.4 23641.5 24272.3 24372.9 24474.8 24525.8 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:28940.87 Median:20764.69 stddev:77631.88 (373.9%) stddev-sans-first:77820.05 14:56:00 INFO - PROCESS | 1660 | Values: 389.4 390.4 397.3 398.2 400.2 19493.9 19721.3 20218.6 20330.6 20836.0 19840.3 20099.5 20239.9 20262.8 20543.8 4651.3 5623.7 5750.7 5777.1 5973.9 5576.4 5704.7 5761.1 5819.7 6008.6 5841.4 5972.4 5982.3 5996.5 6014.7 5524.2 5885.6 5937.3 6478.1 6640.6 5081.8 5732.3 5850.3 5853.4 5883.4 12812.6 13305.0 13621.9 13633.7 13638.9 1951.5 2195.6 2205.2 2256.6 2569.2 9830.3 10214.6 10246.5 10266.5 10449.4 1718.7 1720.2 1725.6 1788.6 1835.6 76456.0 108110.2 123930.0 126423.7 127404.4 9134.8 10058.4 11831.6 11859.8 12024.6 12773.0 12971.3 14476.6 15122.0 15185.4 8503.8 8566.1 8567.4 8578.7 8671.9 8375.8 8406.6 8483.3 8498.0 8559.1 4582.7 4669.8 4671.1 4726.4 4745.7 1565.0 1657.8 1857.8 2028.0 2032.4 918.7 923.9 936.4 1002.6 1012.1 19882.3 20427.9 20470.7 20569.2 20693.4 828.8 933.5 977.3 1019.6 1037.1 8707.6 9239.6 10585.7 10657.0 10707.3 198735.0 199678.0 485968.0 594619.0 601551.0 104649.0 126093.0 126907.0 134194.3 134954.0 981.7 982.5 997.8 1001.6 1003.0 13223.4 16927.8 17722.6 17867.0 18208.6 47621.5 49561.8 50258.0 50492.5 50871.0 62980.7 68602.3 73484.0 73578.6 76711.6 8018.4 8028.1 8104.8 8192.4 8428.5 11167.1 11451.9 11829.4 12549.8 12683.1 10549.1 10673.8 10677.6 10985.0 11009.4 9038.3 10470.0 10530.9 10798.5 10979.7 10918.7 10990.2 11140.0 11264.9 11295.7 8090.4 8120.9 8165.8 8226.8 8498.1 8349.0 10691.6 10829.4 11117.9 11155.6 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5717.93 Median:4852.77 stddev:3205.77 (66.1%) stddev-sans-first:3199.83 14:56:00 INFO - PROCESS | 1660 | Values: 1600.6 1636.0 1893.1 1976.2 1981.3 7849.5 8071.4 8667.7 8920.6 8948.6 7744.4 8656.4 8678.4 8793.7 8811.7 2419.3 2441.2 2450.6 2451.4 2453.0 2418.2 2421.9 2449.4 2451.4 2460.8 2044.2 2431.3 2433.5 2448.6 2450.2 2391.4 2415.5 2431.6 2434.8 2439.6 2378.5 2415.4 2415.5 2418.3 2422.0 8798.1 8850.0 8871.8 8880.8 8899.4 4292.4 5359.5 5387.5 5433.5 5449.3 3542.2 3550.5 3630.9 3687.5 3711.4 1024.3 1056.2 1061.8 1068.0 1073.5 11732.9 11794.5 11826.5 11833.8 11893.5 3811.3 4669.2 4889.7 4897.2 4901.0 9991.5 10014.6 10027.2 10037.9 10038.3 5304.3 5354.2 5369.8 5428.9 5431.6 4472.4 4790.4 4928.4 4950.6 4970.7 3972.8 4022.0 4057.7 4095.5 4157.5 1236.6 1359.4 1383.4 1384.2 1385.2 778.4 830.8 897.3 914.4 931.2 5795.0 5892.3 5909.8 5933.2 6019.6 959.2 964.4 970.6 997.1 1004.6 2912.4 3513.8 3753.3 3777.9 3957.4 9806.7 10369.0 10611.1 10873.1 11062.2 10762.3 10957.6 11027.3 11033.4 11040.7 8242.2 8269.1 8276.4 8284.9 8412.8 5770.4 5807.2 5833.4 5891.3 5910.3 9924.8 10159.6 10232.6 10238.1 10375.2 10137.4 10296.0 10386.8 10410.7 10473.6 6396.4 6779.7 6908.0 7024.0 7030.8 8215.6 8242.3 8271.4 8277.3 8410.2 7233.1 7352.0 7387.0 7472.9 7527.4 7233.5 7252.0 7301.7 7316.9 7350.8 6945.9 6960.5 6960.9 6966.7 6980.9 4761.8 4811.7 4858.7 4905.3 5068.7 4846.8 4899.9 4909.1 4998.7 5119.3 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5243.67 Median:5993.63 stddev:1720.17 (28.7%) stddev-sans-first:1684.77 14:56:00 INFO - PROCESS | 1660 | Values: 316.8 317.9 322.9 327.1 328.0 5213.7 5490.5 5746.7 5993.4 6310.9 5949.9 6039.6 6245.2 6258.8 6271.0 4386.4 4388.8 4471.5 4477.3 4594.4 4222.2 4563.2 4628.4 4650.6 4672.5 3944.7 4613.3 4618.5 4643.7 4660.6 3968.0 4388.3 4525.7 4612.4 4637.4 3287.3 3977.2 4004.4 4006.3 4013.9 4635.2 5100.3 5459.5 5993.9 6057.6 4147.5 4370.3 4589.8 5272.9 5501.6 6499.4 6514.2 6546.3 6548.4 6589.6 3885.9 4058.9 4113.3 4340.0 4349.7 5980.6 6573.5 6728.4 6837.8 6956.4 3634.6 3911.5 4343.7 4377.3 4387.6 4129.0 4421.1 4424.2 4435.4 4455.4 4344.0 4446.3 4557.2 4863.4 5287.4 5006.3 5812.8 6538.7 6679.4 6717.2 1039.6 1345.5 1500.0 1548.4 1558.3 752.4 875.2 959.5 987.6 995.0 5516.5 6168.0 6178.9 6179.9 6181.8 5847.9 6545.3 6793.4 6829.3 6831.6 5136.5 6115.2 6144.8 6152.8 6175.4 3227.2 3473.7 3620.9 3633.5 3638.7 6453.5 6785.6 7099.7 7119.9 7334.9 5725.3 6393.6 6750.6 6764.8 6862.5 7106.0 7267.4 7276.6 7303.5 7305.4 5193.5 6035.7 6376.5 6670.1 6885.1 6112.8 6122.4 6687.7 6867.3 6894.0 5961.8 7030.4 7287.3 7294.3 7309.2 3677.5 3807.7 4404.3 4431.2 4439.9 6359.7 6689.3 6964.7 6976.4 6981.6 5797.9 6213.5 6719.9 6754.4 6756.3 6406.8 6687.7 6709.9 6729.7 6757.6 5801.9 6225.4 6287.7 6498.8 6524.9 5515.1 6513.9 6701.4 6705.4 6722.5 5349.6 6387.7 6496.5 6534.6 6585.9 14:56:00 INFO - PROCESS | 1660 | 14:56:00 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:17882.75 Median:600.31 stddev:25145.17 (4188.7%) stddev-sans-first:25182.20 14:56:00 INFO - PROCESS | 1660 | Values: 594.0 669.4 715.7 726.7 730.0 14985.0 15048.3 15087.4 15187.8 15299.8 11648.2 13866.8 13965.4 13994.9 14664.3 917.1 924.9 928.8 932.1 932.5 886.4 888.8 889.3 926.9 930.9 948.4 960.3 975.8 980.8 985.5 925.4 927.7 928.0 959.2 968.9 690.3 691.0 691.5 714.1 728.7 14292.9 14605.7 14726.8 14752.0 14776.7 10910.8 12779.4 12803.3 13031.5 13790.9 10164.4 10197.2 10248.2 10280.8 10485.6 3462.9 3528.1 3565.4 3598.6 3608.3 81951.6 83886.0 86390.0 87361.1 87876.6 9607.3 9662.4 9697.9 9863.7 9957.3 21657.1 22599.8 22669.3 22710.9 23072.9 7511.1 7645.5 7645.5 7684.2 7920.8 4102.7 4161.1 4172.1 4196.0 4277.9 3596.1 3628.6 3698.8 3708.2 3731.6 603.8 644.4 645.2 659.9 660.1 562.9 565.5 572.7 578.9 594.0 7891.4 7965.4 7982.4 8145.9 8216.2 558.8 560.4 570.6 581.3 596.8 3288.5 3422.4 3858.9 3861.7 3862.5 88872.0 89607.0 90315.0 90846.0 91966.2 63043.7 65829.7 79742.4 81556.6 81912.6 48745.0 67075.0 68754.0 69994.7 71066.2 5955.5 8112.5 8201.1 8277.8 8344.1 43405.8 43440.3 43950.9 44366.8 45196.8 62995.9 65338.7 65537.7 65762.0 66593.7 10974.8 11078.9 11140.8 11353.6 11451.5 10232.8 10848.8 11762.6 11788.6 11825.8 11257.2 11467.3 11552.1 11632.2 11997.8 9597.5 11037.3 11265.4 11522.8 12352.2 9715.1 10954.7 11103.2 11170.0 11710.4 9206.8 9303.0 9389.6 9399.2 9637.0 9013.2 9526.5 9549.0 9565.4 9584.3 14:56:00 INFO - PROCESS | 1660 | -------- Summary: end -------- 14:56:00 INFO - PROCESS | 1660 | 14:56:01 INFO - TEST-INFO | 1660: exit 0 14:56:01 INFO - TEST-OK | dromaeo_css | took 1112745ms 14:56:01 INFO - TEST-START | kraken 14:56:01 INFO - operating with platform_type : mac_ 14:56:01 INFO - Initialising browser for kraken test... 14:56:01 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmp2fYEgN/profile http://localhost:49270/getInfo.html) 14:56:04 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 14:56:04 INFO - PROCESS | 1671 | colorDepth:24 14:56:04 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 14:56:04 INFO - PROCESS | 1671 | __metrics 14:56:04 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:56:04 INFO - TEST-INFO | 1671: exit 0 14:56:04 INFO - Browser initialized. 14:56:04 INFO - Running cycle 1/1 for kraken test... 14:56:04 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmp2fYEgN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:16 INFO - PROCESS | 1674 | RSS: Main: 247771136 14:56:16 INFO - PROCESS | 1674 | 14:56:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:56:20 INFO - PROCESS | 1674 | RSS: Main: 259817472 14:56:20 INFO - PROCESS | 1674 | 14:56:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:56:23 INFO - PROCESS | 1674 | RSS: Main: 269025280 14:56:23 INFO - PROCESS | 1674 | 14:56:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:56:27 INFO - PROCESS | 1674 | RSS: Main: 271790080 14:56:27 INFO - PROCESS | 1674 | 14:56:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:56:30 INFO - PROCESS | 1674 | RSS: Main: 273272832 14:56:30 INFO - PROCESS | 1674 | 14:56:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:56:32 INFO - PROCESS | 1674 | RSS: Main: 275668992 14:56:32 INFO - PROCESS | 1674 | 14:56:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:56:36 INFO - PROCESS | 1674 | RSS: Main: 275660800 14:56:36 INFO - PROCESS | 1674 | 14:56:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:56:39 INFO - PROCESS | 1674 | RSS: Main: 275333120 14:56:39 INFO - PROCESS | 1674 | 14:56:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:56:42 INFO - PROCESS | 1674 | RSS: Main: 275521536 14:56:42 INFO - PROCESS | 1674 | 14:56:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:56:45 INFO - PROCESS | 1674 | RSS: Main: 274722816 14:56:45 INFO - PROCESS | 1674 | 14:56:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:56:47 INFO - PROCESS | 1674 | RSS: Main: 274780160 14:56:47 INFO - PROCESS | 1674 | 14:56:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:56:50 INFO - PROCESS | 1674 | RSS: Main: 274743296 14:56:50 INFO - PROCESS | 1674 | 14:56:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:56:54 INFO - PROCESS | 1674 | RSS: Main: 274927616 14:56:54 INFO - PROCESS | 1674 | 14:56:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:56:57 INFO - PROCESS | 1674 | RSS: Main: 275390464 14:56:57 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:56:59 INFO - PROCESS | 1674 | RSS: Main: 276713472 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | __start_tp_report 14:56:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 14:56:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 14:56:59 INFO - PROCESS | 1674 | |i|pagename|runs| 14:56:59 INFO - PROCESS | 1674 | |0;ai-astar;117;111;116;116;116;128;115;115;118;117 14:56:59 INFO - PROCESS | 1674 | |1;audio-beat-detection;154;120;142;160;120;141;141;124;188;117 14:56:59 INFO - PROCESS | 1674 | |2;audio-dft;196;196;195;214;232;196;201;196;199;196 14:56:59 INFO - PROCESS | 1674 | |3;audio-fft;69;68;82;111;60;79;83;85;138;71 14:56:59 INFO - PROCESS | 1674 | |4;audio-oscillator;81;83;123;75;83;90;122;84;105;168 14:56:59 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;90;87;89;87;89;87;91;86;89;86 14:56:59 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;96;95;94;95;93;94;94;94;94 14:56:59 INFO - PROCESS | 1674 | |7;imaging-desaturate;92;94;90;91;91;89;91;89;92;120 14:56:59 INFO - PROCESS | 1674 | |8;json-parse-financial;54;58;84;93;95;85;95;73;64;61 14:56:59 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;66;65;72;77;74;68;71;64;85 14:56:59 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;84;84;86;85;82;84;83;84;86 14:56:59 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;157;132;160;157;157;145;135;136;221;142 14:56:59 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;172;172;169;173;166;170;176;172;165;184 14:56:59 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;70;70;68;68;70;71;70;69;67;75 14:56:59 INFO - PROCESS | 1674 | __end_tp_report 14:56:59 INFO - PROCESS | 1674 | __start_cc_report 14:56:59 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1015 14:56:59 INFO - PROCESS | 1674 | __end_cc_report 14:56:59 INFO - PROCESS | 1674 | __startTimestamp1461103019621__endTimestamp 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | ------- Summary: start ------- 14:56:59 INFO - PROCESS | 1674 | Number of tests: 14 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.50 stddev:4.33 (3.7%) stddev-sans-first:4.59 14:56:59 INFO - PROCESS | 1674 | Values: 117.0 111.0 116.0 116.0 116.0 128.0 115.0 115.0 118.0 117.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:141.50 stddev:22.33 (15.8%) stddev-sans-first:23.16 14:56:59 INFO - PROCESS | 1674 | Values: 154.0 120.0 142.0 160.0 120.0 141.0 141.0 124.0 188.0 117.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:202.10 Median:197.50 stddev:11.94 (6.0%) stddev-sans-first:12.46 14:56:59 INFO - PROCESS | 1674 | Values: 196.0 196.0 195.0 214.0 232.0 196.0 201.0 196.0 199.0 196.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:23.33 (31.1%) stddev-sans-first:24.05 14:56:59 INFO - PROCESS | 1674 | Values: 69.0 68.0 82.0 111.0 60.0 79.0 83.0 85.0 138.0 71.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:82.00 stddev:28.99 (35.4%) stddev-sans-first:29.79 14:56:59 INFO - PROCESS | 1674 | Values: 81.0 83.0 123.0 75.0 83.0 90.0 122.0 84.0 105.0 168.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:1.73 (1.9%) stddev-sans-first:1.69 14:56:59 INFO - PROCESS | 1674 | Values: 90.0 87.0 89.0 87.0 89.0 87.0 91.0 86.0 89.0 86.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 14:56:59 INFO - PROCESS | 1674 | Values: 94.0 96.0 95.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:91.00 stddev:9.29 (10.2%) stddev-sans-first:9.83 14:56:59 INFO - PROCESS | 1674 | Values: 92.0 94.0 90.0 91.0 91.0 89.0 91.0 89.0 92.0 120.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:76.20 Median:84.50 stddev:16.13 (19.1%) stddev-sans-first:14.97 14:56:59 INFO - PROCESS | 1674 | Values: 54.0 58.0 84.0 93.0 95.0 85.0 95.0 73.0 64.0 61.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.50 stddev:6.85 (9.6%) stddev-sans-first:6.71 14:56:59 INFO - PROCESS | 1674 | Values: 63.0 66.0 65.0 72.0 77.0 74.0 68.0 71.0 64.0 85.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 14:56:59 INFO - PROCESS | 1674 | Values: 84.0 84.0 84.0 86.0 85.0 82.0 84.0 83.0 84.0 86.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:157.00 stddev:25.70 (16.4%) stddev-sans-first:27.24 14:56:59 INFO - PROCESS | 1674 | Values: 157.0 132.0 160.0 157.0 157.0 145.0 135.0 136.0 221.0 142.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:5.36 (3.1%) stddev-sans-first:5.69 14:56:59 INFO - PROCESS | 1674 | Values: 172.0 172.0 169.0 173.0 166.0 170.0 176.0 172.0 165.0 184.0 14:56:59 INFO - PROCESS | 1674 | 14:56:59 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:2.20 (3.1%) stddev-sans-first:2.33 14:56:59 INFO - PROCESS | 1674 | Values: 70.0 70.0 68.0 68.0 70.0 71.0 70.0 69.0 67.0 75.0 14:56:59 INFO - PROCESS | 1674 | -------- Summary: end -------- 14:56:59 INFO - PROCESS | 1674 | 14:57:00 INFO - TEST-INFO | 1674: exit 0 14:57:00 INFO - TEST-OK | kraken | took 59174ms 14:57:00 INFO - SUITE-END | took 1171s 14:57:00 INFO - Completed test suite (00:19:32) 14:57:00 INFO - javascript benchmark 14:57:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3472.9826350868243, 3549.112721819545, 3565.750397472178, 3570.0539357070365, 3629.909252268693, 4475.418195634571, 4535.56912093351, 4579.908401831962, 5827.6212046217015, 6003.969980150098, 5812.651240925547, 5870.324912635048, 5928.081147422156, 5992.7303271352785, 6038.758449662019, 5213.426523082458, 5289.788408463666, 5306.7611957462, 5326.067938110835, 5348.759305831228, 5432.511074003339, 5455.618106732531, 5458.208559758833, 5483.835484935438, 5485.204645326446, 4355.216061108999, 5190.247414124969, 5231.398389185254, 5327.334083239595, 5329.25390445338, 5282.735863206824, 5307.867303317409, 5311.123664595337, 5321.707306098163, 5341.43914888935, 4323.82704691812, 5287.656302340336, 5324.520793128599, 5330.440303768088, 5356.35723713153, 5652.943470565283, 5682.829515114553, 5789.681567513827, 5828.41715828418, 5835.912461313083, 6245.531585131133, 6248.094026366197, 6254.909955151596, 6283.96858015707, 6312.715927783261, 6223.097650840603, 6347.682615869188, 6350.523710721714, 6383.0, 6389.265234498, 6027.246594175728, 6099.085137229451, 6108.755649774048, 6118.663473508956, 6144.2319710036245, 6402.903956440658, 6461.25695545009, 6487.22153341602, 6498.350164983463, 6517.120188774549, 6125.021800333928, 6184.0, 6293.622382657055, 6307.842303942438, 6329.145565348711, 5170.405403378584, 6218.06728990655, 6313.147725057151, 6324.841878953063, 6338.778142764981, 6197.163382943245, 6241.126242326078, 6313.936860631335, 6320.462760665303, 6323.30443651198, 5721.828345149652, 6195.597286176384, 6221.751129954841, 6273.309935907047, 6330.670559182623, 5007.474215207423, 5029.170186919117, 5040.36995375578, 5040.420351659606, 5081.2632168335385, 4494.191045611821, 4534.433195850519, 4541.250693635579, 4549.749763763025, 4594.19601569724, 5919.112133180058, 5997.310309314485, 6005.969970150209, 6026.427489388501, 6096.756129754849, 6290.591111577733, 6293.087502312231, 6320.399562041599, 6338.651374174465, 6351.650659213695, 5966.701664916737, 6059.333473317932, 6060.0, 6063.818085457443, 6065.696715164224, 5435.619506634498, 5505.03661859173, 5555.166724991283, 5574.08027675429, 5598.10430331145, 6546.247181574085, 6565.606063636197, 6574.276829548746, 6583.670816459254, 6586.0, 6319.210098737658, 6325.272593651604, 6340.207474065742, 6340.4293613575, 6342.809715708536, 6421.261554921244, 6453.483721302191, 6488.961766117399, 6494.350564943468, 6529.8694026120165, 6196.225471816023, 6318.905216421849, 6321.905171422341, 6350.269718982191, 6355.491560675043, 4758.857234282977, 5220.817271395483, 6013.7293821779, 6308.369163083655, 6333.113364128933, 5125.487451254994, 6121.331035925228, 6124.441964285601, 6267.5299352549655, 6287.497000239879, 4874.756262186947, 6256.906146407899, 6274.1843560336865, 6283.02613094971, 6291.433770960635, 4818.494058123987, 5274.997750427407, 5472.26124473207, 6035.728392222272, 6156.0, 6062.484688801501, 6244.438000579969, 6255.374462553708, 6287.402696743802, 6298.685065746786, 6164.383561643979, 6169.938300617116, 6174.166487524127, 6177.536684748752, 6203.658798766111], "value": 5759.08432553674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.0, 519.8830263190782, 561.2058936604702, 584.8742520358123, 620.9503239740822, 33117.83441082794, 36562.8171859141, 36587.085322866944, 36609.81695091527, 36636.63363366365, 36828.0, 37230.8138459308, 37332.81333593335, 37367.69213077543, 37393.43909841348, 9235.630574777018, 9402.81194376112, 9452.385594936342, 9482.241420686329, 9491.905080949171, 9383.859242111374, 9416.058394160598, 9422.3875448096, 9435.15083642472, 9508.381955172927, 9415.058494150564, 9441.480718560477, 9469.763255918622, 9538.618455261781, 9559.569819358145, 8115.269625733683, 9425.245980321557, 9466.148046675798, 9484.52577371132, 9524.190443812215, 9438.056194380575, 9465.148136667663, 9494.667686631004, 9542.809143817085, 9558.091981261769, 36847.946725860136, 37240.88277351684, 37281.62718372809, 37365.879023629335, 37452.0, 2527.4060595759984, 3019.5168772996435, 3087.367089746597, 3150.984245078783, 3374.240795820945, 20560.79439205619, 25192.118275860255, 25892.87053564739, 25907.0, 25953.22140335793, 2557.961630575543, 2593.6498572692635, 2604.8306860054035, 2678.0894495871303, 2693.878775455109, 316505.8349416499, 327821.0, 364832.0, 366192.0, 368675.0, 32606.836965815495, 32972.83513582417, 33276.334473310395, 33293.83353083268, 33648.0, 34765.0, 63938.0, 64991.0, 65999.34000660028, 66439.66780166165, 16227.756583651255, 16353.0, 16389.262483188046, 16403.343866245217, 16412.75380869288, 10317.74205644865, 12250.632481025583, 12666.49334026647, 12737.172083814523, 12762.553310634083, 18603.06984650762, 18822.24711011544, 18939.90530047341, 19245.80754192468, 19264.61470770577, 8250.38122140842, 8380.371472139614, 8411.873821892677, 8472.788180295542, 8496.235338819535, 957.6552441121191, 974.6101559376165, 1036.3108532825738, 1056.4189695667353, 1125.3472985668293, 25970.0, 27978.300542486602, 28195.859020705175, 29580.852095739385, 29759.553606695918, 1083.1551389915878, 1102.6581759654532, 1151.9596814111467, 1203.6509412270518, 1218.11686527267, 14082.0, 14392.06451580644, 14902.70194596102, 15185.088894666356, 15483.148426836633, 639658.0, 722204.0, 741247.0, 741679.3328266917, 742938.0, 58005.0, 58224.70887645535, 58787.41212587905, 58950.82098358009, 59027.40972590305, 1469.4122351059448, 1490.7391206538812, 1493.514607752463, 1501.4894935721907, 1502.4891536877515, 27319.0, 28811.56782648304, 29188.416231675674, 29846.403071938876, 29930.85034574813, 50207.995840082265, 54088.729556351966, 55764.88470230654, 56577.15134272907, 56638.7168064157, 501540.0, 567175.0, 568969.0, 576970.0, 582000.0, 40474.59525404826, 41163.0, 41666.58333416627, 41775.37336940009, 41828.790856045525, 44662.10675786531, 45040.54959450364, 45218.32172517349, 45380.546194538954, 45774.54225457703, 36117.45823812697, 36821.19600931968, 37019.25961480809, 37046.25907481889, 37523.06192345213, 36785.26429471342, 37042.8147859259, 37765.24469510539, 37771.43342849804, 37811.432828507044, 31381.0, 35554.644453555135, 36170.819145904105, 38350.61649383471, 38745.418818717175, 25932.573708446216, 31306.843465783437, 31964.0, 32070.83964580162, 32127.357452850345, 23641.52716945686, 24272.271831844366, 24372.878135609208, 24474.75525244796, 24525.754742452347], "value": 19233.93477623486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.35172937059815, 390.39683688700956, 397.25118152282937, 398.16981593377807, 400.18761913315967, 19493.902530487347, 19721.30975415857, 20218.59562808743, 20330.593388132245, 20836.0, 19840.305589304342, 20099.497512562193, 20239.898800505976, 20262.797372026274, 20543.794562054376, 4651.2790517469675, 5623.718814059301, 5750.683712395817, 5777.0756678931375, 5973.910391344122, 5576.358718747335, 5704.686242256675, 5761.1358296255685, 5819.67991760453, 6008.579399442041, 5841.415858414167, 5972.432618901197, 5982.282126144869, 5996.520278377741, 6014.669193194372, 5524.1989911463015, 5885.558583106263, 5937.317208521033, 6478.093066970628, 6640.6015639061325, 5081.780372710523, 5732.31212254528, 5850.327212370589, 5853.414658534155, 5883.352831188566, 12812.61562153137, 13305.0, 13621.863781362159, 13633.727325453436, 13638.93180534101, 1951.4731022623812, 2195.637719776235, 2205.1730601024615, 2256.627656436686, 2569.1907049279416, 9830.262730295257, 10214.591416343337, 10246.487675616265, 10266.538005789758, 10449.373037617766, 1718.67345204412, 1720.1915099903151, 1725.620363520036, 1788.6333301673255, 1835.577817102074, 76456.0, 108110.18898110205, 123930.0, 126423.73576264211, 127404.36297818637, 9134.771630709285, 10058.446785426726, 11831.585894493652, 11859.762804743857, 12024.639260822189, 12773.042021848212, 12971.286579238043, 14476.565703028926, 15122.0, 15185.392584296504, 8503.829923401498, 8566.143385661384, 8567.443116197428, 8578.65685372578, 8671.869921951176, 8375.8324833503, 8406.621702023423, 8483.27892129176, 8498.0, 8559.058503564604, 4582.702124361906, 4669.789859456333, 4671.1358398695675, 4726.385569875963, 4745.738984355894, 1564.9530514084595, 1657.7844880165742, 1857.8327950484522, 2027.9594408111755, 2032.3699653107583, 918.7381596245039, 923.8983711791698, 936.413536156519, 1002.5538635307364, 1012.099231683802, 19882.304119355755, 20427.87646679447, 20470.692939605917, 20569.177232910813, 20693.379198624065, 828.8093738440192, 933.4679232837353, 977.3451787302382, 1019.6431249062917, 1037.097724979273, 8707.608157632922, 9239.614057891371, 10585.735356615993, 10656.9875861793, 10707.304025238334, 198735.0, 199678.001609991, 485968.0, 594619.0, 601551.0, 104649.0, 126093.0, 126907.0, 134194.31611367717, 134954.0, 981.6858605246252, 982.4841957971979, 997.8403455447238, 1001.5743309093606, 1003.007023047178, 13223.396237715631, 16927.830721692626, 17722.645547088727, 17867.009026920572, 18208.635827283117, 47621.52378476309, 49561.75219123881, 50257.994840103725, 50492.49507504878, 50871.0, 62980.68509657423, 68602.31397685959, 73484.0, 73578.63210684127, 76711.61644191743, 8018.438709290293, 8028.1169071403265, 8104.83790324202, 8192.426530143071, 8428.45215061019, 11167.050800682033, 11451.942740286246, 11829.408529573659, 12549.811752823898, 12683.11218214716, 10549.103326217357, 10673.839892401775, 10677.626283080055, 10985.0, 11009.394483303495, 9038.322125840457, 10469.953004699773, 10530.894691052992, 10798.460076996276, 10979.670609881716, 10918.672439826818, 10990.17573681993, 11139.997400234019, 11264.887351126385, 11295.661130166109, 8090.352771778126, 8120.878186827321, 8165.755027349189, 8226.794330141794, 8498.065212826461, 8349.039860415887, 10691.625793097204, 10829.404382759023, 11117.888821112008, 11155.609553665583], "value": 9125.75151220296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1600.5598460423387, 1636.0, 1893.1480833624864, 1976.2193933396318, 1981.2669312354421, 7849.48978316409, 8071.434999550019, 8667.739967800968, 8920.553972301383, 8948.597313120908, 7744.380449564035, 8656.437331573443, 8678.39251252411, 8793.736187914357, 8811.735647930556, 2419.3467763703834, 2441.2066078524463, 2450.644656524803, 2451.3871532116973, 2453.0187924830034, 2418.238254949685, 2421.9394515137087, 2449.4243852694603, 2451.4239153798844, 2460.8031357491445, 2044.1925439451409, 2431.3070774829175, 2433.452473193535, 2448.6449464827588, 2450.179189971353, 2391.4021494626345, 2415.4565222824813, 2431.647411125377, 2434.793042591382, 2439.5852705040097, 2378.488624945645, 2415.4082249848725, 2415.4806716556027, 2418.3349578865777, 2422.031187525004, 8798.076201998761, 8850.0, 8871.822563548758, 8880.777980550538, 8899.421537600036, 4292.399064131024, 5359.464053594609, 5387.461253874581, 5433.510984011458, 5449.264349312872, 3542.2030043240065, 3550.5384300041087, 3630.945535816965, 3687.50218720472, 3711.406175012012, 1024.2522958240452, 1056.244784978736, 1061.7929503746773, 1068.028094434069, 1073.5330131392868, 11732.941335293353, 11794.52821887132, 11826.526938922432, 11833.763324733543, 11893.52425902963, 3811.294910441577, 4669.182892993713, 4889.731064791471, 4897.191963326011, 4901.0, 9991.500424978722, 10014.64948726791, 10027.247956403298, 10037.949810250902, 10038.347507411994, 5304.2839216706025, 5354.170103633943, 5369.838904832861, 5428.864278392993, 5431.592630552725, 4472.373867658531, 4790.353302304214, 4928.433230178575, 4950.628702847301, 4970.701757894538, 3972.82122304497, 4021.9945013746565, 4057.736247143926, 4095.5494895561465, 4157.48031496063, 1236.6104677026708, 1359.395069194199, 1383.3774801339437, 1384.231751377995, 1385.1550554161954, 778.43174482628, 830.8338332333436, 897.2552781191596, 914.4284821986258, 931.2410385535767, 5795.014847475939, 5892.292924849045, 5909.793157239476, 5933.2286802716235, 6019.638821670714, 959.1607343574373, 964.4068897627908, 970.6166064404662, 997.1374760831828, 1004.5730564510054, 2912.359280958186, 3513.8243087845503, 3753.343164946178, 3777.905552361158, 3957.4261732049267, 9806.656767013263, 10368.96310368957, 10611.09805666527, 10873.130149588014, 11062.22564420499, 10762.300450470695, 10957.56169753201, 11027.283226590245, 11033.448327583588, 11040.723981900355, 8242.17578242183, 8269.131741167212, 8276.379271554657, 8284.875726864102, 8412.8317433651, 5770.394108618535, 5807.216025836627, 5833.387494313036, 5891.307277291702, 5910.320313164041, 9924.751881203028, 10159.593616255266, 10232.64185753495, 10238.078572928473, 10375.16998640122, 10137.391756494633, 10296.0, 10386.844197336895, 10410.739731506774, 10473.63342283047, 6396.42432181106, 6779.72881084751, 6908.0, 7024.0, 7030.824229394306, 8215.589220539068, 8242.340612751086, 8271.379646526415, 8277.337812974827, 8410.201030902055, 7233.132024157135, 7351.963240183765, 7386.96306518464, 7472.850542989218, 7527.397808175223, 7233.457490688114, 7251.963740181265, 7301.744438944612, 7316.926830731837, 7350.77947661571, 6945.888657814726, 6960.47796415281, 6960.930390696029, 6966.651667416508, 6980.930190698231, 4761.785719642555, 4811.687240329367, 4858.732769697701, 4905.313256144072, 5068.70747959268, 4846.80612775485, 4899.902001960012, 4909.116359055404, 4998.6500944933505, 5119.334486516729], "value": 4615.351251285889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.8431626344959, 317.8966835778371, 322.9015150379135, 327.0972116957198, 327.9950800737991, 5213.66111202772, 5490.533304669108, 5746.706990927045, 5993.400659934005, 6310.873782524358, 5949.851253718648, 6039.637621742688, 6245.157678484847, 6258.812235632927, 6271.0, 4386.429764130667, 4388.771144079647, 4471.463424389078, 4477.283634618461, 4594.448666160066, 4222.218889505436, 4563.201439748047, 4628.352030715702, 4650.581447669709, 4672.532746725335, 3944.678532691552, 4613.284940834159, 4618.468876079261, 4643.744594047326, 4660.627149828023, 3968.0, 4388.275934470808, 4525.705829121097, 4612.3542704021465, 4637.350770892078, 3287.342531493711, 3977.2244412339605, 4004.4193591929006, 4006.2988976928923, 4013.9363068786793, 4635.1656701794, 5100.285959965608, 5459.481349271813, 5993.850153746148, 6057.575969682124, 4147.523034851, 4370.2570563004365, 4589.829593453648, 5272.92090618641, 5501.614886957915, 6499.447546958514, 6514.185726784152, 6546.279909209983, 6548.410643042149, 6589.571677840973, 3885.892520631635, 4058.939115913264, 4113.25961326961, 4339.956600433987, 4349.69552131351, 5980.551458640576, 6573.474122070223, 6728.42808361285, 6837.760678376283, 6956.408705260059, 3634.5638523376833, 3911.4523966644692, 4343.652507799368, 4377.277749171415, 4387.583179597933, 4129.009037830899, 4421.137878113801, 4424.203643344229, 4435.385161093698, 4455.353973673799, 4344.0, 4446.333050042519, 4557.154352487248, 4863.440704319049, 5287.444818294024, 5006.324146240284, 5812.779316343615, 6538.659574787157, 6679.432248258855, 6717.227518835299, 1039.6017356655286, 1345.4618152738788, 1499.9550013499613, 1548.3651702801797, 1558.306553583667, 752.3529764402609, 875.1642181716445, 959.5442164971582, 987.6148302162162, 995.0, 5516.503514683698, 6168.0439531872635, 6178.938210617926, 6179.938200618026, 6181.81454556364, 5847.883042339129, 6545.262602269781, 6793.388595026471, 6829.326814930374, 6831.555948863308, 5136.486351364833, 6115.205023346936, 6144.78493252734, 6152.846178845475, 6175.44421002112, 3227.193201699575, 3473.662639883663, 3620.8913732588067, 3633.5094762206763, 3638.7270954678506, 6453.451456626145, 6785.6428714257345, 7099.680514376762, 7119.89320160198, 7334.889976650355, 5725.282415275484, 6393.611385965446, 6750.594964302158, 6764.797056088227, 6862.451003919675, 7105.96447017772, 7267.38227250679, 7276.599787011659, 7303.48875578715, 7305.4341036851965, 5193.506616871391, 6035.668038257762, 6376.489880809431, 6670.132882725215, 6885.139357580302, 6112.786052488142, 6122.387761223842, 6687.665616719048, 6867.3476019778045, 6894.0025873737195, 5961.791337303173, 7030.402415794715, 7287.271272872882, 7294.343509084208, 7309.232530584212, 3677.5035370225746, 3807.7144214183495, 4404.251277282934, 4431.246688062973, 4439.889002774957, 6359.742291486641, 6689.331066893272, 6964.686589103401, 6976.372126508639, 6981.616011119234, 5797.8550536236935, 6213.502919766498, 6719.899201512079, 6754.3921047106, 6756.256811750802, 6406.775762848278, 6687.665616719048, 6709.93290067093, 6729.730810767514, 6757.594544327356, 5801.883962320646, 6225.408586184305, 6287.717052732546, 6498.830210562144, 6524.902126468011, 5515.145152501369, 6513.9058947001695, 6701.363370479991, 6705.39651431354, 6722.529422940347, 5349.598780091431, 6387.72245550901, 6496.545241833026, 6534.640594767334, 6585.934140658532], "value": 4677.474463465562, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.0465552787775, 669.3574168797953, 715.68867542619, 726.7456390263405, 729.9525530840498, 14985.0, 15048.322825472853, 15087.396504139835, 15187.848121518795, 15299.770503442458, 11648.184627076109, 13866.791998120036, 13965.44138234472, 13994.930025349859, 14664.266786660677, 917.1058218237199, 924.9491277979708, 928.8467402878517, 932.1377725603824, 932.5197523275518, 886.3573908916048, 888.8133491966662, 889.3063410539789, 926.8841394825647, 930.888293404789, 948.369334392628, 960.3133759362055, 975.8194733974237, 980.7744218829673, 985.5318723606301, 925.3984909808645, 927.7216834949488, 927.9907200928005, 959.1799011844842, 968.8740463739704, 690.3062422265591, 690.9827254318682, 691.4848437913736, 714.0681410758957, 728.7449392712562, 14292.928535357361, 14605.70788584233, 14726.779098313535, 14752.0, 14776.704465910729, 10910.836337454944, 12779.424925878358, 12803.295818729966, 13031.543895963596, 13790.931045344809, 10164.44095574743, 10197.164510388127, 10248.180145588334, 10280.845787313121, 10485.63300284494, 3462.913427164341, 3528.1003344147334, 3565.358235517606, 3598.5681718193982, 3608.2603066371594, 81951.590242049, 83886.0, 86390.0, 87361.12638873594, 87876.56061719714, 9607.279454040974, 9662.3719458235, 9697.933227344987, 9863.704088877344, 9957.253206009578, 21657.133714651554, 22599.774002260096, 22669.319920402413, 22710.886445567667, 23072.88463557705, 7511.136219334737, 7645.4648174628355, 7645.4648174628355, 7684.231576842271, 7920.84158316842, 4102.712810103324, 4161.146964872194, 4172.061286210578, 4195.979020104941, 4277.893052673646, 3596.0650230940146, 3628.582712987987, 3698.7595806272507, 3708.2212735325884, 3731.626837316301, 603.8218725475995, 644.4103645164622, 645.20639613275, 659.85153340498, 660.1022609251414, 562.8846086552329, 565.4712843491349, 572.6792995922214, 578.9189513468118, 594.0020765114649, 7891.447598668153, 7965.442419030728, 7982.361411087099, 8145.877811832827, 8216.178382161856, 558.8295569851153, 560.4479587606205, 570.5963330207653, 581.3082431906018, 596.8000719758843, 3288.5067239914206, 3422.435298175773, 3858.9421158682644, 3861.7489863158803, 3862.4978752761963, 88872.0, 89607.0, 90315.0, 90846.0, 91966.16067678743, 63043.6847815758, 65829.68340633257, 79742.40515189664, 81556.59221703853, 81912.62786349257, 48745.0, 67075.0, 68754.0, 69994.65002675056, 71066.22334441578, 5955.493783028491, 8112.472689275178, 8201.13888041771, 8277.83444331122, 8344.08215096351, 43405.78297108494, 43440.34839477347, 43950.90122746957, 44366.77816610896, 45196.77401612971, 62995.85020749036, 65338.673306635064, 65537.67231163813, 65762.0, 66593.66922157702, 10974.835377469184, 11078.889211107786, 11140.777184456427, 11353.602623908124, 11451.48468318911, 10232.846507302247, 10848.825164912832, 11762.647120586396, 11788.646340609452, 11825.822612660644, 11257.21199516026, 11467.31196128235, 11552.075833933097, 11632.18574699763, 11997.76004479923, 9597.47213903242, 11037.337759734442, 11265.380404077527, 11522.769544608893, 12352.197107188003, 9715.125638692552, 10954.726131846768, 11103.16726245551, 11169.994700476997, 11710.414479275832, 9206.769830754285, 9303.023182565734, 9389.577469013775, 9399.248060155034, 9637.036296370306, 9013.233875120688, 9526.52367381642, 9548.952255238679, 9565.378250413702, 9584.28117891147], "value": 6833.919720732176, "unit": "score"}], "name": "dromaeo_css", "value": 7282.30871929142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 116.0, 116.0, 116.0, 128.0, 115.0, 115.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 142.0, 160.0, 120.0, 141.0, 141.0, 124.0, 188.0, 117.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 195.0, 214.0, 232.0, 196.0, 201.0, 196.0, 199.0, 196.0], "value": 202.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 82.0, 111.0, 60.0, 79.0, 83.0, 85.0, 138.0, 71.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 123.0, 75.0, 83.0, 90.0, 122.0, 84.0, 105.0, 168.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 89.0, 87.0, 91.0, 86.0, 89.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 90.0, 91.0, 91.0, 89.0, 91.0, 89.0, 92.0, 120.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 84.0, 93.0, 95.0, 85.0, 95.0, 73.0, 64.0, 61.0], "value": 76.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 72.0, 77.0, 74.0, 68.0, 71.0, 64.0, 85.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 82.0, 84.0, 83.0, 84.0, 86.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 160.0, 157.0, 157.0, 145.0, 135.0, 136.0, 221.0, 142.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 169.0, 173.0, 166.0, 170.0, 176.0, 172.0, 165.0, 184.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 68.0, 70.0, 71.0, 70.0, 69.0, 67.0, 75.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1548.8000000000002, "alertThreshold": 2.0}]} 14:57:00 INFO - Return code: 0 14:57:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:57:00 ERROR - # TBPL SUCCESS # 14:57:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:57:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:57:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:57:00 INFO - 2016-04-19 14:57:00.934 screenresolution[1679:10208] starting screenresolution argv=screenresolution get 14:57:00 INFO - 2016-04-19 14:57:00.936 screenresolution[1679:10208] Display 0: 1600x1200x32@60 14:57:00 INFO - 2016-04-19 14:57:00.942 screenresolution[1680:10211] starting screenresolution argv=screenresolution list 14:57:00 INFO - Available Modes on Display 0 14:57:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:57:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:57:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:57:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:57:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:57:01 INFO - Intel Iris: 14:57:01 INFO - Chipset Model: Intel Iris 14:57:01 INFO - Type: GPU 14:57:01 INFO - Bus: Built-In 14:57:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:57:01 INFO - Vendor: Intel (0x8086) 14:57:01 INFO - Device ID: 0x0a2e 14:57:01 INFO - Revision ID: 0x0009 14:57:01 INFO - Displays: 14:57:01 INFO - Display: 14:57:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:57:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:57:01 INFO - Display Serial Number: 1600x1200 60 14:57:01 INFO - Main Display: Yes 14:57:01 INFO - Mirror: Off 14:57:01 INFO - Online: Yes 14:57:01 INFO - Rotation: Supported 14:57:01 INFO - Return code: 0 14:57:01 INFO - Running post-action listener: _resource_record_post_action 14:57:01 INFO - Running post-run listener: _resource_record_post_run 14:57:02 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37242368; Write bytes: 695476224; Read time: 389; Write time: 2170 14:57:02 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 394447360; Write bytes: 388838912; Read time: 29344; Write time: 755 14:57:02 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 35427840; Write bytes: 297392640; Read time: 370; Write time: 1381 14:57:02 INFO - Running post-run listener: _upload_blobber_files 14:57:02 INFO - Blob upload gear active. 14:57:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:57:02 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 14:57:02 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:57:02 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:57:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:57:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:03 INFO - (blobuploader) - INFO - Done attempting. 14:57:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:57:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:05 INFO - (blobuploader) - INFO - Done attempting. 14:57:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:57:05 INFO - Return code: 0 14:57:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:57:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:57:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f47ad581059d26014047a1bb3ec10f782e92dc8489e72dd690ba541b5f2d309ccf8efb5eba623f928001d590dbb8f5848efd96d5bb4e74dab8e4c36020dbcc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f964bbb955f1bf94318170cda83f1c0bafa6627c42727c080fe9f7f857db92aa29da0c7c984b5254684c145478601ebdcd825bdcf1e28f7f0e38dc054b512"} 14:57:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:57:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:57:05 INFO - Contents: 14:57:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f47ad581059d26014047a1bb3ec10f782e92dc8489e72dd690ba541b5f2d309ccf8efb5eba623f928001d590dbb8f5848efd96d5bb4e74dab8e4c36020dbcc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f964bbb955f1bf94318170cda83f1c0bafa6627c42727c080fe9f7f857db92aa29da0c7c984b5254684c145478601ebdcd825bdcf1e28f7f0e38dc054b512"} 14:57:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:57:05 INFO - Copying logs to upload dir... 14:57:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:57:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.821567 ========= master_lag: 1.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-19 14:57:06.612761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 14:57:06.616487) ========= 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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f47ad581059d26014047a1bb3ec10f782e92dc8489e72dd690ba541b5f2d309ccf8efb5eba623f928001d590dbb8f5848efd96d5bb4e74dab8e4c36020dbcc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f964bbb955f1bf94318170cda83f1c0bafa6627c42727c080fe9f7f857db92aa29da0c7c984b5254684c145478601ebdcd825bdcf1e28f7f0e38dc054b512"} build_url:https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/ZRVP-UwORtehXbmQYGyNhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f47ad581059d26014047a1bb3ec10f782e92dc8489e72dd690ba541b5f2d309ccf8efb5eba623f928001d590dbb8f5848efd96d5bb4e74dab8e4c36020dbcc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/607f964bbb955f1bf94318170cda83f1c0bafa6627c42727c080fe9f7f857db92aa29da0c7c984b5254684c145478601ebdcd825bdcf1e28f7f0e38dc054b512"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 14:57:06.953944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-19 14:57:06.954248) ========= 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.VhlSjJFiA0/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.5Yzeo2erhO/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.004928 ========= master_lag: 3.91 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-19 14:57:10.872494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 14:57:10.872821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 14:57:10.952719) ========= ========= Total master_lag: 6.85 =========