builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0045 starttime: 1461596961.85 results: success (0) buildid: 20160425053553 builduid: 1d95cc054ffb4593add8611da7987a93 revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:21.854549) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:21.854941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:21.855227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:21.882882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:21.883245) ========= 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.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-25 08:09:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2016-04-25 08:09:22 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:22.026974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:22.030357) ========= 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.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.020037 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:22.079139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 08:09:22.082592) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --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 0f07f975526f3abda2f997bbb2feb0a25f771227 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-25 08:09:22,398 truncating revision to first 12 chars 2016-04-25 08:09:22,399 Setting DEBUG logging. 2016-04-25 08:09:22,399 attempt 1/10 2016-04-25 08:09:22,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f07f975526f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 08:09:23,457 unpacking tar archive at: fx-team-0f07f975526f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.303815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 08:09:23.404951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:23.405285) ========= script_repo_revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:23.405700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:23.409095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 08:09:23.428221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-04-25 08:09:23.428531) ========= /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.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:09:23 INFO - MultiFileLogger online at 20160425 08:09:23 in /builds/slave/test 08:09:23 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 08:09:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:23 INFO - {'append_to_log': False, 08:09:23 INFO - 'base_work_dir': '/builds/slave/test', 08:09:23 INFO - 'blob_upload_branch': 'Fx-Team', 08:09:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:23 INFO - 'branch': 'Fx-Team', 08:09:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:23 INFO - 'config_files': ('talos/mac_config.py',), 08:09:23 INFO - 'default_actions': ('clobber', 08:09:23 INFO - 'read-buildbot-config', 08:09:23 INFO - 'download-and-extract', 08:09:23 INFO - 'populate-webroot', 08:09:23 INFO - 'create-virtualenv', 08:09:23 INFO - 'install', 08:09:23 INFO - 'run-tests'), 08:09:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:23 INFO - 'download_minidump_stackwalk': True, 08:09:23 INFO - 'download_symbols': 'ondemand', 08:09:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:23 INFO - 'installer_path': 'installer.exe', 08:09:23 INFO - 'log_level': 'info', 08:09:23 INFO - 'log_name': 'talos', 08:09:23 INFO - 'log_to_console': True, 08:09:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:09:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:09:23 INFO - 'opt_config_files': (), 08:09:23 INFO - 'pip_index': False, 08:09:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:23 INFO - 'cmd': ('bash', 08:09:23 INFO - '-c', 08:09:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:23 INFO - 'enabled': True, 08:09:23 INFO - 'halt_on_failure': False, 08:09:23 INFO - 'name': 'check_screen_resolution'},), 08:09:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:23 INFO - 'cmd': ('bash', 08:09:23 INFO - '-c', 08:09:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:23 INFO - 'enabled': True, 08:09:23 INFO - 'halt_on_failure': False, 08:09:23 INFO - 'name': 'check_screen_resolution'},), 08:09:23 INFO - 'run_cmd_checks_enabled': True, 08:09:23 INFO - 'sps_profile': False, 08:09:23 INFO - 'sps_profile_interval': 0, 08:09:23 INFO - 'suite': 'dromaeojs-e10s', 08:09:23 INFO - 'system_bits': '32', 08:09:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:23 INFO - 'title': 't-yosemite-r7-0045', 08:09:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:23 INFO - 'use_talos_json': True, 08:09:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:23 INFO - 'work_dir': 'build'} 08:09:23 INFO - ##### 08:09:23 INFO - ##### Running clobber step. 08:09:23 INFO - ##### 08:09:23 INFO - Running pre-action listener: _resource_record_pre_action 08:09:23 INFO - Running main action method: clobber 08:09:23 INFO - rmtree: /builds/slave/test/build 08:09:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:24 INFO - Running post-action listener: _resource_record_post_action 08:09:24 INFO - ##### 08:09:24 INFO - ##### Running read-buildbot-config step. 08:09:24 INFO - ##### 08:09:24 INFO - Running pre-action listener: _resource_record_pre_action 08:09:24 INFO - Running main action method: read_buildbot_config 08:09:24 INFO - Using buildbot properties: 08:09:24 INFO - { 08:09:24 INFO - "project": "", 08:09:24 INFO - "product": "firefox", 08:09:24 INFO - "script_repo_revision": "production", 08:09:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:09:24 INFO - "repository": "", 08:09:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:09:24 INFO - "buildid": "20160425053553", 08:09:24 INFO - "pgo_build": "False", 08:09:24 INFO - "basedir": "/builds/slave/test", 08:09:24 INFO - "buildnumber": 726, 08:09:24 INFO - "slavename": "t-yosemite-r7-0045", 08:09:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:09:24 INFO - "platform": "yosemite_r7", 08:09:24 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:09:24 INFO - "branch": "fx-team", 08:09:24 INFO - "repo_path": "integration/fx-team", 08:09:24 INFO - "revision": "0f07f975526f3abda2f997bbb2feb0a25f771227", 08:09:24 INFO - "stage_platform": "macosx64", 08:09:24 INFO - "builduid": "1d95cc054ffb4593add8611da7987a93", 08:09:24 INFO - "slavebuilddir": "test" 08:09:24 INFO - } 08:09:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:09:24 INFO - Running post-action listener: _resource_record_post_action 08:09:24 INFO - ##### 08:09:24 INFO - ##### Running download-and-extract step. 08:09:24 INFO - ##### 08:09:24 INFO - Running pre-action listener: _resource_record_pre_action 08:09:24 INFO - Running main action method: download_and_extract 08:09:24 INFO - mkdir: /builds/slave/test/build/tests 08:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:24 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:44 INFO - Downloaded 1199 bytes. 08:09:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:09:44 INFO - Using the following test package requirements: 08:09:44 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:09:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:09:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:09:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'jsshell-mac.zip'], 08:09:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:09:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:09:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:09:44 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:09:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:09:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:09:44 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:09:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:09: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')]} 08:09:44 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:52 INFO - Downloaded 18111316 bytes. 08:09:52 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'] 08:09:52 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 08:09:55 INFO - Return code: 0 08:09:55 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 08:09:55 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')]} 08:09:55 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:09:57 INFO - Downloaded 18111316 bytes. 08:09:57 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'] 08:09:57 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 08:10:00 INFO - Return code: 0 08:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:00 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:10:01 INFO - Downloaded 10840145 bytes. 08:10:01 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'] 08:10:01 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 08:10:02 INFO - Return code: 0 08:10:02 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')]} 08:10:02 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/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 08:10:06 INFO - Downloaded 110147975 bytes. 08:10:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:10:06 INFO - mkdir: /builds/slave/test/properties 08:10:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:06 INFO - Contents: 08:10:06 INFO - build_url:https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:10:07 INFO - Running post-action listener: _resource_record_post_action 08:10:07 INFO - Running post-action listener: set_extra_try_arguments 08:10:07 INFO - ##### 08:10:07 INFO - ##### Running populate-webroot step. 08:10:07 INFO - ##### 08:10:07 INFO - Running pre-action listener: _resource_record_pre_action 08:10:07 INFO - Running main action method: populate_webroot 08:10:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:07 INFO - '--tppagecycles', 08:10:07 INFO - '7'], 08:10:07 INFO - 'tests': ['tsvgm']}}, 08:10:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['damp', 'tps']}, 08:10:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'tests': ['damp', 'tps']}, 08:10:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['dromaeo_dom']}, 08:10:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['a11yr', 08:10:07 INFO - 'ts_paint', 08:10:07 INFO - 'tpaint', 08:10:07 INFO - 'sessionrestore', 08:10:07 INFO - 'sessionrestore_no_auto_restore', 08:10:07 INFO - 'tabpaint']}, 08:10:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['tsvgx', 08:10:07 INFO - 'tsvgr_opacity', 08:10:07 INFO - 'tart', 08:10:07 INFO - 'tscrollx', 08:10:07 INFO - 'cart']}, 08:10:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:07 INFO - 'tsvgr_opacity', 08:10:07 INFO - 'tart', 08:10:07 INFO - 'tscrollx', 08:10:07 INFO - 'cart']}, 08:10:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'talos_options': ['--disable-e10s'], 08:10:07 INFO - 'tests': ['tp5o']}, 08:10:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'tests': ['tp5o']}, 08:10:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'talos_options': ['--disable-e10s', 08:10:07 INFO - '--xperf_path', 08:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:07 INFO - 'tests': ['tp5n']}, 08:10:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:07 INFO - 'talos_options': ['--xperf_path', 08:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:07 INFO - 'tests': ['tp5n']}}, 08:10:07 INFO - 'talos.zip': {'path': '', 08:10:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:07 INFO - Running post-action listener: _resource_record_post_action 08:10:07 INFO - ##### 08:10:07 INFO - ##### Running create-virtualenv step. 08:10:07 INFO - ##### 08:10:07 INFO - Running pre-action listener: _resource_record_pre_action 08:10:07 INFO - Running main action method: create_virtualenv 08:10:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:07 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 08:10:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:07 INFO - Using real prefix '/tools/python27' 08:10:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:10 INFO - Installing pip.................done. 08:10:10 INFO - Return code: 0 08:10:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:10 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')]} 08:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:10 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')]} 08:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:10 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 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:10 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 08:10:10 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 08:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:10 INFO - 'HOME': '/Users/cltbld', 08:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:10 INFO - 'LOGNAME': 'cltbld', 08:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:10 INFO - 'MOZ_NO_REMOTE': '1', 08:10:10 INFO - 'NO_EM_RESTART': '1', 08:10:10 INFO - 'PAGER': '/bin/cat', 08:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:10 INFO - 'PWD': '/builds/slave/test', 08:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:10 INFO - 'SHELL': '/bin/bash', 08:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:10 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:10 INFO - 'USER': 'cltbld', 08:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:10 INFO - 'XPC_FLAGS': '0x0', 08:10:10 INFO - 'XPC_SERVICE_NAME': '0', 08:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:11 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 08:10:11 INFO - Cleaning up... 08:10:11 INFO - Return code: 0 08:10:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:11 INFO - 'HOME': '/Users/cltbld', 08:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:11 INFO - 'LOGNAME': 'cltbld', 08:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:11 INFO - 'MOZ_NO_REMOTE': '1', 08:10:11 INFO - 'NO_EM_RESTART': '1', 08:10:11 INFO - 'PAGER': '/bin/cat', 08:10:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:11 INFO - 'PWD': '/builds/slave/test', 08:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:11 INFO - 'SHELL': '/bin/bash', 08:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:11 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:11 INFO - 'USER': 'cltbld', 08:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:11 INFO - 'XPC_FLAGS': '0x0', 08:10:11 INFO - 'XPC_SERVICE_NAME': '0', 08:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:11 INFO - Downloading/unpacking psutil>=0.7.1 08:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:14 INFO - Installing collected packages: psutil 08:10:14 INFO - Running setup.py install for psutil 08:10:14 INFO - building 'psutil._psutil_osx' extension 08:10:14 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 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 INFO - building 'psutil._psutil_posix' extension 08:10:15 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 08:10:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:10:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:10:15 INFO - ^ 08:10:15 INFO - 1 warning generated. 08:10:15 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 08:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:15 INFO - Successfully installed psutil 08:10:15 INFO - Cleaning up... 08:10:15 INFO - Return code: 0 08:10:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:15 INFO - 'HOME': '/Users/cltbld', 08:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:15 INFO - 'LOGNAME': 'cltbld', 08:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:15 INFO - 'MOZ_NO_REMOTE': '1', 08:10:15 INFO - 'NO_EM_RESTART': '1', 08:10:15 INFO - 'PAGER': '/bin/cat', 08:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:15 INFO - 'PWD': '/builds/slave/test', 08:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:15 INFO - 'SHELL': '/bin/bash', 08:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:15 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:15 INFO - 'USER': 'cltbld', 08:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:15 INFO - 'XPC_FLAGS': '0x0', 08:10:15 INFO - 'XPC_SERVICE_NAME': '0', 08:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:10:18 INFO - Installing collected packages: mozsystemmonitor 08:10:18 INFO - Running setup.py install for mozsystemmonitor 08:10:18 INFO - Successfully installed mozsystemmonitor 08:10:18 INFO - Cleaning up... 08:10:19 INFO - Return code: 0 08:10:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:19 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')]} 08:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:19 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')]} 08:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:19 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 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:19 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 08:10:19 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 08:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:19 INFO - 'HOME': '/Users/cltbld', 08:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:19 INFO - 'LOGNAME': 'cltbld', 08:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:19 INFO - 'MOZ_NO_REMOTE': '1', 08:10:19 INFO - 'NO_EM_RESTART': '1', 08:10:19 INFO - 'PAGER': '/bin/cat', 08:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:19 INFO - 'PWD': '/builds/slave/test', 08:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:19 INFO - 'SHELL': '/bin/bash', 08:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:19 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:19 INFO - 'USER': 'cltbld', 08:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:19 INFO - 'XPC_FLAGS': '0x0', 08:10:19 INFO - 'XPC_SERVICE_NAME': '0', 08:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:22 INFO - Downloading docopt-0.6.1.tar.gz 08:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:23 INFO - Running setup.py install for blobuploader 08:10:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:23 INFO - Running setup.py install for requests 08:10:23 INFO - Running setup.py install for docopt 08:10:23 INFO - Successfully installed blobuploader requests docopt 08:10:23 INFO - Cleaning up... 08:10:23 INFO - Return code: 0 08:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:23 INFO - 'HOME': '/Users/cltbld', 08:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:23 INFO - 'LOGNAME': 'cltbld', 08:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:23 INFO - 'MOZ_NO_REMOTE': '1', 08:10:23 INFO - 'NO_EM_RESTART': '1', 08:10:23 INFO - 'PAGER': '/bin/cat', 08:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:23 INFO - 'PWD': '/builds/slave/test', 08:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:23 INFO - 'SHELL': '/bin/bash', 08:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:23 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:23 INFO - 'USER': 'cltbld', 08:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:23 INFO - 'XPC_FLAGS': '0x0', 08:10:23 INFO - 'XPC_SERVICE_NAME': '0', 08:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-7eoXhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-DLAYPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Oh6dkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-QpOMYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Z0FDUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-FiTHCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-tDmlZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ofadvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zAo2Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-VjKCMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-pDPAJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-BdOqTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-VSHkFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-_zUQBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-vD_9Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3PYzJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-oKkpRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:25 INFO - Running setup.py install for manifestparser 08:10:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:26 INFO - Running setup.py install for mozcrash 08:10:26 INFO - Running setup.py install for mozdebug 08:10:26 INFO - Running setup.py install for mozdevice 08:10:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:26 INFO - Running setup.py install for mozfile 08:10:26 INFO - Running setup.py install for mozhttpd 08:10:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:26 INFO - Running setup.py install for mozinfo 08:10:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:26 INFO - Running setup.py install for mozInstall 08:10:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Running setup.py install for mozleak 08:10:27 INFO - Running setup.py install for mozlog 08:10:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Running setup.py install for moznetwork 08:10:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Running setup.py install for mozprocess 08:10:27 INFO - Running setup.py install for mozprofile 08:10:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:27 INFO - Running setup.py install for mozrunner 08:10:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:28 INFO - Running setup.py install for mozscreenshot 08:10:28 INFO - Running setup.py install for moztest 08:10:28 INFO - Running setup.py install for mozversion 08:10:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:28 INFO - Cleaning up... 08:10:28 INFO - Return code: 0 08:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:28 INFO - 'HOME': '/Users/cltbld', 08:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:28 INFO - 'LOGNAME': 'cltbld', 08:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:28 INFO - 'MOZ_NO_REMOTE': '1', 08:10:28 INFO - 'NO_EM_RESTART': '1', 08:10:28 INFO - 'PAGER': '/bin/cat', 08:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:28 INFO - 'PWD': '/builds/slave/test', 08:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:28 INFO - 'SHELL': '/bin/bash', 08:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:28 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:28 INFO - 'USER': 'cltbld', 08:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:28 INFO - 'XPC_FLAGS': '0x0', 08:10:28 INFO - 'XPC_SERVICE_NAME': '0', 08:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:28 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ZCPwks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:28 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Zy3uhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:28 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-SjALPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:29 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)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-0VchLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:29 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)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-uOsFSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:29 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)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wVl_LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3ryk5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-GRJBQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-QsieQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-JM9YUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:29 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)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-HPzLip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-FQ9G9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:29 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)) 08:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:29 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-bfqjxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:30 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)) 08:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:30 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-jVF0Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:30 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)) 08:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:30 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-AekLQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:30 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)) 08:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:30 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-52uJ5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:30 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-og5rPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:10:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10:32 INFO - Downloading blessings-1.6.tar.gz 08:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:33 INFO - Installing collected packages: blessings 08:10:33 INFO - Running setup.py install for blessings 08:10:33 INFO - Successfully installed blessings 08:10:33 INFO - Cleaning up... 08:10:33 INFO - Return code: 0 08:10:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:33 INFO - Reading from file tmpfile_stdout 08:10:33 INFO - Current package versions: 08:10:33 INFO - blessings == 1.6 08:10:33 INFO - blobuploader == 1.2.4 08:10:33 INFO - docopt == 0.6.1 08:10:33 INFO - manifestparser == 1.1 08:10:33 INFO - mozInstall == 1.12 08:10:33 INFO - mozcrash == 0.17 08:10:33 INFO - mozdebug == 0.1 08:10:33 INFO - mozdevice == 0.48 08:10:33 INFO - mozfile == 1.2 08:10:33 INFO - mozhttpd == 0.7 08:10:33 INFO - mozinfo == 0.9 08:10:33 INFO - mozleak == 0.1 08:10:33 INFO - mozlog == 3.1 08:10:33 INFO - moznetwork == 0.27 08:10:33 INFO - mozprocess == 0.22 08:10:33 INFO - mozprofile == 0.28 08:10:33 INFO - mozrunner == 6.11 08:10:33 INFO - mozscreenshot == 0.1 08:10:33 INFO - mozsystemmonitor == 0.0 08:10:33 INFO - moztest == 0.7 08:10:33 INFO - mozversion == 1.4 08:10:33 INFO - psutil == 3.1.1 08:10:33 INFO - requests == 1.2.3 08:10:33 INFO - wsgiref == 0.1.2 08:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:33 INFO - 'HOME': '/Users/cltbld', 08:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PAGER': '/bin/cat', 08:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:33 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - 'XPC_FLAGS': '0x0', 08:10:33 INFO - 'XPC_SERVICE_NAME': '0', 08:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:10:33 INFO - Cleaning up... 08:10:33 INFO - Return code: 0 08:10:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:33 INFO - 'HOME': '/Users/cltbld', 08:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PAGER': '/bin/cat', 08:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:33 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - 'XPC_FLAGS': '0x0', 08:10:33 INFO - 'XPC_SERVICE_NAME': '0', 08:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:34 INFO - Downloading/unpacking jsonschema 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:37 INFO - warning: no files found matching '*.txt' 08:10:37 INFO - no previously-included directories found matching 'build' 08:10:37 INFO - no previously-included directories found matching 'dist' 08:10:37 INFO - no previously-included directories found matching '.git*' 08:10:37 INFO - Installing collected packages: jsonschema, functools32 08:10:37 INFO - Running setup.py install for functools32 08:10:37 INFO - warning: no files found matching '*.txt' 08:10:37 INFO - no previously-included directories found matching 'build' 08:10:37 INFO - no previously-included directories found matching 'dist' 08:10:37 INFO - no previously-included directories found matching '.git*' 08:10:37 INFO - Successfully installed jsonschema functools32 08:10:37 INFO - Cleaning up... 08:10:37 INFO - Return code: 0 08:10:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a846a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, '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.bFk354x29Y/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.sGW0gMYvxP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 08:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:37 INFO - 'HOME': '/Users/cltbld', 08:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:37 INFO - 'LOGNAME': 'cltbld', 08:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:37 INFO - 'MOZ_NO_REMOTE': '1', 08:10:37 INFO - 'NO_EM_RESTART': '1', 08:10:37 INFO - 'PAGER': '/bin/cat', 08:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:37 INFO - 'PWD': '/builds/slave/test', 08:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:37 INFO - 'SHELL': '/bin/bash', 08:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:10:37 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:37 INFO - 'USER': 'cltbld', 08:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:37 INFO - 'XPC_FLAGS': '0x0', 08:10:37 INFO - 'XPC_SERVICE_NAME': '0', 08:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:37 INFO - Downloading/unpacking flake8 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:37 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 08:10:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:10:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:10:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:41 INFO - no previously-included directories found matching 'docs/_build' 08:10:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:10:41 INFO - Running setup.py install for pep8 08:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:41 INFO - no previously-included directories found matching 'docs/_build' 08:10:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:10:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:10:41 INFO - Cleaning up... 08:10:41 INFO - Return code: 0 08:10:41 INFO - Running post-action listener: _resource_record_post_action 08:10:41 INFO - Running post-action listener: _start_resource_monitoring 08:10:41 INFO - Starting resource monitoring. 08:10:41 INFO - ##### 08:10:41 INFO - ##### Running install step. 08:10:41 INFO - ##### 08:10:41 INFO - Running pre-action listener: _resource_record_pre_action 08:10:41 INFO - Running main action method: install 08:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:41 INFO - Reading from file tmpfile_stdout 08:10:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:41 INFO - Reading from file tmpfile_stdout 08:10:41 INFO - Output received: 08:10:41 INFO - Usage: mozinstall [options] installer 08:10:41 INFO - Options: 08:10:41 INFO - -h, --help show this help message and exit 08:10:41 INFO - -d DEST, --destination=DEST 08:10:41 INFO - Directory to install application into. [default: 08:10:41 INFO - "/builds/slave/test"] 08:10:41 INFO - --app=APP Application being installed. [default: firefox] 08:10:41 INFO - mkdir: /builds/slave/test/build/application 08:10:41 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'] 08:10:41 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 08:11:15 INFO - Reading from file tmpfile_stdout 08:11:15 INFO - Output received: 08:11:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:11:15 INFO - Running post-action listener: _resource_record_post_action 08:11:15 INFO - ##### 08:11:15 INFO - ##### Running run-tests step. 08:11:15 INFO - ##### 08:11:15 INFO - Running pre-action listener: _resource_record_pre_action 08:11:15 INFO - Running main action method: run_tests 08:11:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:15 INFO - 2016-04-25 08:11:15.583 screenresolution[6346:102039] starting screenresolution argv=screenresolution get 08:11:15 INFO - 2016-04-25 08:11:15.586 screenresolution[6346:102039] Display 0: 1600x1200x32@60 08:11:15 INFO - 2016-04-25 08:11:15.592 screenresolution[6347:102041] starting screenresolution argv=screenresolution list 08:11:15 INFO - Available Modes on Display 0 08:11:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:15 INFO - Intel Iris: 08:11:15 INFO - Chipset Model: Intel Iris 08:11:15 INFO - Type: GPU 08:11:15 INFO - Bus: Built-In 08:11:15 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:15 INFO - Vendor: Intel (0x8086) 08:11:15 INFO - Device ID: 0x0a2e 08:11:15 INFO - Revision ID: 0x0009 08:11:15 INFO - Displays: 08:11:15 INFO - Display: 08:11:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:15 INFO - Display Serial Number: 1600x1200 60 08:11:15 INFO - Main Display: Yes 08:11:15 INFO - Mirror: Off 08:11:15 INFO - Online: Yes 08:11:15 INFO - Rotation: Supported 08:11:15 INFO - Return code: 0 08:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:15 INFO - Python 2.7.3 08:11:15 INFO - Return code: 0 08:11:15 INFO - grabbing minidump binary from tooltool 08:11: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')]} 08:11:15 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 0x109deee00>, '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 0x109c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109de9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:15 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 08:11:15 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 08:11:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:15 INFO - Return code: 0 08:11:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:11:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:11:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:11:17 INFO - Return code: 0 08:11:17 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/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 08:11:17 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/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --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 08:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFk354x29Y/Render', 08:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:17 INFO - 'HOME': '/Users/cltbld', 08:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:17 INFO - 'LOGNAME': 'cltbld', 08:11:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:17 INFO - 'MOZ_NO_REMOTE': '1', 08:11:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:17 INFO - 'NO_EM_RESTART': '1', 08:11:17 INFO - 'PAGER': '/bin/cat', 08:11:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:17 INFO - 'PWD': '/builds/slave/test', 08:11:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:17 INFO - 'SHELL': '/bin/bash', 08:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGW0gMYvxP/Listeners', 08:11:17 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 08:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:17 INFO - 'USER': 'cltbld', 08:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:17 INFO - 'XPC_FLAGS': '0x0', 08:11:17 INFO - 'XPC_SERVICE_NAME': '0', 08:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:17 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/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 08:11:17 INFO - mozversion application_buildid: 20160425053553 08:11:17 INFO - mozversion application_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 08:11:17 INFO - mozversion application_display_name: Nightly 08:11:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:17 INFO - mozversion application_name: Firefox 08:11:17 INFO - mozversion application_remotingname: firefox 08:11:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:17 INFO - mozversion application_vendor: Mozilla 08:11:17 INFO - mozversion application_version: 48.0a1 08:11:17 INFO - mozversion platform_buildid: 20160425053553 08:11:17 INFO - mozversion platform_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 08:11:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:17 INFO - mozversion platform_version: 48.0a1 08:11:17 INFO - using testdate: 1461597077 08:11:17 INFO - actual date: 1461597077 08:11:17 INFO - starting webserver on 'localhost:54448' 08:11:17 INFO - SUITE-START | Running 2 tests 08:11:17 INFO - TEST-START | dromaeo_css 08:11:17 INFO - operating with platform_type : mac_ 08:11:17 INFO - Initialising browser for dromaeo_css test... 08:11:17 INFO - TEST-INFO | started process 6365 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpX_Oe4g/profile http://localhost:54448/getInfo.html) 08:11:20 INFO - PROCESS | 6365 | __metrics Screen width/height:1600/1200 08:11:20 INFO - PROCESS | 6365 | colorDepth:24 08:11:20 INFO - PROCESS | 6365 | Browser inner width/height: 1024/689 08:11:20 INFO - PROCESS | 6365 | __metrics 08:11:20 ERROR - PROCESS | 6365 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:11:20 INFO - TEST-INFO | 6365: exit 0 08:11:20 INFO - Browser initialized. 08:11:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:20 INFO - TEST-INFO | started process 6369 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpX_Oe4g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:32 INFO - PROCESS | 6369 | RSS: Main: 249667584 08:11:32 INFO - PROCESS | 6369 | 08:12:22 INFO - PROCESS | 6369 | 1461597142600 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:14:34 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54448/tests/dromaeo/cssquery-ext.html) 08:14:35 INFO - PROCESS | 6369 | RSS: Main: 261922816 08:14:35 INFO - PROCESS | 6369 | 08:17:37 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-ext.html (next: http://localhost:54448/tests/dromaeo/cssquery-jquery.html) 08:17:38 INFO - PROCESS | 6369 | RSS: Main: 274264064 08:17:38 INFO - PROCESS | 6369 | 08:20:40 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54448/tests/dromaeo/cssquery-mootools.html) 08:20:40 INFO - PROCESS | 6369 | RSS: Main: 275660800 08:20:40 INFO - PROCESS | 6369 | 08:23:42 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54448/tests/dromaeo/cssquery-prototype.html) 08:23:43 INFO - PROCESS | 6369 | RSS: Main: 277225472 08:23:43 INFO - PROCESS | 6369 | 08:26:45 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54448/tests/dromaeo/cssquery-yui.html) 08:26:46 INFO - PROCESS | 6369 | RSS: Main: 279990272 08:26:46 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | Cycle 1(1): loaded http://localhost:54448/tests/dromaeo/cssquery-yui.html (next: http://localhost:54448/tests/dromaeo/cssquery-dojo.html) 08:29:49 INFO - PROCESS | 6369 | RSS: Main: 281268224 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | __start_tp_report 08:29:49 INFO - PROCESS | 6369 | _x_x_mozilla_page_load 08:29:49 INFO - PROCESS | 6369 | _x_x_mozilla_page_load_details 08:29:49 INFO - PROCESS | 6369 | |i|pagename|runs| 08:29:49 INFO - PROCESS | 6369 | |0;dojo.html;3448.7930724156554;3461.2385275239444;3476.5480487536615;3483.860645574177;3512.7541072124964;4732.550407711262;5661.631993920392;5667.433256674331;5749.080147176453;5758.165066065418;5707.286589176353;5822.7088645567765;5845.970770146143;5894.410558944114;5924.940750592493;5112.97443512782;5203.583713302926;5214.634975551713;5246.606504512168;5277.683338999653;4323.2218200723855;4388.341748737683;4709.546594400294;5247.1866860636665;5337.386200586943;4361.386212488259;5154.5103215194495;5256.710880901549;5266.552343050846;5339.359276886779;5188.169892817131;5214.765335559909;5219.660722053054;5251.553617942442;5276.630635855492;4761.833335833229;4889.486603906575;5139.0749665060275;5145.974270128663;5204.76578553966;5617.325920889479;5643.717814109319;5758.049921762904;5761.279840019997;5799.971000145015;6103.717529324765;6120.938790612081;6150.538709596798;6163.414475624853;6193.87612247757;6250.499960003189;6253.937460625381;6265.498760099181;6271.96864015677;6297.401746834089;4874.731889746027;5780.16187652788;5792.536597072224;5914.349421563625;5928.199693041427;6287.622742635456;6334.176557047646;6336.778212762623;6352.841178970562;6357.237131544244;6220.782272620437;6223.875522489525;6228.844278892973;6232.719527621268;6241.906371404432;6054.697265136726;6174.8147555573405;6182.443580077815;6243.063540468966;6260.530460215502;6183.690815459209;6209.161763161916;6229.408206220402;6242.687865606701;6243.313235544087;6199.380061993765;6218.471429928416;6243.0635404688755;6248.31268560458;6253.843653908689;4840.975795121002;4897.118518666674;4956.281339205795;4977.601791856715;4989.426215985136;4394.824207031683;4415.940174358131;4422.137683151819;4452.0873220989615;4453.287474004209;5871.882562348729;5875.882482350415;5899.469047785634;5908.704564771744;5912.881742365129;6093.177421048191;6172.321044685081;6213.254409470893;6216.906746398808;6227.844303892349;5949.95875721747;5959.821205363846;5962.493188078975;5964.910526342108;5979.4917432018765;5338.279332290169;5416.593755468356;5438.864028399243;5446.346438427414;5449.863753406117;6315.873682526324;6370.267419246753;6413.422791948747;6428.935710642927;6443.806685799434;6229.408206220402;6249.218847644044;6252.249730032425;6260.74957001733;6269.216347956505;6276.152719382825;6399.8080057598345;6437;6441.967790161019;6458.321876202931;6108.85814249354;6133.76314253068;6161.876762464815;6182.567220294716;6186.1648677427975;6188.690565471618;6242.65665388408;6244.562880598496;6249.500039996698;6256.405641464054;6048.425399587032;6099.329073801967;6159.599626024294;6179.536534760001;6218.844528886814;5147.5881929446305;6136.447719705248;6152;6165.84585385369;6181.412765787243;5025.7989680412375;5063.468335824686;5923.7926672566255;6060.757569697339;6072.392760723892;5050.646454748133;6050.788222412194;6117.143599895929;6166.81499555014;6183.752649893954;4989.927165659401;6095.542834287357;6100.096771792299;6111.495242027356;6112.572119951561 08:29:49 INFO - PROCESS | 6369 | |1;ext.html;491.42748697767104;514.8378260847833;516.3958168942337;550.6283258800308;583.6789765628906;29106.417871642556;39152;39278.80360598193;39293.214135717266;39417.21165576687;41124;41512.13195406206;41578.7921060395;41984;42050.57949420505;8167.469114507538;8476.194761497647;8720.389572729911;9506.47714375709;9638.277129215301;9434.10376014281;9578.233741300679;9585.2811039172;9587.760305992337;9605;8493.830123397529;9575.329726919119;9606.183474404648;9609;9638.987906269846;9540.904590954106;9607.711768646883;9612.711618651381;9622.134007939248;9650.806983860353;9389.62441502339;9515.23878089751;9535.094166054214;9543.761405964906;9552.90447095527;38926;39028.41457378142;39136.80431597824;39382;39470.21059578821;3043.893463728781;3187.0757480330676;3410;3423.4693622488553;3769.095417099876;28526.857365713247;28574.714252857415;28697.56953645697;29204.707952920413;30298.394032119453;2720.7687346575567;2739.301478123086;2740.5341092014405;2764.8894044238205;2828.490871643103;430979.45102744736;437958;438298;438317;438838;35516.82241588776;69309.30690693129;69455;69597;69690.3030969694;37067.443988340194;37151.4427283591;37344;37607.87176384713;37634;14803.111813291236;15092.320845561977;15176.165310907785;15207.619809504851;15226.248981367284;12612.747745045232;12646.367681615882;12711.936440317924;12785.808212876815;12794.93602532;8364.498130112213;8492.405531612727;8529.360297977677;8589.44168629037;8641.438306510057;3525.682688558042;3562.5724913010604;3572.7499075064497;3623.3296840084668;3652.4703917932284;971.7133445633555;990.7225976726528;1023.6110278094277;1077.1651969723528;1115.1079136690614;29220.561691574643;29535;29867.850660746994;30008.099757007323;30090.398192036475;1135.137295655308;1149.1898211760688;1159.4956194055612;1208.7219939413983;1231.7743844874228;15383.384664613513;15385.846141538665;15665.373385064699;15667.451639192574;15727.528174154793;339245;416171.91914040234;416963;420203;573212;55943.720281399146;55961;56601.71699141478;56608.150877736865;56991;1470.8235011798652;1488.9702205956037;1496.6482876524008;1501.0318344667628;1510.4411367793987;24556.754432455447;24840.75159248457;27237.86381068082;27301.044463443683;27652.170434886986;43973.12053758971;49264.522064338125;49828.75085624694;51371.22943155781;51997;449685;450214;452112;453156.7342163268;454843;27017.72982270152;27088.32279193036;27329.31676708098;27622.89508419721;27646.44707105887;43350;44003.559964401225;44352.33471497866;44446.333304999804;44545.77727111344;30809.229769255948;36569.45145822868;37006.88979330625;37318;38048;30247.69752302449;31311;35988;36561.81719091388;36689.81655091814;24631.87684061568;33965.811196608;34831.65168348284;36296.637033629326;37288.81355593204;30333.090007299816;31356.216094597818;31856.840715796272;31926.201844954063;32106.357872841945;24206;24319.63520547158;24362;24485;24502.344094218854 08:29:49 INFO - PROCESS | 6369 | |2;jquery.html;345.50765159647506;397.6182864450129;401.8593492277701;409.2449430800174;416.35880743654775;19605.50986225345;20130;20439.59120817583;20858.687119693197;20885.791142088576;18788.53028674284;19634.803651963477;19724.21103155872;20292.695609565868;21827.345179644595;5537.224788529609;5842.532597392198;5894.852628684274;5908.370775005103;5956.880862382761;5624.943750562504;5793.884122317551;5840.561957853157;6089.2692876854835;6177.135201071854;6103.572749907508;6131.417515336036;6148.938510614904;6149.0468977308365;6152.661603611799;5608.046632072537;5956.7319470623925;5972.343042265347;5984.0126379147605;6138.785142520012;5651.2370829937845;5759.65442073477;5776.9422305776825;5956.047032474827;6024.307204671475;11676.94161529187;13572.389242484112;13983.23092229927;15576.688466230611;26794.598081028802;2018.5760990192077;2159.6652518859446;2206.6579680149603;2266.897989590456;2273.499830037389;8429.367797415218;8476.957615211946;9675.516224188832;9972.85312189093;10176.389416635026;1711.922963466647;1717.3216579451048;1814.0929535232383;1836.8163183681659;1872.1762424533163;115534;118380;118740.81259187384;119353.20970185455;126731.36634316861;11704.88295117055;11728.472218750177;11744.354060526583;11843.46704398287;12022;15158;15174.848251517564;15340.616484587752;15377.769333460006;15390.538283851502;8731.432456890281;8779.517126558101;8837.469751814911;8845.69040083594;8850.247728943112;8673.262772664268;8687.956560217159;8749.956250218835;8761.737147885573;8796.604152813139;3820.1213720843807;3996.4205190247253;4665.113628410591;4769.093872164278;4801.567858892647;1686.4181857259225;1924.6150769846088;1966.7934866839062;1989.8607097503325;1992.8604997650316;731.5500966905315;924.177482040984;940.4200942416669;966.5843687214425;990.2276224544867;18727;19345.709814352795;20172.798272017386;20710.482237944172;20734.546253834098;785.6189747972343;790.7192946504023;867.505521852538;992.6823416506649;1022.5551884930079;10600.310979786444;11126.276792008493;11133.99794018526;11144.442777861075;11168.441577921234;546970;551270;555056;562176;567480;119768;125040.74959250473;126106.36946815207;129249.35375323064;130876;998.691713854838;1031.3193292426963;1052.9473526323652;1053.4364115198332;1058.5606973106228;16066.39336066384;16807.747883781998;18014.36949706754;18400.90799546047;18446;49516;49760.751196243786;50173;50831;51528.45414637567;72061.6396918012;72379.63810180915;73154.63422682852;74481;75854.24145758692;7758.495697779626;7920.564368959763;7929.960350198212;8067;8308.169183081885;11264.94367528157;12119;12305.507779688713;12374.13381063317;12394.938025309815;10450.216233782648;10628.787424251626;10852.077573406348;10990;11128.443577820915;9470.384425012353;10641.521131549254;10685.786284274427;10829.620963266249;10923.726906827393;9345.53272336394;10822.026017658449;11033.889661103607;11368.829467557827;11417.714557136138;8002.399820013638;8014.318782903519;8049.718259860877;8140.796480088045;8337.08292087882;8299.211574900375;10686.946565267124;10842.566297348018;11079.279846809932;11184.496697648463 08:29:49 INFO - PROCESS | 6369 | |3;mootools.html;1597.7044246814337;1625.9756103658444;1892.6687829629811;1920.251102070192;1966.2429964463686;8003.839923201533;8372.288355489783;8745.169208925157;8752.431091979017;8870.911290887088;7339.926600733991;8555.144485551442;8732.30141588673;8733.650653973833;8745.606447709852;2204.732278939612;2326.1858349577597;2445.8654773987423;2469.950600987979;2472.3571871313497;2403.759624037591;2435.537247922889;2437.878106094688;2438.3660248335473;2443.2670198940336;2438.073532057824;2458.4960083182905;2481.950360992788;2491.725910149882;2497.0261597976805;2430.4895971845935;2443.987780061106;2453.5338285725657;2461.876906154685;2466.580681284186;2414.6860908082012;2425.4300239443714;2432.72023717273;2434.7565243475688;2440.9137933619545;8904.59929303183;8908.73273801787;8968.641254349819;8974.551272436353;8975.192232699022;5286.5242128208265;5464.371597266326;5465.644733092376;5511.5039646432015;5533.00405926933;3460.688538031564;3531.487934249545;3589.351789432691;3656.1042544576485;3657.7805331680183;983.7196399026243;990.2869933647834;991.1822746234313;1047.3558761361785;1050.5062620568397;9645.662401815904;11306.265092768943;11636.243644163102;11874.990625796818;11965.965785816345;4795.376601041842;4848.660593758474;4902.558769710743;4916.877078073006;4960.627952903475;9899.1585715215;9950.502474876228;9959.55182016811;9979.002099789963;10039.096481316716;5337.86655333612;5399.649022813504;5445.128779395278;5445.537129343971;5456.61803673739;4449.644028477714;4830.492798256132;4906.70559766408;4979.979104283613;5006.924896126488;3959.7328854766197;3969.702272329587;4061.329880569732;4077.776666999888;4100.200460910094;1354.3228385807097;1361.7276544691101;1368.7809950407886;1370.5340184337374;1375.7042235919125;830.5556527257888;873.3493547307297;945.579217248318;952.5618215620754;985.9112679858847;5865.618734782225;5959.731812068468;5964.761409543657;6103.877922441527;6159.29168145669;449.85379751580865;462.4612326639495;468.2227502346089;468.372381009449;471.6721878294621;3953.584873588232;4034.2133284009337;4063.593640635913;4128.669706423479;4155.8753237402925;10291.588336466457;10747.40889251083;10802.72993175177;10878;10901;10599.84100238497;10648.414337211529;10713.464326783629;10800.135989120852;10883.510242039127;7749.7287594933905;8179.304759095544;8200.75397738057;8205.95897020511;8278.958605206935;4914.213725803854;5925.140854575976;5967.9701601491715;6045.486133678686;6070.0591408331775;9736.9026309736;10128.746781330527;10131.848022279819;10175.440350780778;10245.692629221136;10034.247431442525;10095.646652367426;10125.898741012496;10158.847617285599;10385.636502722671;6900.102986611709;7304.890426643498;7485.401167906445;7509.887351689838;7664.156942736406;8183.918160818554;8220.095789463036;8244.958775206325;8289.668413263402;8307.252347288773;7226.4218862491925;7368.336849683555;7410.147832999274;7506.549607023596;7575.772726818204;6114.633122012693;6869.7595584154315;7048.365647091787;7161.749338773118;7325.743598974011;6846;6894.13823272091;6933.5493192942295;6966.721331146698;6998.965005174941;4874.512548745097;4909.852704418873;4946.678465899849;4990.875228119181;5118.411382691038;4936.3089167515855;4966.8758281043265;5018.799248030038;5065.164247899203;5260.815871444481 08:29:49 INFO - PROCESS | 6369 | |4;prototype.html;313.1279386907462;322.5419903736694;329.2394568546659;330.3063566510328;330.9586301712286;5420.322459692538;5532.114861622136;5688.118341657039;5697.230873832036;5714.942850571493;4607.378003969463;5481.205225242347;5562.666240025601;5564.666120032791;5594.475480447312;4166.187593419285;4205.789710514462;4211.284081706117;4224.577542245782;4225.640820530243;3760.417135344026;3817.7136714746366;3882.2730179028167;4157.147784704129;4224.134052519226;4103.815328310233;4142.399352093945;4155.480564929384;4164.022089507474;4183.330667093266;3663.7360110761742;4131.669466442678;4156.106437116019;4165.625343636592;4183.477065366829;3042.680518545543;3072.4023507776055;3602.981985090084;3612.277544491086;3619.4389869569995;5079.644424890259;5218.191180367011;5388.380336261341;5407.486288802596;5430.266913966603;4782.545658162469;4787.425508938914;4803.807847686088;4812.278158276286;4826.276058591205;4327.242732521828;4764.499727528594;5651.378348381675;5675.6878371689545;5921.940780592182;3553.982230088859;3818.7135964802474;3862.575116737157;3867.535895692507;4014;4913.034786085559;5492.780288788404;5780.53755699543;5895.351511333793;6098.878022439526;3355.647656996029;3532.152283452004;3789.4947173864066;4001.4598029265676;4012.197560487914;4098.581836716352;4101.097758493127;4106.733062350938;4107.774072426046;4128.277551428488;4492.281235002384;4532.410786597721;4611.608013318838;4656.674032817738;4741.739204343794;4705.976470117627;4918.827841025547;5910.788288400953;5924;5965.433283838029;1468.0531057467874;1494.3574263066769;1499.3627708224178;1500.4373359990004;1500.9099454032576;946.5740416812462;975.9756006099905;984.9901500985042;988.471167925171;995.4873240281261;5990.580659353891;6037.849053773691;6059.757609695651;6073.544484163705;6073.817785466443;6538.640374779337;6667.299933506912;6683.732650694015;6740.831479213059;6747.156605424322;5700.37295897451;5766.500709815478;5963.4334738199805;6035.034394496859;6051.788187413419;3349.8945348035577;3401.36734367505;3460.775049621817;3469.8438570264398;3511.9806111485996;6687.331266873273;6868.759593414206;6872.931270687329;6894.620795856175;6920.792376228721;5531.917021244684;6393.6163830170335;6766.221884483249;6777.288384719632;6780.660966951633;6154.969225153935;6389.297177310492;6692.111200564546;6893.105395451554;6901.861962760717;6265;6601.966990165019;6627.5360724750735;6629.668516574248;6636.668166591555;5624.762552238501;6054.700188397422;6109;6227.252729672468;6513.316101809241;5668.801591944427;5733.569982251264;5821.57371443982;6301.054841773771;6403.199600049994;3556.4665300205174;3673.7061035117663;4071.7353372030725;4073.3279008964373;4076.103257283393;5254.687937307573;5642.181883626769;6017.308009578955;6170.475509581556;6193.38066193377;5058.747062646779;5713.885722285448;5923.85190370227;5945.762169513171;5970.671613061323;5019.974900125476;5875.794347197828;5909.497692695997;5937.387549478216;5969.1495636352865;4636.489986101458;5489.368722596792;5594.524465420485;5738.5696072795545;5801.477866991991;4911.410630724193;5591.4688104629995;5897.250181073419;5917.615355001911;5946.345901950695;5174.249733788655;5796.855078623068;5802.593818432669;5823.505002074871;5875.970620146872 08:29:49 INFO - PROCESS | 6369 | |5;yui.html;609.9420555047275;679.8606285711429;718.75562308815;726.8473620539686;749.2208103572286;13628;15036.774448383268;15136.243187840619;15283.694326113486;15306.31121599528;13971.371288292026;14026.789598156036;14074.577762667112;14281.78577321341;14294.857051429482;851.1403482482706;908.3414524469773;909.8271328447573;917.7843206846386;919.8896132464114;703.2053779229464;885.6413152673146;925.0379605210572;926.1988380051274;933.9019402962693;962.4033099478333;963.9228861691048;971.519098046468;972.6498460554195;982.9066238707311;944.84882418813;950.9144177024032;962.7496850818768;962.9133377995979;974.8878878928907;703.2124021096405;706.2372637551483;712.508369225233;714.8248679073608;724.0117239967459;14573.271336433241;14578.854211457856;14626.561203163816;14630.853691463055;14646.97471177018;10329.380237185793;12686.682832929158;12784.424700888483;12878;13165.736685266242;9672.177864881494;10007.999200080007;10060.899391006069;10100.141487973531;10516.579336826519;3430.485427185917;3445.3453843769603;3455.1016735648914;3513;3573.7855728656364;73055;74459;75130.62434687847;75206.62396687982;75387.24612753857;9127.767751353615;9144.679936202201;9174.86237706435;9250.768730781785;9388.295877809192;20230.494237644176;20241.291554795513;20315.288964886156;20345.694814577793;20364.287249946476;7180.856382872418;7192;7376.409887209011;7377.557346559223;7527.8118047049265;3305.520699498559;3951.585083566184;3986.123052928351;3991.3015222335976;4062.3500239962054;3460.602030766494;3528.2237907660788;3536.328097661436;3540.2034542228307;3546.219831637036;558.4582954534095;623.7006237006262;633.8383712153463;646.2309851276965;647.601724939159;485.8129620096218;590.3152343281772;599.7001499250375;601.0803470689851;605.5639939243738;7720.768376948588;8092.8381432371025;8220.301274391744;8270.503769773833;8293.419460637697;519.2393144043994;538.464228093042;540.4271472239438;572.5734327925722;610.2272897233544;3593.8562457501407;3826.7129965252716;3858.074062225102;3942.704297177723;3983.9203215935518;83304;92864.67838304097;95202;98032.50983745178;98834;46179.76910115428;79066.81399779009;79113.64874931934;79206.81189782158;80100.19899800928;72113;73485.16287092866;73857.52284954271;74030;74360.88458673125;6151.5386346025125;7633.885491717518;7670.7315243966195;7723.189065148079;7901.960490197513;33811.83094084514;35441.46837797383;43581.34627980519;44325;44703;40256.59101931418;59213.703931480064;62920.37079629145;63308.36691633025;63498.68250658902;9651;10552.46363536799;11076.778464430505;11304.982551570398;11315.547378105113;11768.94115529417;11974.101942354184;12011.579594714143;12030.819537707117;12114.878851211375;11025.117990560897;11055.447227638426;11079.446027698745;11129.109671226444;11402.828957565478;10824.296420732628;11019.283746556768;11147.108231341635;11292.774144517229;11324.716882077684;9630.951845240728;11240.55037798479;11268.492917818554;11294.134035133065;11472.347341767094;9320.906790932004;9426.868775746954;9489.335746497678;9837.065478779505;10014.499275036365;9426.717198484057;9463.952680236554;9473.763155921157;9557.808843823224;9560.282978776759 08:29:49 INFO - PROCESS | 6369 | __end_tp_report 08:29:49 INFO - PROCESS | 6369 | __start_cc_report 08:29:49 INFO - PROCESS | 6369 | _x_x_mozilla_cycle_collect,423 08:29:49 INFO - PROCESS | 6369 | __end_cc_report 08:29:49 INFO - PROCESS | 6369 | __startTimestamp1461598189354__endTimestamp 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | ------- Summary: start ------- 08:29:49 INFO - PROCESS | 6369 | Number of tests: 6 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#0] dojo.html Cycles:165 Average:5725.69 Median:6050.79 stddev:683.08 (11.3%) stddev-sans-first:661.41 08:29:49 INFO - PROCESS | 6369 | Values: 3448.8 3461.2 3476.5 3483.9 3512.8 4732.6 5661.6 5667.4 5749.1 5758.2 5707.3 5822.7 5846.0 5894.4 5924.9 5113.0 5203.6 5214.6 5246.6 5277.7 4323.2 4388.3 4709.5 5247.2 5337.4 4361.4 5154.5 5256.7 5266.6 5339.4 5188.2 5214.8 5219.7 5251.6 5276.6 4761.8 4889.5 5139.1 5146.0 5204.8 5617.3 5643.7 5758.0 5761.3 5800.0 6103.7 6120.9 6150.5 6163.4 6193.9 6250.5 6253.9 6265.5 6272.0 6297.4 4874.7 5780.2 5792.5 5914.3 5928.2 6287.6 6334.2 6336.8 6352.8 6357.2 6220.8 6223.9 6228.8 6232.7 6241.9 6054.7 6174.8 6182.4 6243.1 6260.5 6183.7 6209.2 6229.4 6242.7 6243.3 6199.4 6218.5 6243.1 6248.3 6253.8 4841.0 4897.1 4956.3 4977.6 4989.4 4394.8 4415.9 4422.1 4452.1 4453.3 5871.9 5875.9 5899.5 5908.7 5912.9 6093.2 6172.3 6213.3 6216.9 6227.8 5950.0 5959.8 5962.5 5964.9 5979.5 5338.3 5416.6 5438.9 5446.3 5449.9 6315.9 6370.3 6413.4 6428.9 6443.8 6229.4 6249.2 6252.2 6260.7 6269.2 6276.2 6399.8 6437.0 6442.0 6458.3 6108.9 6133.8 6161.9 6182.6 6186.2 6188.7 6242.7 6244.6 6249.5 6256.4 6048.4 6099.3 6159.6 6179.5 6218.8 5147.6 6136.4 6152.0 6165.8 6181.4 5025.8 5063.5 5923.8 6060.8 6072.4 5050.6 6050.8 6117.1 6166.8 6183.8 4989.9 6095.5 6100.1 6111.5 6112.6 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#1] ext.html Cycles:180 Average:57631.30 Median:37331.00 stddev:117751.27 (315.4%) stddev-sans-first:118003.44 08:29:49 INFO - PROCESS | 6369 | Values: 491.4 514.8 516.4 550.6 583.7 29106.4 39152.0 39278.8 39293.2 39417.2 41124.0 41512.1 41578.8 41984.0 42050.6 8167.5 8476.2 8720.4 9506.5 9638.3 9434.1 9578.2 9585.3 9587.8 9605.0 8493.8 9575.3 9606.2 9609.0 9639.0 9540.9 9607.7 9612.7 9622.1 9650.8 9389.6 9515.2 9535.1 9543.8 9552.9 38926.0 39028.4 39136.8 39382.0 39470.2 3043.9 3187.1 3410.0 3423.5 3769.1 28526.9 28574.7 28697.6 29204.7 30298.4 2720.8 2739.3 2740.5 2764.9 2828.5 430979.5 437958.0 438298.0 438317.0 438838.0 35516.8 69309.3 69455.0 69597.0 69690.3 37067.4 37151.4 37344.0 37607.9 37634.0 14803.1 15092.3 15176.2 15207.6 15226.2 12612.7 12646.4 12711.9 12785.8 12794.9 8364.5 8492.4 8529.4 8589.4 8641.4 3525.7 3562.6 3572.7 3623.3 3652.5 971.7 990.7 1023.6 1077.2 1115.1 29220.6 29535.0 29867.9 30008.1 30090.4 1135.1 1149.2 1159.5 1208.7 1231.8 15383.4 15385.8 15665.4 15667.5 15727.5 339245.0 416171.9 416963.0 420203.0 573212.0 55943.7 55961.0 56601.7 56608.2 56991.0 1470.8 1489.0 1496.6 1501.0 1510.4 24556.8 24840.8 27237.9 27301.0 27652.2 43973.1 49264.5 49828.8 51371.2 51997.0 449685.0 450214.0 452112.0 453156.7 454843.0 27017.7 27088.3 27329.3 27622.9 27646.4 43350.0 44003.6 44352.3 44446.3 44545.8 30809.2 36569.5 37006.9 37318.0 38048.0 30247.7 31311.0 35988.0 36561.8 36689.8 24631.9 33965.8 34831.7 36296.6 37288.8 30333.1 31356.2 31856.8 31926.2 32106.4 24206.0 24319.6 24362.0 24485.0 24502.3 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#2] jquery.html Cycles:180 Average:33323.93 Median:2270.20 stddev:93297.62 (4109.7%) stddev-sans-first:93526.48 08:29:49 INFO - PROCESS | 6369 | Values: 345.5 397.6 401.9 409.2 416.4 19605.5 20130.0 20439.6 20858.7 20885.8 18788.5 19634.8 19724.2 20292.7 21827.3 5537.2 5842.5 5894.9 5908.4 5956.9 5624.9 5793.9 5840.6 6089.3 6177.1 6103.6 6131.4 6148.9 6149.0 6152.7 5608.0 5956.7 5972.3 5984.0 6138.8 5651.2 5759.7 5776.9 5956.0 6024.3 11676.9 13572.4 13983.2 15576.7 26794.6 2018.6 2159.7 2206.7 2266.9 2273.5 8429.4 8477.0 9675.5 9972.9 10176.4 1711.9 1717.3 1814.1 1836.8 1872.2 115534.0 118380.0 118740.8 119353.2 126731.4 11704.9 11728.5 11744.4 11843.5 12022.0 15158.0 15174.8 15340.6 15377.8 15390.5 8731.4 8779.5 8837.5 8845.7 8850.2 8673.3 8688.0 8750.0 8761.7 8796.6 3820.1 3996.4 4665.1 4769.1 4801.6 1686.4 1924.6 1966.8 1989.9 1992.9 731.6 924.2 940.4 966.6 990.2 18727.0 19345.7 20172.8 20710.5 20734.5 785.6 790.7 867.5 992.7 1022.6 10600.3 11126.3 11134.0 11144.4 11168.4 546970.0 551270.0 555056.0 562176.0 567480.0 119768.0 125040.7 126106.4 129249.4 130876.0 998.7 1031.3 1052.9 1053.4 1058.6 16066.4 16807.7 18014.4 18400.9 18446.0 49516.0 49760.8 50173.0 50831.0 51528.5 72061.6 72379.6 73154.6 74481.0 75854.2 7758.5 7920.6 7930.0 8067.0 8308.2 11264.9 12119.0 12305.5 12374.1 12394.9 10450.2 10628.8 10852.1 10990.0 11128.4 9470.4 10641.5 10685.8 10829.6 10923.7 9345.5 10822.0 11033.9 11368.8 11417.7 8002.4 8014.3 8049.7 8140.8 8337.1 8299.2 10686.9 10842.6 11079.3 11184.5 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#3] mootools.html Cycles:180 Average:5713.11 Median:4926.59 stddev:3171.87 (64.4%) stddev-sans-first:3165.69 08:29:49 INFO - PROCESS | 6369 | Values: 1597.7 1626.0 1892.7 1920.3 1966.2 8003.8 8372.3 8745.2 8752.4 8870.9 7339.9 8555.1 8732.3 8733.7 8745.6 2204.7 2326.2 2445.9 2470.0 2472.4 2403.8 2435.5 2437.9 2438.4 2443.3 2438.1 2458.5 2482.0 2491.7 2497.0 2430.5 2444.0 2453.5 2461.9 2466.6 2414.7 2425.4 2432.7 2434.8 2440.9 8904.6 8908.7 8968.6 8974.6 8975.2 5286.5 5464.4 5465.6 5511.5 5533.0 3460.7 3531.5 3589.4 3656.1 3657.8 983.7 990.3 991.2 1047.4 1050.5 9645.7 11306.3 11636.2 11875.0 11966.0 4795.4 4848.7 4902.6 4916.9 4960.6 9899.2 9950.5 9959.6 9979.0 10039.1 5337.9 5399.6 5445.1 5445.5 5456.6 4449.6 4830.5 4906.7 4980.0 5006.9 3959.7 3969.7 4061.3 4077.8 4100.2 1354.3 1361.7 1368.8 1370.5 1375.7 830.6 873.3 945.6 952.6 985.9 5865.6 5959.7 5964.8 6103.9 6159.3 449.9 462.5 468.2 468.4 471.7 3953.6 4034.2 4063.6 4128.7 4155.9 10291.6 10747.4 10802.7 10878.0 10901.0 10599.8 10648.4 10713.5 10800.1 10883.5 7749.7 8179.3 8200.8 8206.0 8279.0 4914.2 5925.1 5968.0 6045.5 6070.1 9736.9 10128.7 10131.8 10175.4 10245.7 10034.2 10095.6 10125.9 10158.8 10385.6 6900.1 7304.9 7485.4 7509.9 7664.2 8183.9 8220.1 8245.0 8289.7 8307.3 7226.4 7368.3 7410.1 7506.5 7575.8 6114.6 6869.8 7048.4 7161.7 7325.7 6846.0 6894.1 6933.5 6966.7 6999.0 4874.5 4909.9 4946.7 4990.9 5118.4 4936.3 4966.9 5018.8 5065.2 5260.8 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#4] prototype.html Cycles:180 Average:4859.48 Median:5512.35 stddev:1562.96 (28.4%) stddev-sans-first:1529.64 08:29:49 INFO - PROCESS | 6369 | Values: 313.1 322.5 329.2 330.3 331.0 5420.3 5532.1 5688.1 5697.2 5714.9 4607.4 5481.2 5562.7 5564.7 5594.5 4166.2 4205.8 4211.3 4224.6 4225.6 3760.4 3817.7 3882.3 4157.1 4224.1 4103.8 4142.4 4155.5 4164.0 4183.3 3663.7 4131.7 4156.1 4165.6 4183.5 3042.7 3072.4 3603.0 3612.3 3619.4 5079.6 5218.2 5388.4 5407.5 5430.3 4782.5 4787.4 4803.8 4812.3 4826.3 4327.2 4764.5 5651.4 5675.7 5921.9 3554.0 3818.7 3862.6 3867.5 4014.0 4913.0 5492.8 5780.5 5895.4 6098.9 3355.6 3532.2 3789.5 4001.5 4012.2 4098.6 4101.1 4106.7 4107.8 4128.3 4492.3 4532.4 4611.6 4656.7 4741.7 4706.0 4918.8 5910.8 5924.0 5965.4 1468.1 1494.4 1499.4 1500.4 1500.9 946.6 976.0 985.0 988.5 995.5 5990.6 6037.8 6059.8 6073.5 6073.8 6538.6 6667.3 6683.7 6740.8 6747.2 5700.4 5766.5 5963.4 6035.0 6051.8 3349.9 3401.4 3460.8 3469.8 3512.0 6687.3 6868.8 6872.9 6894.6 6920.8 5531.9 6393.6 6766.2 6777.3 6780.7 6155.0 6389.3 6692.1 6893.1 6901.9 6265.0 6602.0 6627.5 6629.7 6636.7 5624.8 6054.7 6109.0 6227.3 6513.3 5668.8 5733.6 5821.6 6301.1 6403.2 3556.5 3673.7 4071.7 4073.3 4076.1 5254.7 5642.2 6017.3 6170.5 6193.4 5058.7 5713.9 5923.9 5945.8 5970.7 5020.0 5875.8 5909.5 5937.4 5969.1 4636.5 5489.4 5594.5 5738.6 5801.5 4911.4 5591.5 5897.3 5917.6 5946.3 5174.2 5796.9 5802.6 5823.5 5876.0 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - PROCESS | 6369 | [#5] yui.html Cycles:180 Average:17442.92 Median:607.75 stddev:24683.60 (4061.5%) stddev-sans-first:24720.48 08:29:49 INFO - PROCESS | 6369 | Values: 609.9 679.9 718.8 726.8 749.2 13628.0 15036.8 15136.2 15283.7 15306.3 13971.4 14026.8 14074.6 14281.8 14294.9 851.1 908.3 909.8 917.8 919.9 703.2 885.6 925.0 926.2 933.9 962.4 963.9 971.5 972.6 982.9 944.8 950.9 962.7 962.9 974.9 703.2 706.2 712.5 714.8 724.0 14573.3 14578.9 14626.6 14630.9 14647.0 10329.4 12686.7 12784.4 12878.0 13165.7 9672.2 10008.0 10060.9 10100.1 10516.6 3430.5 3445.3 3455.1 3513.0 3573.8 73055.0 74459.0 75130.6 75206.6 75387.2 9127.8 9144.7 9174.9 9250.8 9388.3 20230.5 20241.3 20315.3 20345.7 20364.3 7180.9 7192.0 7376.4 7377.6 7527.8 3305.5 3951.6 3986.1 3991.3 4062.4 3460.6 3528.2 3536.3 3540.2 3546.2 558.5 623.7 633.8 646.2 647.6 485.8 590.3 599.7 601.1 605.6 7720.8 8092.8 8220.3 8270.5 8293.4 519.2 538.5 540.4 572.6 610.2 3593.9 3826.7 3858.1 3942.7 3983.9 83304.0 92864.7 95202.0 98032.5 98834.0 46179.8 79066.8 79113.6 79206.8 80100.2 72113.0 73485.2 73857.5 74030.0 74360.9 6151.5 7633.9 7670.7 7723.2 7902.0 33811.8 35441.5 43581.3 44325.0 44703.0 40256.6 59213.7 62920.4 63308.4 63498.7 9651.0 10552.5 11076.8 11305.0 11315.5 11768.9 11974.1 12011.6 12030.8 12114.9 11025.1 11055.4 11079.4 11129.1 11402.8 10824.3 11019.3 11147.1 11292.8 11324.7 9631.0 11240.6 11268.5 11294.1 11472.3 9320.9 9426.9 9489.3 9837.1 10014.5 9426.7 9464.0 9473.8 9557.8 9560.3 08:29:49 INFO - PROCESS | 6369 | -------- Summary: end -------- 08:29:49 INFO - PROCESS | 6369 | 08:29:49 INFO - TEST-INFO | 6369: exit 0 08:29:49 INFO - TEST-OK | dromaeo_css | took 1112666ms 08:29:49 INFO - TEST-START | kraken 08:29:49 INFO - operating with platform_type : mac_ 08:29:49 INFO - Initialising browser for kraken test... 08:29:49 INFO - TEST-INFO | started process 6373 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp1SRU_O/profile http://localhost:54448/getInfo.html) 08:29:52 INFO - PROCESS | 6373 | __metrics Screen width/height:1600/1200 08:29:52 INFO - PROCESS | 6373 | colorDepth:24 08:29:52 INFO - PROCESS | 6373 | Browser inner width/height: 1024/689 08:29:52 INFO - PROCESS | 6373 | __metrics 08:29:52 ERROR - PROCESS | 6373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:29:53 INFO - TEST-INFO | 6373: exit 0 08:29:53 INFO - Browser initialized. 08:29:53 INFO - Running cycle 1/1 for kraken test... 08:29:53 INFO - TEST-INFO | started process 6376 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp1SRU_O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:05 INFO - PROCESS | 6376 | RSS: Main: 249774080 08:30:05 INFO - PROCESS | 6376 | 08:30:08 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54448/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:09 INFO - PROCESS | 6376 | RSS: Main: 261906432 08:30:09 INFO - PROCESS | 6376 | 08:30:12 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54448/tests/kraken/driver.html?testName=audio-dft) 08:30:12 INFO - PROCESS | 6376 | RSS: Main: 270827520 08:30:12 INFO - PROCESS | 6376 | 08:30:16 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54448/tests/kraken/driver.html?testName=audio-fft) 08:30:16 INFO - PROCESS | 6376 | RSS: Main: 274018304 08:30:16 INFO - PROCESS | 6376 | 08:30:18 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54448/tests/kraken/driver.html?testName=audio-oscillator) 08:30:19 INFO - PROCESS | 6376 | RSS: Main: 275521536 08:30:19 INFO - PROCESS | 6376 | 08:30:21 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:22 INFO - PROCESS | 6376 | RSS: Main: 276652032 08:30:22 INFO - PROCESS | 6376 | 08:30:24 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54448/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:25 INFO - PROCESS | 6376 | RSS: Main: 277852160 08:30:25 INFO - PROCESS | 6376 | 08:30:28 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54448/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:29 INFO - PROCESS | 6376 | RSS: Main: 277479424 08:30:29 INFO - PROCESS | 6376 | 08:30:31 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54448/tests/kraken/driver.html?testName=json-parse-financial) 08:30:32 INFO - PROCESS | 6376 | RSS: Main: 277803008 08:30:32 INFO - PROCESS | 6376 | 08:30:34 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:34 INFO - PROCESS | 6376 | RSS: Main: 276668416 08:30:34 INFO - PROCESS | 6376 | 08:30:36 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:37 INFO - PROCESS | 6376 | RSS: Main: 276979712 08:30:37 INFO - PROCESS | 6376 | 08:30:39 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:40 INFO - PROCESS | 6376 | RSS: Main: 277082112 08:30:40 INFO - PROCESS | 6376 | 08:30:42 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:43 INFO - PROCESS | 6376 | RSS: Main: 277172224 08:30:43 INFO - PROCESS | 6376 | 08:30:46 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:47 INFO - PROCESS | 6376 | RSS: Main: 277098496 08:30:47 INFO - PROCESS | 6376 | 08:30:48 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:54448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54448/tests/kraken/driver.html?testName=ai-astar) 08:30:49 INFO - PROCESS | 6376 | RSS: Main: 278822912 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | __start_tp_report 08:30:49 INFO - PROCESS | 6376 | _x_x_mozilla_page_load 08:30:49 INFO - PROCESS | 6376 | _x_x_mozilla_page_load_details 08:30:49 INFO - PROCESS | 6376 | |i|pagename|runs| 08:30:49 INFO - PROCESS | 6376 | |0;ai-astar;117;112;110;128;119;149;95;96;128;169 08:30:49 INFO - PROCESS | 6376 | |1;audio-beat-detection;169;124;158;203;153;173;137;155;214;105 08:30:49 INFO - PROCESS | 6376 | |2;audio-dft;205;225;201;201;200;195;217;191;238;194 08:30:49 INFO - PROCESS | 6376 | |3;audio-fft;71;89;75;135;47;57;92;51;79;71 08:30:49 INFO - PROCESS | 6376 | |4;audio-oscillator;79;92;130;78;81;86;123;81;79;126 08:30:49 INFO - PROCESS | 6376 | |5;imaging-gaussian-blur;121;86;88;84;92;86;85;127;134;85 08:30:49 INFO - PROCESS | 6376 | |6;imaging-darkroom;94;96;94;95;95;95;94;97;94;108 08:30:49 INFO - PROCESS | 6376 | |7;imaging-desaturate;91;91;90;91;94;92;90;92;101;92 08:30:49 INFO - PROCESS | 6376 | |8;json-parse-financial;63;62;64;61;63;63;62;81;64;59 08:30:49 INFO - PROCESS | 6376 | |9;json-stringify-tinderbox;67;61;76;68;79;76;71;67;66;68 08:30:49 INFO - PROCESS | 6376 | |10;stanford-crypto-aes;84;85;84;81;85;82;84;84;85;85 08:30:49 INFO - PROCESS | 6376 | |11;stanford-crypto-ccm;145;169;156;161;140;137;137;141;220;140 08:30:49 INFO - PROCESS | 6376 | |12;stanford-crypto-pbkdf2;175;172;174;175;170;176;202;234;170;171 08:30:49 INFO - PROCESS | 6376 | |13;stanford-crypto-sha256-iterative;69;70;67;70;73;70;72;68;73;71 08:30:49 INFO - PROCESS | 6376 | __end_tp_report 08:30:49 INFO - PROCESS | 6376 | __start_cc_report 08:30:49 INFO - PROCESS | 6376 | _x_x_mozilla_cycle_collect,1092 08:30:49 INFO - PROCESS | 6376 | __end_cc_report 08:30:49 INFO - PROCESS | 6376 | __startTimestamp1461598249035__endTimestamp 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | ------- Summary: start ------- 08:30:49 INFO - PROCESS | 6376 | Number of tests: 14 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#0] ai-astar Cycles:10 Average:122.30 Median:138.50 stddev:22.83 (16.5%) stddev-sans-first:24.14 08:30:49 INFO - PROCESS | 6376 | Values: 117.0 112.0 110.0 128.0 119.0 149.0 95.0 96.0 128.0 169.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#1] audio-beat-detection Cycles:10 Average:159.10 Median:163.50 stddev:33.22 (20.3%) stddev-sans-first:35.05 08:30:49 INFO - PROCESS | 6376 | Values: 169.0 124.0 158.0 203.0 153.0 173.0 137.0 155.0 214.0 105.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#2] audio-dft Cycles:10 Average:206.70 Median:203.00 stddev:15.20 (7.5%) stddev-sans-first:16.10 08:30:49 INFO - PROCESS | 6376 | Values: 205.0 225.0 201.0 201.0 200.0 195.0 217.0 191.0 238.0 194.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#3] audio-fft Cycles:10 Average:76.70 Median:73.00 stddev:25.36 (34.7%) stddev-sans-first:26.81 08:30:49 INFO - PROCESS | 6376 | Values: 71.0 89.0 75.0 135.0 47.0 57.0 92.0 51.0 79.0 71.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:80.00 stddev:21.73 (27.2%) stddev-sans-first:22.21 08:30:49 INFO - PROCESS | 6376 | Values: 79.0 92.0 130.0 78.0 81.0 86.0 123.0 81.0 79.0 126.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:85.50 stddev:20.05 (23.4%) stddev-sans-first:19.59 08:30:49 INFO - PROCESS | 6376 | Values: 121.0 86.0 88.0 84.0 92.0 86.0 85.0 127.0 134.0 85.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:95.00 stddev:4.26 (4.5%) stddev-sans-first:4.45 08:30:49 INFO - PROCESS | 6376 | Values: 94.0 96.0 94.0 95.0 95.0 95.0 94.0 97.0 94.0 108.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:91.50 stddev:3.24 (3.5%) stddev-sans-first:3.40 08:30:49 INFO - PROCESS | 6376 | Values: 91.0 91.0 90.0 91.0 94.0 92.0 90.0 92.0 101.0 92.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:63.00 stddev:6.09 (9.7%) stddev-sans-first:6.44 08:30:49 INFO - PROCESS | 6376 | Values: 63.0 62.0 64.0 61.0 63.0 63.0 62.0 81.0 64.0 59.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:5.55 (8.0%) stddev-sans-first:5.78 08:30:49 INFO - PROCESS | 6376 | Values: 67.0 61.0 76.0 68.0 79.0 76.0 71.0 67.0 66.0 68.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:1.37 (1.6%) stddev-sans-first:1.45 08:30:49 INFO - PROCESS | 6376 | Values: 84.0 85.0 84.0 81.0 85.0 82.0 84.0 84.0 85.0 85.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:150.50 stddev:25.50 (16.9%) stddev-sans-first:26.80 08:30:49 INFO - PROCESS | 6376 | Values: 145.0 169.0 156.0 161.0 140.0 137.0 137.0 141.0 220.0 140.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:175.00 stddev:20.58 (11.8%) stddev-sans-first:21.67 08:30:49 INFO - PROCESS | 6376 | Values: 175.0 172.0 174.0 175.0 170.0 176.0 202.0 234.0 170.0 171.0 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - PROCESS | 6376 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:2.00 (2.8%) stddev-sans-first:2.07 08:30:49 INFO - PROCESS | 6376 | Values: 69.0 70.0 67.0 70.0 73.0 70.0 72.0 68.0 73.0 71.0 08:30:49 INFO - PROCESS | 6376 | -------- Summary: end -------- 08:30:49 INFO - PROCESS | 6376 | 08:30:49 INFO - TEST-INFO | 6376: exit 0 08:30:49 INFO - TEST-OK | kraken | took 60075ms 08:30:49 INFO - SUITE-END | took 1172s 08:30:50 INFO - Completed test suite (00:19:32) 08:30:50 INFO - javascript benchmark 08:30:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3448.7930724156554, 3461.2385275239444, 3476.5480487536615, 3483.860645574177, 3512.7541072124964, 4732.550407711262, 5661.631993920392, 5667.433256674331, 5749.080147176453, 5758.165066065418, 5707.286589176353, 5822.7088645567765, 5845.970770146143, 5894.410558944114, 5924.940750592493, 5112.97443512782, 5203.583713302926, 5214.634975551713, 5246.606504512168, 5277.683338999653, 4323.2218200723855, 4388.341748737683, 4709.546594400294, 5247.1866860636665, 5337.386200586943, 4361.386212488259, 5154.5103215194495, 5256.710880901549, 5266.552343050846, 5339.359276886779, 5188.169892817131, 5214.765335559909, 5219.660722053054, 5251.553617942442, 5276.630635855492, 4761.833335833229, 4889.486603906575, 5139.0749665060275, 5145.974270128663, 5204.76578553966, 5617.325920889479, 5643.717814109319, 5758.049921762904, 5761.279840019997, 5799.971000145015, 6103.717529324765, 6120.938790612081, 6150.538709596798, 6163.414475624853, 6193.87612247757, 6250.499960003189, 6253.937460625381, 6265.498760099181, 6271.96864015677, 6297.401746834089, 4874.731889746027, 5780.16187652788, 5792.536597072224, 5914.349421563625, 5928.199693041427, 6287.622742635456, 6334.176557047646, 6336.778212762623, 6352.841178970562, 6357.237131544244, 6220.782272620437, 6223.875522489525, 6228.844278892973, 6232.719527621268, 6241.906371404432, 6054.697265136726, 6174.8147555573405, 6182.443580077815, 6243.063540468966, 6260.530460215502, 6183.690815459209, 6209.161763161916, 6229.408206220402, 6242.687865606701, 6243.313235544087, 6199.380061993765, 6218.471429928416, 6243.0635404688755, 6248.31268560458, 6253.843653908689, 4840.975795121002, 4897.118518666674, 4956.281339205795, 4977.601791856715, 4989.426215985136, 4394.824207031683, 4415.940174358131, 4422.137683151819, 4452.0873220989615, 4453.287474004209, 5871.882562348729, 5875.882482350415, 5899.469047785634, 5908.704564771744, 5912.881742365129, 6093.177421048191, 6172.321044685081, 6213.254409470893, 6216.906746398808, 6227.844303892349, 5949.95875721747, 5959.821205363846, 5962.493188078975, 5964.910526342108, 5979.4917432018765, 5338.279332290169, 5416.593755468356, 5438.864028399243, 5446.346438427414, 5449.863753406117, 6315.873682526324, 6370.267419246753, 6413.422791948747, 6428.935710642927, 6443.806685799434, 6229.408206220402, 6249.218847644044, 6252.249730032425, 6260.74957001733, 6269.216347956505, 6276.152719382825, 6399.8080057598345, 6437.0, 6441.967790161019, 6458.321876202931, 6108.85814249354, 6133.76314253068, 6161.876762464815, 6182.567220294716, 6186.1648677427975, 6188.690565471618, 6242.65665388408, 6244.562880598496, 6249.500039996698, 6256.405641464054, 6048.425399587032, 6099.329073801967, 6159.599626024294, 6179.536534760001, 6218.844528886814, 5147.5881929446305, 6136.447719705248, 6152.0, 6165.84585385369, 6181.412765787243, 5025.7989680412375, 5063.468335824686, 5923.7926672566255, 6060.757569697339, 6072.392760723892, 5050.646454748133, 6050.788222412194, 6117.143599895929, 6166.81499555014, 6183.752649893954, 4989.927165659401, 6095.542834287357, 6100.096771792299, 6111.495242027356, 6112.572119951561], "value": 5683.278257096333, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.42748697767104, 514.8378260847833, 516.3958168942337, 550.6283258800308, 583.6789765628906, 29106.417871642556, 39152.0, 39278.80360598193, 39293.214135717266, 39417.21165576687, 41124.0, 41512.13195406206, 41578.7921060395, 41984.0, 42050.57949420505, 8167.469114507538, 8476.194761497647, 8720.389572729911, 9506.47714375709, 9638.277129215301, 9434.10376014281, 9578.233741300679, 9585.2811039172, 9587.760305992337, 9605.0, 8493.830123397529, 9575.329726919119, 9606.183474404648, 9609.0, 9638.987906269846, 9540.904590954106, 9607.711768646883, 9612.711618651381, 9622.134007939248, 9650.806983860353, 9389.62441502339, 9515.23878089751, 9535.094166054214, 9543.761405964906, 9552.90447095527, 38926.0, 39028.41457378142, 39136.80431597824, 39382.0, 39470.21059578821, 3043.893463728781, 3187.0757480330676, 3410.0, 3423.4693622488553, 3769.095417099876, 28526.857365713247, 28574.714252857415, 28697.56953645697, 29204.707952920413, 30298.394032119453, 2720.7687346575567, 2739.301478123086, 2740.5341092014405, 2764.8894044238205, 2828.490871643103, 430979.45102744736, 437958.0, 438298.0, 438317.0, 438838.0, 35516.82241588776, 69309.30690693129, 69455.0, 69597.0, 69690.3030969694, 37067.443988340194, 37151.4427283591, 37344.0, 37607.87176384713, 37634.0, 14803.111813291236, 15092.320845561977, 15176.165310907785, 15207.619809504851, 15226.248981367284, 12612.747745045232, 12646.367681615882, 12711.936440317924, 12785.808212876815, 12794.93602532, 8364.498130112213, 8492.405531612727, 8529.360297977677, 8589.44168629037, 8641.438306510057, 3525.682688558042, 3562.5724913010604, 3572.7499075064497, 3623.3296840084668, 3652.4703917932284, 971.7133445633555, 990.7225976726528, 1023.6110278094277, 1077.1651969723528, 1115.1079136690614, 29220.561691574643, 29535.0, 29867.850660746994, 30008.099757007323, 30090.398192036475, 1135.137295655308, 1149.1898211760688, 1159.4956194055612, 1208.7219939413983, 1231.7743844874228, 15383.384664613513, 15385.846141538665, 15665.373385064699, 15667.451639192574, 15727.528174154793, 339245.0, 416171.91914040234, 416963.0, 420203.0, 573212.0, 55943.720281399146, 55961.0, 56601.71699141478, 56608.150877736865, 56991.0, 1470.8235011798652, 1488.9702205956037, 1496.6482876524008, 1501.0318344667628, 1510.4411367793987, 24556.754432455447, 24840.75159248457, 27237.86381068082, 27301.044463443683, 27652.170434886986, 43973.12053758971, 49264.522064338125, 49828.75085624694, 51371.22943155781, 51997.0, 449685.0, 450214.0, 452112.0, 453156.7342163268, 454843.0, 27017.72982270152, 27088.32279193036, 27329.31676708098, 27622.89508419721, 27646.44707105887, 43350.0, 44003.559964401225, 44352.33471497866, 44446.333304999804, 44545.77727111344, 30809.229769255948, 36569.45145822868, 37006.88979330625, 37318.0, 38048.0, 30247.69752302449, 31311.0, 35988.0, 36561.81719091388, 36689.81655091814, 24631.87684061568, 33965.811196608, 34831.65168348284, 36296.637033629326, 37288.81355593204, 30333.090007299816, 31356.216094597818, 31856.840715796272, 31926.201844954063, 32106.357872841945, 24206.0, 24319.63520547158, 24362.0, 24485.0, 24502.344094218854], "value": 18065.086396769577, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.50765159647506, 397.6182864450129, 401.8593492277701, 409.2449430800174, 416.35880743654775, 19605.50986225345, 20130.0, 20439.59120817583, 20858.687119693197, 20885.791142088576, 18788.53028674284, 19634.803651963477, 19724.21103155872, 20292.695609565868, 21827.345179644595, 5537.224788529609, 5842.532597392198, 5894.852628684274, 5908.370775005103, 5956.880862382761, 5624.943750562504, 5793.884122317551, 5840.561957853157, 6089.2692876854835, 6177.135201071854, 6103.572749907508, 6131.417515336036, 6148.938510614904, 6149.0468977308365, 6152.661603611799, 5608.046632072537, 5956.7319470623925, 5972.343042265347, 5984.0126379147605, 6138.785142520012, 5651.2370829937845, 5759.65442073477, 5776.9422305776825, 5956.047032474827, 6024.307204671475, 11676.94161529187, 13572.389242484112, 13983.23092229927, 15576.688466230611, 26794.598081028802, 2018.5760990192077, 2159.6652518859446, 2206.6579680149603, 2266.897989590456, 2273.499830037389, 8429.367797415218, 8476.957615211946, 9675.516224188832, 9972.85312189093, 10176.389416635026, 1711.922963466647, 1717.3216579451048, 1814.0929535232383, 1836.8163183681659, 1872.1762424533163, 115534.0, 118380.0, 118740.81259187384, 119353.20970185455, 126731.36634316861, 11704.88295117055, 11728.472218750177, 11744.354060526583, 11843.46704398287, 12022.0, 15158.0, 15174.848251517564, 15340.616484587752, 15377.769333460006, 15390.538283851502, 8731.432456890281, 8779.517126558101, 8837.469751814911, 8845.69040083594, 8850.247728943112, 8673.262772664268, 8687.956560217159, 8749.956250218835, 8761.737147885573, 8796.604152813139, 3820.1213720843807, 3996.4205190247253, 4665.113628410591, 4769.093872164278, 4801.567858892647, 1686.4181857259225, 1924.6150769846088, 1966.7934866839062, 1989.8607097503325, 1992.8604997650316, 731.5500966905315, 924.177482040984, 940.4200942416669, 966.5843687214425, 990.2276224544867, 18727.0, 19345.709814352795, 20172.798272017386, 20710.482237944172, 20734.546253834098, 785.6189747972343, 790.7192946504023, 867.505521852538, 992.6823416506649, 1022.5551884930079, 10600.310979786444, 11126.276792008493, 11133.99794018526, 11144.442777861075, 11168.441577921234, 546970.0, 551270.0, 555056.0, 562176.0, 567480.0, 119768.0, 125040.74959250473, 126106.36946815207, 129249.35375323064, 130876.0, 998.691713854838, 1031.3193292426963, 1052.9473526323652, 1053.4364115198332, 1058.5606973106228, 16066.39336066384, 16807.747883781998, 18014.36949706754, 18400.90799546047, 18446.0, 49516.0, 49760.751196243786, 50173.0, 50831.0, 51528.45414637567, 72061.6396918012, 72379.63810180915, 73154.63422682852, 74481.0, 75854.24145758692, 7758.495697779626, 7920.564368959763, 7929.960350198212, 8067.0, 8308.169183081885, 11264.94367528157, 12119.0, 12305.507779688713, 12374.13381063317, 12394.938025309815, 10450.216233782648, 10628.787424251626, 10852.077573406348, 10990.0, 11128.443577820915, 9470.384425012353, 10641.521131549254, 10685.786284274427, 10829.620963266249, 10923.726906827393, 9345.53272336394, 10822.026017658449, 11033.889661103607, 11368.829467557827, 11417.714557136138, 8002.399820013638, 8014.318782903519, 8049.718259860877, 8140.796480088045, 8337.08292087882, 8299.211574900375, 10686.946565267124, 10842.566297348018, 11079.279846809932, 11184.496697648463], "value": 9335.925889690838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1597.7044246814337, 1625.9756103658444, 1892.6687829629811, 1920.251102070192, 1966.2429964463686, 8003.839923201533, 8372.288355489783, 8745.169208925157, 8752.431091979017, 8870.911290887088, 7339.926600733991, 8555.144485551442, 8732.30141588673, 8733.650653973833, 8745.606447709852, 2204.732278939612, 2326.1858349577597, 2445.8654773987423, 2469.950600987979, 2472.3571871313497, 2403.759624037591, 2435.537247922889, 2437.878106094688, 2438.3660248335473, 2443.2670198940336, 2438.073532057824, 2458.4960083182905, 2481.950360992788, 2491.725910149882, 2497.0261597976805, 2430.4895971845935, 2443.987780061106, 2453.5338285725657, 2461.876906154685, 2466.580681284186, 2414.6860908082012, 2425.4300239443714, 2432.72023717273, 2434.7565243475688, 2440.9137933619545, 8904.59929303183, 8908.73273801787, 8968.641254349819, 8974.551272436353, 8975.192232699022, 5286.5242128208265, 5464.371597266326, 5465.644733092376, 5511.5039646432015, 5533.00405926933, 3460.688538031564, 3531.487934249545, 3589.351789432691, 3656.1042544576485, 3657.7805331680183, 983.7196399026243, 990.2869933647834, 991.1822746234313, 1047.3558761361785, 1050.5062620568397, 9645.662401815904, 11306.265092768943, 11636.243644163102, 11874.990625796818, 11965.965785816345, 4795.376601041842, 4848.660593758474, 4902.558769710743, 4916.877078073006, 4960.627952903475, 9899.1585715215, 9950.502474876228, 9959.55182016811, 9979.002099789963, 10039.096481316716, 5337.86655333612, 5399.649022813504, 5445.128779395278, 5445.537129343971, 5456.61803673739, 4449.644028477714, 4830.492798256132, 4906.70559766408, 4979.979104283613, 5006.924896126488, 3959.7328854766197, 3969.702272329587, 4061.329880569732, 4077.776666999888, 4100.200460910094, 1354.3228385807097, 1361.7276544691101, 1368.7809950407886, 1370.5340184337374, 1375.7042235919125, 830.5556527257888, 873.3493547307297, 945.579217248318, 952.5618215620754, 985.9112679858847, 5865.618734782225, 5959.731812068468, 5964.761409543657, 6103.877922441527, 6159.29168145669, 449.85379751580865, 462.4612326639495, 468.2227502346089, 468.372381009449, 471.6721878294621, 3953.584873588232, 4034.2133284009337, 4063.593640635913, 4128.669706423479, 4155.8753237402925, 10291.588336466457, 10747.40889251083, 10802.72993175177, 10878.0, 10901.0, 10599.84100238497, 10648.414337211529, 10713.464326783629, 10800.135989120852, 10883.510242039127, 7749.7287594933905, 8179.304759095544, 8200.75397738057, 8205.95897020511, 8278.958605206935, 4914.213725803854, 5925.140854575976, 5967.9701601491715, 6045.486133678686, 6070.0591408331775, 9736.9026309736, 10128.746781330527, 10131.848022279819, 10175.440350780778, 10245.692629221136, 10034.247431442525, 10095.646652367426, 10125.898741012496, 10158.847617285599, 10385.636502722671, 6900.102986611709, 7304.890426643498, 7485.401167906445, 7509.887351689838, 7664.156942736406, 8183.918160818554, 8220.095789463036, 8244.958775206325, 8289.668413263402, 8307.252347288773, 7226.4218862491925, 7368.336849683555, 7410.147832999274, 7506.549607023596, 7575.772726818204, 6114.633122012693, 6869.7595584154315, 7048.365647091787, 7161.749338773118, 7325.743598974011, 6846.0, 6894.13823272091, 6933.5493192942295, 6966.721331146698, 6998.965005174941, 4874.512548745097, 4909.852704418873, 4946.678465899849, 4990.875228119181, 5118.411382691038, 4936.3089167515855, 4966.8758281043265, 5018.799248030038, 5065.164247899203, 5260.815871444481], "value": 4549.525987127089, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.1279386907462, 322.5419903736694, 329.2394568546659, 330.3063566510328, 330.9586301712286, 5420.322459692538, 5532.114861622136, 5688.118341657039, 5697.230873832036, 5714.942850571493, 4607.378003969463, 5481.205225242347, 5562.666240025601, 5564.666120032791, 5594.475480447312, 4166.187593419285, 4205.789710514462, 4211.284081706117, 4224.577542245782, 4225.640820530243, 3760.417135344026, 3817.7136714746366, 3882.2730179028167, 4157.147784704129, 4224.134052519226, 4103.815328310233, 4142.399352093945, 4155.480564929384, 4164.022089507474, 4183.330667093266, 3663.7360110761742, 4131.669466442678, 4156.106437116019, 4165.625343636592, 4183.477065366829, 3042.680518545543, 3072.4023507776055, 3602.981985090084, 3612.277544491086, 3619.4389869569995, 5079.644424890259, 5218.191180367011, 5388.380336261341, 5407.486288802596, 5430.266913966603, 4782.545658162469, 4787.425508938914, 4803.807847686088, 4812.278158276286, 4826.276058591205, 4327.242732521828, 4764.499727528594, 5651.378348381675, 5675.6878371689545, 5921.940780592182, 3553.982230088859, 3818.7135964802474, 3862.575116737157, 3867.535895692507, 4014.0, 4913.034786085559, 5492.780288788404, 5780.53755699543, 5895.351511333793, 6098.878022439526, 3355.647656996029, 3532.152283452004, 3789.4947173864066, 4001.4598029265676, 4012.197560487914, 4098.581836716352, 4101.097758493127, 4106.733062350938, 4107.774072426046, 4128.277551428488, 4492.281235002384, 4532.410786597721, 4611.608013318838, 4656.674032817738, 4741.739204343794, 4705.976470117627, 4918.827841025547, 5910.788288400953, 5924.0, 5965.433283838029, 1468.0531057467874, 1494.3574263066769, 1499.3627708224178, 1500.4373359990004, 1500.9099454032576, 946.5740416812462, 975.9756006099905, 984.9901500985042, 988.471167925171, 995.4873240281261, 5990.580659353891, 6037.849053773691, 6059.757609695651, 6073.544484163705, 6073.817785466443, 6538.640374779337, 6667.299933506912, 6683.732650694015, 6740.831479213059, 6747.156605424322, 5700.37295897451, 5766.500709815478, 5963.4334738199805, 6035.034394496859, 6051.788187413419, 3349.8945348035577, 3401.36734367505, 3460.775049621817, 3469.8438570264398, 3511.9806111485996, 6687.331266873273, 6868.759593414206, 6872.931270687329, 6894.620795856175, 6920.792376228721, 5531.917021244684, 6393.6163830170335, 6766.221884483249, 6777.288384719632, 6780.660966951633, 6154.969225153935, 6389.297177310492, 6692.111200564546, 6893.105395451554, 6901.861962760717, 6265.0, 6601.966990165019, 6627.5360724750735, 6629.668516574248, 6636.668166591555, 5624.762552238501, 6054.700188397422, 6109.0, 6227.252729672468, 6513.316101809241, 5668.801591944427, 5733.569982251264, 5821.57371443982, 6301.054841773771, 6403.199600049994, 3556.4665300205174, 3673.7061035117663, 4071.7353372030725, 4073.3279008964373, 4076.103257283393, 5254.687937307573, 5642.181883626769, 6017.308009578955, 6170.475509581556, 6193.38066193377, 5058.747062646779, 5713.885722285448, 5923.85190370227, 5945.762169513171, 5970.671613061323, 5019.974900125476, 5875.794347197828, 5909.497692695997, 5937.387549478216, 5969.1495636352865, 4636.489986101458, 5489.368722596792, 5594.524465420485, 5738.5696072795545, 5801.477866991991, 4911.410630724193, 5591.4688104629995, 5897.250181073419, 5917.615355001911, 5946.345901950695, 5174.249733788655, 5796.855078623068, 5802.593818432669, 5823.505002074871, 5875.970620146872], "value": 4371.365032469386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9420555047275, 679.8606285711429, 718.75562308815, 726.8473620539686, 749.2208103572286, 13628.0, 15036.774448383268, 15136.243187840619, 15283.694326113486, 15306.31121599528, 13971.371288292026, 14026.789598156036, 14074.577762667112, 14281.78577321341, 14294.857051429482, 851.1403482482706, 908.3414524469773, 909.8271328447573, 917.7843206846386, 919.8896132464114, 703.2053779229464, 885.6413152673146, 925.0379605210572, 926.1988380051274, 933.9019402962693, 962.4033099478333, 963.9228861691048, 971.519098046468, 972.6498460554195, 982.9066238707311, 944.84882418813, 950.9144177024032, 962.7496850818768, 962.9133377995979, 974.8878878928907, 703.2124021096405, 706.2372637551483, 712.508369225233, 714.8248679073608, 724.0117239967459, 14573.271336433241, 14578.854211457856, 14626.561203163816, 14630.853691463055, 14646.97471177018, 10329.380237185793, 12686.682832929158, 12784.424700888483, 12878.0, 13165.736685266242, 9672.177864881494, 10007.999200080007, 10060.899391006069, 10100.141487973531, 10516.579336826519, 3430.485427185917, 3445.3453843769603, 3455.1016735648914, 3513.0, 3573.7855728656364, 73055.0, 74459.0, 75130.62434687847, 75206.62396687982, 75387.24612753857, 9127.767751353615, 9144.679936202201, 9174.86237706435, 9250.768730781785, 9388.295877809192, 20230.494237644176, 20241.291554795513, 20315.288964886156, 20345.694814577793, 20364.287249946476, 7180.856382872418, 7192.0, 7376.409887209011, 7377.557346559223, 7527.8118047049265, 3305.520699498559, 3951.585083566184, 3986.123052928351, 3991.3015222335976, 4062.3500239962054, 3460.602030766494, 3528.2237907660788, 3536.328097661436, 3540.2034542228307, 3546.219831637036, 558.4582954534095, 623.7006237006262, 633.8383712153463, 646.2309851276965, 647.601724939159, 485.8129620096218, 590.3152343281772, 599.7001499250375, 601.0803470689851, 605.5639939243738, 7720.768376948588, 8092.8381432371025, 8220.301274391744, 8270.503769773833, 8293.419460637697, 519.2393144043994, 538.464228093042, 540.4271472239438, 572.5734327925722, 610.2272897233544, 3593.8562457501407, 3826.7129965252716, 3858.074062225102, 3942.704297177723, 3983.9203215935518, 83304.0, 92864.67838304097, 95202.0, 98032.50983745178, 98834.0, 46179.76910115428, 79066.81399779009, 79113.64874931934, 79206.81189782158, 80100.19899800928, 72113.0, 73485.16287092866, 73857.52284954271, 74030.0, 74360.88458673125, 6151.5386346025125, 7633.885491717518, 7670.7315243966195, 7723.189065148079, 7901.960490197513, 33811.83094084514, 35441.46837797383, 43581.34627980519, 44325.0, 44703.0, 40256.59101931418, 59213.703931480064, 62920.37079629145, 63308.36691633025, 63498.68250658902, 9651.0, 10552.46363536799, 11076.778464430505, 11304.982551570398, 11315.547378105113, 11768.94115529417, 11974.101942354184, 12011.579594714143, 12030.819537707117, 12114.878851211375, 11025.117990560897, 11055.447227638426, 11079.446027698745, 11129.109671226444, 11402.828957565478, 10824.296420732628, 11019.283746556768, 11147.108231341635, 11292.774144517229, 11324.716882077684, 9630.951845240728, 11240.55037798479, 11268.492917818554, 11294.134035133065, 11472.347341767094, 9320.906790932004, 9426.868775746954, 9489.335746497678, 9837.065478779505, 10014.499275036365, 9426.717198484057, 9463.952680236554, 9473.763155921157, 9557.808843823224, 9560.282978776759], "value": 6714.204156483316, "unit": "score"}], "name": "dromaeo_css", "value": 7099.083005270691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 110.0, 128.0, 119.0, 149.0, 95.0, 96.0, 128.0, 169.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 124.0, 158.0, 203.0, 153.0, 173.0, 137.0, 155.0, 214.0, 105.0], "value": 159.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 225.0, 201.0, 201.0, 200.0, 195.0, 217.0, 191.0, 238.0, 194.0], "value": 206.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 89.0, 75.0, 135.0, 47.0, 57.0, 92.0, 51.0, 79.0, 71.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 92.0, 130.0, 78.0, 81.0, 86.0, 123.0, 81.0, 79.0, 126.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 86.0, 88.0, 84.0, 92.0, 86.0, 85.0, 127.0, 134.0, 85.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 97.0, 94.0, 108.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 90.0, 91.0, 94.0, 92.0, 90.0, 92.0, 101.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 61.0, 63.0, 63.0, 62.0, 81.0, 64.0, 59.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 76.0, 68.0, 79.0, 76.0, 71.0, 67.0, 66.0, 68.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 81.0, 85.0, 82.0, 84.0, 84.0, 85.0, 85.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 169.0, 156.0, 161.0, 140.0, 137.0, 137.0, 141.0, 220.0, 140.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 174.0, 175.0, 170.0, 176.0, 202.0, 234.0, 170.0, 171.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 70.0, 73.0, 70.0, 72.0, 68.0, 73.0, 71.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1572.5, "alertThreshold": 2.0}]} 08:30:50 INFO - Return code: 0 08:30:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:30:50 ERROR - # TBPL SUCCESS # 08:30:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:50 INFO - 2016-04-25 08:30:50.382 screenresolution[6382:104693] starting screenresolution argv=screenresolution get 08:30:50 INFO - 2016-04-25 08:30:50.385 screenresolution[6382:104693] Display 0: 1600x1200x32@60 08:30:50 INFO - 2016-04-25 08:30:50.392 screenresolution[6383:104696] starting screenresolution argv=screenresolution list 08:30:50 INFO - Available Modes on Display 0 08:30:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:50 INFO - Intel Iris: 08:30:50 INFO - Chipset Model: Intel Iris 08:30:50 INFO - Type: GPU 08:30:50 INFO - Bus: Built-In 08:30:50 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:50 INFO - Vendor: Intel (0x8086) 08:30:50 INFO - Device ID: 0x0a2e 08:30:50 INFO - Revision ID: 0x0009 08:30:50 INFO - Displays: 08:30:50 INFO - Display: 08:30:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:50 INFO - Display Serial Number: 1600x1200 60 08:30:50 INFO - Main Display: Yes 08:30:50 INFO - Mirror: Off 08:30:50 INFO - Online: Yes 08:30:50 INFO - Rotation: Supported 08:30:50 INFO - Return code: 0 08:30:50 INFO - Running post-action listener: _resource_record_post_action 08:30:50 INFO - Running post-run listener: _resource_record_post_run 08:30:51 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 5832192; Write bytes: 696606208; Read time: 70; Write time: 1979 08:30:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 373967360; Write bytes: 368887808; Read time: 28258; Write time: 787 08:30:51 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 5832192; Write bytes: 298227200; Read time: 70; Write time: 1139 08:30:51 INFO - Running post-run listener: _upload_blobber_files 08:30:51 INFO - Blob upload gear active. 08:30:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:30:51 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'] 08:30:51 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 08:30:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:52 INFO - (blobuploader) - INFO - Done attempting. 08:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:53 INFO - (blobuploader) - INFO - Done attempting. 08:30:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:53 INFO - Return code: 0 08:30:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c952cec94db6a945982e329d67617bc16e1e560a30fd0dba6afac291199f137fbff25e1df6059422ea02e976cc77b17b0f8dc570c3390deedb74ed07a26b2d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68a1d93d3ea04a89c1ea692cb693e91863a93e18702820fe0edf465370356b422e6bbcd62e55cc530ca63c3c47f74113e58ac34a4ec27dd3e90825f8fca0fce"} 08:30:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:53 INFO - Contents: 08:30:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c952cec94db6a945982e329d67617bc16e1e560a30fd0dba6afac291199f137fbff25e1df6059422ea02e976cc77b17b0f8dc570c3390deedb74ed07a26b2d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68a1d93d3ea04a89c1ea692cb693e91863a93e18702820fe0edf465370356b422e6bbcd62e55cc530ca63c3c47f74113e58ac34a4ec27dd3e90825f8fca0fce"} 08:30:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:53 INFO - Copying logs to upload dir... 08:30:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.138969 ========= master_lag: 56.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-04-25 08:31:49.648275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 08:31:49.655811) ========= 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.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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/1c952cec94db6a945982e329d67617bc16e1e560a30fd0dba6afac291199f137fbff25e1df6059422ea02e976cc77b17b0f8dc570c3390deedb74ed07a26b2d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68a1d93d3ea04a89c1ea692cb693e91863a93e18702820fe0edf465370356b422e6bbcd62e55cc530ca63c3c47f74113e58ac34a4ec27dd3e90825f8fca0fce"} build_url:https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011062 build_url: 'https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/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/1c952cec94db6a945982e329d67617bc16e1e560a30fd0dba6afac291199f137fbff25e1df6059422ea02e976cc77b17b0f8dc570c3390deedb74ed07a26b2d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68a1d93d3ea04a89c1ea692cb693e91863a93e18702820fe0edf465370356b422e6bbcd62e55cc530ca63c3c47f74113e58ac34a4ec27dd3e90825f8fca0fce"}' ========= master_lag: 3.72 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 08:31:53.382965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:31:53.385468) ========= 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.bFk354x29Y/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.sGW0gMYvxP/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005272 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:31:53.550819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 08:31:53.551117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 08:31:53.601332) ========= ========= Total master_lag: 60.02 =========