builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1461173845.54 results: success (0) buildid: 20160420094342 builduid: a1e895ebc7944c22b05b8dd4b95d21b5 revision: b29a652d68e85d25953a2bb371d35114cd8036a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:25.542417) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:25.542845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:25.543125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:25.568598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 10:37:25.568913) ========= 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.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-20 10:37:25-- 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% 66.9M=0s 2016-04-20 10:37:25 (66.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095444 ========= master_lag: 5.83 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 10:37:31.490809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 10:37:31.491146) ========= 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.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.027099 ========= master_lag: 5.91 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 10:37:37.431464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 10:37:37.431873) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b29a652d68e85d25953a2bb371d35114cd8036a0 --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 b29a652d68e85d25953a2bb371d35114cd8036a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-20 10:37:37,505 truncating revision to first 12 chars 2016-04-20 10:37:37,506 Setting DEBUG logging. 2016-04-20 10:37:37,506 attempt 1/10 2016-04-20 10:37:37,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b29a652d68e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 10:37:38,532 unpacking tar archive at: fx-team-b29a652d68e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267804 ========= master_lag: 3.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 10:37:42.164163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:42.164535) ========= script_repo_revision: b29a652d68e85d25953a2bb371d35114cd8036a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:42.171196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:42.171584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:37:42.503488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 10:37:42.503942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:37:42 INFO - MultiFileLogger online at 20160420 10:37:42 in /builds/slave/test 10:37:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:37:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:42 INFO - {'append_to_log': False, 10:37:42 INFO - 'base_work_dir': '/builds/slave/test', 10:37:42 INFO - 'blob_upload_branch': 'Fx-Team', 10:37:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:42 INFO - 'branch': 'Fx-Team', 10:37:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:42 INFO - 'config_files': ('talos/mac_config.py',), 10:37:42 INFO - 'default_actions': ('clobber', 10:37:42 INFO - 'read-buildbot-config', 10:37:42 INFO - 'download-and-extract', 10:37:42 INFO - 'populate-webroot', 10:37:42 INFO - 'create-virtualenv', 10:37:42 INFO - 'install', 10:37:42 INFO - 'run-tests'), 10:37:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:42 INFO - 'download_minidump_stackwalk': True, 10:37:42 INFO - 'download_symbols': 'ondemand', 10:37:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:42 INFO - 'installer_path': 'installer.exe', 10:37:42 INFO - 'log_level': 'info', 10:37:42 INFO - 'log_name': 'talos', 10:37:42 INFO - 'log_to_console': True, 10:37:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:37:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:37:42 INFO - 'opt_config_files': (), 10:37:42 INFO - 'pip_index': False, 10:37:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:37:42 INFO - 'cmd': ('bash', 10:37:42 INFO - '-c', 10:37:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:37:42 INFO - 'enabled': True, 10:37:42 INFO - 'halt_on_failure': False, 10:37:42 INFO - 'name': 'check_screen_resolution'},), 10:37:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:37:42 INFO - 'cmd': ('bash', 10:37:42 INFO - '-c', 10:37:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:37:42 INFO - 'enabled': True, 10:37:42 INFO - 'halt_on_failure': False, 10:37:42 INFO - 'name': 'check_screen_resolution'},), 10:37:42 INFO - 'run_cmd_checks_enabled': True, 10:37:42 INFO - 'sps_profile': False, 10:37:42 INFO - 'sps_profile_interval': 0, 10:37:42 INFO - 'suite': 'dromaeojs', 10:37:42 INFO - 'system_bits': '32', 10:37:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:42 INFO - 'title': 't-yosemite-r7-0144', 10:37:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:42 INFO - 'use_talos_json': True, 10:37:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:42 INFO - 'work_dir': 'build'} 10:37:42 INFO - ##### 10:37:42 INFO - ##### Running clobber step. 10:37:42 INFO - ##### 10:37:42 INFO - Running pre-action listener: _resource_record_pre_action 10:37:42 INFO - Running main action method: clobber 10:37:42 INFO - rmtree: /builds/slave/test/build 10:37:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:44 INFO - Running post-action listener: _resource_record_post_action 10:37:44 INFO - ##### 10:37:44 INFO - ##### Running read-buildbot-config step. 10:37:44 INFO - ##### 10:37:44 INFO - Running pre-action listener: _resource_record_pre_action 10:37:44 INFO - Running main action method: read_buildbot_config 10:37:44 INFO - Using buildbot properties: 10:37:44 INFO - { 10:37:44 INFO - "project": "", 10:37:44 INFO - "product": "firefox", 10:37:44 INFO - "script_repo_revision": "production", 10:37:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:37:44 INFO - "repository": "", 10:37:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:37:44 INFO - "buildid": "20160420094342", 10:37:44 INFO - "pgo_build": "False", 10:37:44 INFO - "basedir": "/builds/slave/test", 10:37:44 INFO - "buildnumber": 656, 10:37:44 INFO - "slavename": "t-yosemite-r7-0144", 10:37:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:37:44 INFO - "platform": "yosemite_r7", 10:37:44 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:37:44 INFO - "branch": "fx-team", 10:37:44 INFO - "repo_path": "integration/fx-team", 10:37:44 INFO - "revision": "b29a652d68e85d25953a2bb371d35114cd8036a0", 10:37:44 INFO - "stage_platform": "macosx64", 10:37:44 INFO - "builduid": "a1e895ebc7944c22b05b8dd4b95d21b5", 10:37:44 INFO - "slavebuilddir": "test" 10:37:44 INFO - } 10:37:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:37:44 INFO - Running post-action listener: _resource_record_post_action 10:37:44 INFO - ##### 10:37:44 INFO - ##### Running download-and-extract step. 10:37:44 INFO - ##### 10:37:44 INFO - Running pre-action listener: _resource_record_pre_action 10:37:44 INFO - Running main action method: download_and_extract 10:37:44 INFO - mkdir: /builds/slave/test/build/tests 10:37: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')]} 10:37:44 INFO - https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:45 INFO - Downloaded 1199 bytes. 10:37:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:37:45 INFO - Using the following test package requirements: 10:37:45 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:37:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:37:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:37:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'jsshell-mac.zip'], 10:37:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:37:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:37:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:37:45 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:37:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:37:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:37:45 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:37:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:37:45 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')]} 10:37:45 INFO - https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:46 INFO - Downloaded 18096067 bytes. 10:37:46 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'] 10:37:46 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 10:37:49 INFO - Return code: 0 10:37:49 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 10:37:49 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')]} 10:37:49 INFO - https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:50 INFO - Downloaded 18096067 bytes. 10:37:50 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'] 10:37:50 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 10:37:54 INFO - Return code: 0 10:37:54 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')]} 10:37:54 INFO - https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:37:57 INFO - Downloaded 10845952 bytes. 10:37:57 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'] 10:37:57 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 10:37:57 INFO - Return code: 0 10:37:57 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')]} 10:37:57 INFO - https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:37:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:37:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:37:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:37:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cG8M9ovIRYOxGU3rY0CzXw/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 10:38:00 INFO - Downloaded 110036584 bytes. 10:38:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:38:00 INFO - mkdir: /builds/slave/test/properties 10:38:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:00 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:00 INFO - Contents: 10:38:00 INFO - build_url:https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:38:01 INFO - Running post-action listener: _resource_record_post_action 10:38:01 INFO - Running post-action listener: set_extra_try_arguments 10:38:01 INFO - ##### 10:38:01 INFO - ##### Running populate-webroot step. 10:38:01 INFO - ##### 10:38:01 INFO - Running pre-action listener: _resource_record_pre_action 10:38:01 INFO - Running main action method: populate_webroot 10:38:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:38:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:38:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:38:01 INFO - '--tppagecycles', 10:38:01 INFO - '7'], 10:38:01 INFO - 'tests': ['tsvgm']}}, 10:38:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:38:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:38:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['damp', 'tps']}, 10:38:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'tests': ['damp', 'tps']}, 10:38:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['dromaeo_dom']}, 10:38:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['a11yr', 10:38:01 INFO - 'ts_paint', 10:38:01 INFO - 'tpaint', 10:38:01 INFO - 'sessionrestore', 10:38:01 INFO - 'sessionrestore_no_auto_restore', 10:38:01 INFO - 'tabpaint']}, 10:38:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['tsvgx', 10:38:01 INFO - 'tsvgr_opacity', 10:38:01 INFO - 'tart', 10:38:01 INFO - 'tscrollx', 10:38:01 INFO - 'cart']}, 10:38:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:01 INFO - 'tsvgr_opacity', 10:38:01 INFO - 'tart', 10:38:01 INFO - 'tscrollx', 10:38:01 INFO - 'cart']}, 10:38:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'talos_options': ['--disable-e10s'], 10:38:01 INFO - 'tests': ['tp5o']}, 10:38:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'tests': ['tp5o']}, 10:38:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'talos_options': ['--disable-e10s', 10:38:01 INFO - '--xperf_path', 10:38:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:01 INFO - 'tests': ['tp5n']}, 10:38:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:01 INFO - 'talos_options': ['--xperf_path', 10:38:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:01 INFO - 'tests': ['tp5n']}}, 10:38:01 INFO - 'talos.zip': {'path': '', 10:38:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:38:01 INFO - Running post-action listener: _resource_record_post_action 10:38:01 INFO - ##### 10:38:01 INFO - ##### Running create-virtualenv step. 10:38:01 INFO - ##### 10:38:01 INFO - Running pre-action listener: _resource_record_pre_action 10:38:01 INFO - Running main action method: create_virtualenv 10:38:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38:01 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 10:38:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:01 INFO - Using real prefix '/tools/python27' 10:38:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:05 INFO - Installing pip.................done. 10:38:05 INFO - Return code: 0 10:38:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38:05 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')]} 10:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:05 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')]} 10:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:05 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:05 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 10:38:05 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 10:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:05 INFO - 'HOME': '/Users/cltbld', 10:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:05 INFO - 'LOGNAME': 'cltbld', 10:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:05 INFO - 'MOZ_NO_REMOTE': '1', 10:38:05 INFO - 'NO_EM_RESTART': '1', 10:38:05 INFO - 'PAGER': '/bin/cat', 10:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:05 INFO - 'PWD': '/builds/slave/test', 10:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:05 INFO - 'SHELL': '/bin/bash', 10:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:05 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:05 INFO - 'USER': 'cltbld', 10:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:05 INFO - 'XPC_FLAGS': '0x0', 10:38:05 INFO - 'XPC_SERVICE_NAME': '0', 10:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:05 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 10:38:05 INFO - Cleaning up... 10:38:05 INFO - Return code: 0 10:38:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:38:05 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')]} 10:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:05 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')]} 10:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:05 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:05 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 10:38:05 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 10:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:05 INFO - 'HOME': '/Users/cltbld', 10:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:05 INFO - 'LOGNAME': 'cltbld', 10:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:05 INFO - 'MOZ_NO_REMOTE': '1', 10:38:05 INFO - 'NO_EM_RESTART': '1', 10:38:05 INFO - 'PAGER': '/bin/cat', 10:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:05 INFO - 'PWD': '/builds/slave/test', 10:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:05 INFO - 'SHELL': '/bin/bash', 10:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:05 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:05 INFO - 'USER': 'cltbld', 10:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:05 INFO - 'XPC_FLAGS': '0x0', 10:38:05 INFO - 'XPC_SERVICE_NAME': '0', 10:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:05 INFO - Downloading/unpacking psutil>=0.7.1 10:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:38:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:08 INFO - Installing collected packages: psutil 10:38:08 INFO - Running setup.py install for psutil 10:38:08 INFO - building 'psutil._psutil_osx' extension 10:38:08 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 10:38:09 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 10:38:09 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 10:38:09 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 10:38:09 INFO - building 'psutil._psutil_posix' extension 10:38:09 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 10:38:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:38:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:38:09 INFO - ^ 10:38:09 INFO - 1 warning generated. 10:38:09 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 10:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:09 INFO - Successfully installed psutil 10:38:09 INFO - Cleaning up... 10:38:09 INFO - Return code: 0 10:38:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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', '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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:38: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 mozsystemmonitor==0.0.0 10:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:10 INFO - 'HOME': '/Users/cltbld', 10:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:10 INFO - 'LOGNAME': 'cltbld', 10:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:10 INFO - 'MOZ_NO_REMOTE': '1', 10:38:10 INFO - 'NO_EM_RESTART': '1', 10:38:10 INFO - 'PAGER': '/bin/cat', 10:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:10 INFO - 'PWD': '/builds/slave/test', 10:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:10 INFO - 'SHELL': '/bin/bash', 10:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:10 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:10 INFO - 'USER': 'cltbld', 10:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:10 INFO - 'XPC_FLAGS': '0x0', 10:38:10 INFO - 'XPC_SERVICE_NAME': '0', 10:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:38:13 INFO - Installing collected packages: mozsystemmonitor 10:38:13 INFO - Running setup.py install for mozsystemmonitor 10:38:13 INFO - Successfully installed mozsystemmonitor 10:38:13 INFO - Cleaning up... 10:38:13 INFO - Return code: 0 10:38:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:13 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:13 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 10:38:13 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 10:38:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:13 INFO - 'HOME': '/Users/cltbld', 10:38:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:13 INFO - 'LOGNAME': 'cltbld', 10:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:13 INFO - 'MOZ_NO_REMOTE': '1', 10:38:13 INFO - 'NO_EM_RESTART': '1', 10:38:13 INFO - 'PAGER': '/bin/cat', 10:38:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:13 INFO - 'PWD': '/builds/slave/test', 10:38:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:13 INFO - 'SHELL': '/bin/bash', 10:38:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:13 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:13 INFO - 'USER': 'cltbld', 10:38:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:13 INFO - 'XPC_FLAGS': '0x0', 10:38:13 INFO - 'XPC_SERVICE_NAME': '0', 10:38:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:38:13 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 10:38:13 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 10:38:13 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 10:38:13 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 10:38:13 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 10:38:13 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 10:38:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:17 INFO - Downloading docopt-0.6.1.tar.gz 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:17 INFO - Running setup.py install for blobuploader 10:38:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:17 INFO - Running setup.py install for requests 10:38:18 INFO - Running setup.py install for docopt 10:38:18 INFO - Successfully installed blobuploader requests docopt 10:38:18 INFO - Cleaning up... 10:38:18 INFO - Return code: 0 10:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:18 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')]} 10:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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')]} 10:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:18 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 10:38:18 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 10:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:18 INFO - 'HOME': '/Users/cltbld', 10:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:18 INFO - 'LOGNAME': 'cltbld', 10:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:18 INFO - 'MOZ_NO_REMOTE': '1', 10:38:18 INFO - 'NO_EM_RESTART': '1', 10:38:18 INFO - 'PAGER': '/bin/cat', 10:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:18 INFO - 'PWD': '/builds/slave/test', 10:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:18 INFO - 'SHELL': '/bin/bash', 10:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:18 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:18 INFO - 'USER': 'cltbld', 10:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:18 INFO - 'XPC_FLAGS': '0x0', 10:38:18 INFO - 'XPC_SERVICE_NAME': '0', 10:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:18 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-yvBiFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:18 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-nywEc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:18 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-J95ykp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:18 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tyA1uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VNSQj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zcbv7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cnNEY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tzZXbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UX14wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-LARVZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Cadsjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-I183X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:19 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-m2_Eex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-NhrQwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-WIpvld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-sN4uuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:20 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-QfgjRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:20 INFO - Running setup.py install for manifestparser 10:38:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozcrash 10:38:20 INFO - Running setup.py install for mozdebug 10:38:20 INFO - Running setup.py install for mozdevice 10:38:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozfile 10:38:21 INFO - Running setup.py install for mozhttpd 10:38:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozinfo 10:38:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozInstall 10:38:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozleak 10:38:21 INFO - Running setup.py install for mozlog 10:38:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for moznetwork 10:38:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Running setup.py install for mozprocess 10:38:22 INFO - Running setup.py install for mozprofile 10:38:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Running setup.py install for mozrunner 10:38:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Running setup.py install for mozscreenshot 10:38:22 INFO - Running setup.py install for moztest 10:38:22 INFO - Running setup.py install for mozversion 10:38:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:23 INFO - Cleaning up... 10:38:23 INFO - Return code: 0 10:38:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:23 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:23 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 10:38:23 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 10:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:23 INFO - 'HOME': '/Users/cltbld', 10:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:23 INFO - 'LOGNAME': 'cltbld', 10:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:23 INFO - 'MOZ_NO_REMOTE': '1', 10:38:23 INFO - 'NO_EM_RESTART': '1', 10:38:23 INFO - 'PAGER': '/bin/cat', 10:38:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:23 INFO - 'PWD': '/builds/slave/test', 10:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:23 INFO - 'SHELL': '/bin/bash', 10:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:23 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:23 INFO - 'USER': 'cltbld', 10:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:23 INFO - 'XPC_FLAGS': '0x0', 10:38:23 INFO - 'XPC_SERVICE_NAME': '0', 10:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-IEU8ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Tl0hot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pjAVH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3LfejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-S4funW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-G3X1mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:23 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-JgZVZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-jpEyx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1RiXHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tynyWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-PpP4N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZQVWcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-PUkSYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-9_xCWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pxn8D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:24 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)) 10:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:24 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-GzNyP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:25 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)) 10:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:25 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-g5yC3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:25 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)) 10:38:25 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)) 10:38:25 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)) 10:38:25 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)) 10:38:25 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)) 10:38:25 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)) 10:38:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:27 INFO - Downloading blessings-1.6.tar.gz 10:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:27 INFO - Installing collected packages: blessings 10:38:27 INFO - Running setup.py install for blessings 10:38:27 INFO - Successfully installed blessings 10:38:27 INFO - Cleaning up... 10:38:27 INFO - Return code: 0 10:38:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:28 INFO - Reading from file tmpfile_stdout 10:38:28 INFO - Current package versions: 10:38:28 INFO - blessings == 1.6 10:38:28 INFO - blobuploader == 1.2.4 10:38:28 INFO - docopt == 0.6.1 10:38:28 INFO - manifestparser == 1.1 10:38:28 INFO - mozInstall == 1.12 10:38:28 INFO - mozcrash == 0.17 10:38:28 INFO - mozdebug == 0.1 10:38:28 INFO - mozdevice == 0.48 10:38:28 INFO - mozfile == 1.2 10:38:28 INFO - mozhttpd == 0.7 10:38:28 INFO - mozinfo == 0.9 10:38:28 INFO - mozleak == 0.1 10:38:28 INFO - mozlog == 3.1 10:38:28 INFO - moznetwork == 0.27 10:38:28 INFO - mozprocess == 0.22 10:38:28 INFO - mozprofile == 0.28 10:38:28 INFO - mozrunner == 6.11 10:38:28 INFO - mozscreenshot == 0.1 10:38:28 INFO - mozsystemmonitor == 0.0 10:38:28 INFO - moztest == 0.7 10:38:28 INFO - mozversion == 1.4 10:38:28 INFO - psutil == 3.1.1 10:38:28 INFO - requests == 1.2.3 10:38:28 INFO - wsgiref == 0.1.2 10:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:28 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:28 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 10:38:28 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 10:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:28 INFO - 'HOME': '/Users/cltbld', 10:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:28 INFO - 'LOGNAME': 'cltbld', 10:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:28 INFO - 'MOZ_NO_REMOTE': '1', 10:38:28 INFO - 'NO_EM_RESTART': '1', 10:38:28 INFO - 'PAGER': '/bin/cat', 10:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:28 INFO - 'PWD': '/builds/slave/test', 10:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:28 INFO - 'SHELL': '/bin/bash', 10:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:28 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:28 INFO - 'USER': 'cltbld', 10:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:28 INFO - 'XPC_FLAGS': '0x0', 10:38:28 INFO - 'XPC_SERVICE_NAME': '0', 10:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 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)) 10:38:28 INFO - Cleaning up... 10:38:28 INFO - Return code: 0 10:38:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:28 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:28 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 10:38:28 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 10:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:28 INFO - 'HOME': '/Users/cltbld', 10:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:28 INFO - 'LOGNAME': 'cltbld', 10:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:28 INFO - 'MOZ_NO_REMOTE': '1', 10:38:28 INFO - 'NO_EM_RESTART': '1', 10:38:28 INFO - 'PAGER': '/bin/cat', 10:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:28 INFO - 'PWD': '/builds/slave/test', 10:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:28 INFO - 'SHELL': '/bin/bash', 10:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:28 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:28 INFO - 'USER': 'cltbld', 10:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:28 INFO - 'XPC_FLAGS': '0x0', 10:38:28 INFO - 'XPC_SERVICE_NAME': '0', 10:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:28 INFO - Downloading/unpacking jsonschema 10:38:28 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 10:38:28 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 10:38:28 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 10:38:28 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 10:38:28 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 10:38:28 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 10:38:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:38:31 INFO - Downloading/unpacking functools32 (from jsonschema) 10:38:31 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 10:38:31 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 10:38:31 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 10:38:31 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 10:38:31 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 10:38:31 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 10:38:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:38:31 INFO - warning: no files found matching '*.txt' 10:38:31 INFO - no previously-included directories found matching 'build' 10:38:31 INFO - no previously-included directories found matching 'dist' 10:38:31 INFO - no previously-included directories found matching '.git*' 10:38:31 INFO - Installing collected packages: jsonschema, functools32 10:38:31 INFO - Running setup.py install for functools32 10:38:31 INFO - warning: no files found matching '*.txt' 10:38:31 INFO - no previously-included directories found matching 'build' 10:38:31 INFO - no previously-included directories found matching 'dist' 10:38:31 INFO - no previously-included directories found matching '.git*' 10:38:31 INFO - Successfully installed jsonschema functools32 10:38:31 INFO - Cleaning up... 10:38:31 INFO - Return code: 0 10:38:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:38:31 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')]} 10:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:31 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')]} 10:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:31 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 0x10b4e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa983454e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, '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.b40sY5MVDa/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.4IYW4fbnYo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 10:38:31 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 10:38:31 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 10:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:31 INFO - 'HOME': '/Users/cltbld', 10:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:31 INFO - 'LOGNAME': 'cltbld', 10:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:31 INFO - 'MOZ_NO_REMOTE': '1', 10:38:31 INFO - 'NO_EM_RESTART': '1', 10:38:31 INFO - 'PAGER': '/bin/cat', 10:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:31 INFO - 'PWD': '/builds/slave/test', 10:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:31 INFO - 'SHELL': '/bin/bash', 10:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:38:31 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:31 INFO - 'USER': 'cltbld', 10:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:31 INFO - 'XPC_FLAGS': '0x0', 10:38:31 INFO - 'XPC_SERVICE_NAME': '0', 10:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:32 INFO - Downloading/unpacking flake8 10:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:38:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:38:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:38:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:35 INFO - no previously-included directories found matching 'docs/_build' 10:38:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:38:36 INFO - Running setup.py install for pep8 10:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:36 INFO - no previously-included directories found matching 'docs/_build' 10:38:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:38:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:38:36 INFO - Cleaning up... 10:38:36 INFO - Return code: 0 10:38:36 INFO - Running post-action listener: _resource_record_post_action 10:38:36 INFO - Running post-action listener: _start_resource_monitoring 10:38:36 INFO - Starting resource monitoring. 10:38:36 INFO - ##### 10:38:36 INFO - ##### Running install step. 10:38:36 INFO - ##### 10:38:36 INFO - Running pre-action listener: _resource_record_pre_action 10:38:36 INFO - Running main action method: install 10:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:36 INFO - Reading from file tmpfile_stdout 10:38:36 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:36 INFO - Reading from file tmpfile_stdout 10:38:36 INFO - Output received: 10:38:36 INFO - Usage: mozinstall [options] installer 10:38:36 INFO - Options: 10:38:36 INFO - -h, --help show this help message and exit 10:38:36 INFO - -d DEST, --destination=DEST 10:38:36 INFO - Directory to install application into. [default: 10:38:36 INFO - "/builds/slave/test"] 10:38:36 INFO - --app=APP Application being installed. [default: firefox] 10:38:36 INFO - mkdir: /builds/slave/test/build/application 10:38:36 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'] 10:38:36 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 10:39:10 INFO - Reading from file tmpfile_stdout 10:39:10 INFO - Output received: 10:39:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:39:10 INFO - Running post-action listener: _resource_record_post_action 10:39:10 INFO - ##### 10:39:10 INFO - ##### Running run-tests step. 10:39:10 INFO - ##### 10:39:10 INFO - Running pre-action listener: _resource_record_pre_action 10:39:10 INFO - Running main action method: run_tests 10:39:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:39:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:39:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:39:10 INFO - 2016-04-20 10:39:10.291 screenresolution[1638:7655] starting screenresolution argv=screenresolution get 10:39:10 INFO - 2016-04-20 10:39:10.293 screenresolution[1638:7655] Display 0: 1600x1200x32@60 10:39:10 INFO - 2016-04-20 10:39:10.299 screenresolution[1639:7657] starting screenresolution argv=screenresolution list 10:39:10 INFO - Available Modes on Display 0 10:39:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:39:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:39:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:39:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:39:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:39:10 INFO - Intel Iris: 10:39:10 INFO - Chipset Model: Intel Iris 10:39:10 INFO - Type: GPU 10:39:10 INFO - Bus: Built-In 10:39:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:39:10 INFO - Vendor: Intel (0x8086) 10:39:10 INFO - Device ID: 0x0a2e 10:39:10 INFO - Revision ID: 0x0009 10:39:10 INFO - Displays: 10:39:10 INFO - Display: 10:39:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:39:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:39:10 INFO - Display Serial Number: 1600x1200 60 10:39:10 INFO - Main Display: Yes 10:39:10 INFO - Mirror: Off 10:39:10 INFO - Online: Yes 10:39:10 INFO - Rotation: Supported 10:39:10 INFO - Return code: 0 10:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:39:10 INFO - Python 2.7.3 10:39:10 INFO - Return code: 0 10:39:10 INFO - grabbing minidump binary from tooltool 10:39: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')]} 10:39:10 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 0x10b380e00>, '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 0x10b1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b37bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:39:10 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 10:39:10 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 10:39:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:39:10 INFO - Return code: 0 10:39:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:39:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:39:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:39:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:39:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:39:11 INFO - Return code: 0 10:39:11 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:39:11 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b40sY5MVDa/Render', 10:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:11 INFO - 'HOME': '/Users/cltbld', 10:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:11 INFO - 'LOGNAME': 'cltbld', 10:39:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:39:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:11 INFO - 'MOZ_NO_REMOTE': '1', 10:39:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:39:11 INFO - 'NO_EM_RESTART': '1', 10:39:11 INFO - 'PAGER': '/bin/cat', 10:39:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:11 INFO - 'PWD': '/builds/slave/test', 10:39:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:11 INFO - 'SHELL': '/bin/bash', 10:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4IYW4fbnYo/Listeners', 10:39:11 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 10:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:11 INFO - 'USER': 'cltbld', 10:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:11 INFO - 'XPC_FLAGS': '0x0', 10:39:11 INFO - 'XPC_SERVICE_NAME': '0', 10:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:39:12 INFO - mozversion application_buildid: 20160420094342 10:39:12 INFO - mozversion application_changeset: b29a652d68e85d25953a2bb371d35114cd8036a0 10:39:12 INFO - mozversion application_display_name: Nightly 10:39:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:39:12 INFO - mozversion application_name: Firefox 10:39:12 INFO - mozversion application_remotingname: firefox 10:39:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:39:12 INFO - mozversion application_vendor: Mozilla 10:39:12 INFO - mozversion application_version: 48.0a1 10:39:12 INFO - mozversion platform_buildid: 20160420094342 10:39:12 INFO - mozversion platform_changeset: b29a652d68e85d25953a2bb371d35114cd8036a0 10:39:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:39:12 INFO - mozversion platform_version: 48.0a1 10:39:12 INFO - using testdate: 1461173952 10:39:12 INFO - actual date: 1461173952 10:39:12 INFO - starting webserver on 'localhost:49275' 10:39:12 INFO - SUITE-START | Running 2 tests 10:39:12 INFO - TEST-START | dromaeo_css 10:39:12 INFO - operating with platform_type : mac_ 10:39:12 INFO - Initialising browser for dromaeo_css test... 10:39:12 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp_zdAxc/profile http://localhost:49275/getInfo.html) 10:39:14 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 10:39:14 INFO - PROCESS | 1657 | colorDepth:24 10:39:14 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 10:39:14 INFO - PROCESS | 1657 | __metrics 10:39:14 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:39:14 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:39:15 INFO - TEST-INFO | 1657: exit 0 10:39:15 INFO - Browser initialized. 10:39:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:39:15 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp_zdAxc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:27 INFO - PROCESS | 1659 | RSS: Main: 237744128 10:39:27 INFO - PROCESS | 1659 | 10:40:18 INFO - PROCESS | 1659 | 1461174018839 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] 10:42:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 10:42:31 INFO - PROCESS | 1659 | RSS: Main: 375197696 10:42:31 INFO - PROCESS | 1659 | 10:45:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 10:45:35 INFO - PROCESS | 1659 | RSS: Main: 382021632 10:45:35 INFO - PROCESS | 1659 | 10:48:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 10:48:37 INFO - PROCESS | 1659 | RSS: Main: 375746560 10:48:37 INFO - PROCESS | 1659 | 10:51:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 10:51:40 INFO - PROCESS | 1659 | RSS: Main: 372731904 10:51:40 INFO - PROCESS | 1659 | 10:54:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:54:44 INFO - PROCESS | 1659 | RSS: Main: 341889024 10:54:44 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:57:48 INFO - PROCESS | 1659 | RSS: Main: 382435328 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | __start_tp_report 10:57:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 10:57:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 10:57:48 INFO - PROCESS | 1659 | |i|pagename|runs| 10:57:48 INFO - PROCESS | 1659 | |0;dojo.html;2851.48673238817;3467.9479807802886;3487.5291835602193;3508.087897146741;3550.733694972876;5604.551635869131;5677.943220567793;5679.460451257124;5759.251297331346;5785.595008349417;5646.915296270559;5720.256366672337;5721.227634269372;5725.2843394575675;5737.770489180428;5151.0728068947665;5179.637425380225;5206.973965130188;5218.1650935850275;5276.12943864262;5258.342707161605;5264.552513036378;5274.129768588178;5274.841754747364;5290.867728306785;5223.529882310591;5250.816221432251;5268.736563171845;5286;5331.013762453939;5292.629515933886;5320.574354051705;5329.387120481156;5334.413214546396;5336.813211537577;5113.028524580318;5133.6919784813035;5223.843284701465;5224.268602395668;5247.344081989751;5622.128570071645;5656.745446454919;5668.234788303567;5682.977064128455;5787.247657804501;6135.263768347782;6155;6185.474234690012;6188.81433556994;6194.94685903393;6104.633721976696;6116.67056464255;6159.952808022647;6231.968840155816;6234.064890266451;5784.479396854219;5800.738966746507;5805.129230615442;5869.06095024794;5880.206172166745;6268.341824108494;6289.276733175652;6294.8111556653375;6296.905546416808;6297.086922396227;6066.575339726265;6116.908246376308;6145.631262124287;6148.555089553951;6153;6266;6293.244810622663;6302.212223472066;6308.432241098323;6311.242650881832;6209.689515524296;6254.655993920287;6278.30938596754;6286.9056964145575;6287.528435367366;6083.8479038023515;6131.223750760645;6156.415140561639;6287.402696743802;6345.650989195547;4821.349117869113;4850.927236091461;4867.34290870735;4868.513148685174;4868.756562171877;4409.823607055682;4449.888752781141;4458.554144585515;4473.261911784584;4524.6832721709825;5758.107493338539;5770.769169233267;5772.7113644317615;5796.797112101056;5814.215080964101;6195.907061393992;6266.905996410058;6291.245050593958;6291.276503202099;6302.023186406114;5571.721413929287;5646.040173170571;5659.745311460994;5725.828225153252;5758.165066065397;5142.100132476877;5324.068288049576;5369.731513424314;5391.353037635509;5395.298611180521;6211.006239001738;6271.216097987752;6273.592216505913;6279.843003924939;6280.995040793542;6215.96892015537;6289.874202515833;6323.36766323364;6332.30344662096;6339.112524246517;6334.651594162366;6340.809775706736;6357.650329231937;6361.268454127835;6373.203349581302;6095.710389288371;6175.505959523317;6255.249370075438;6256.280527739368;6281.403266689657;6233.96883015582;6257.374262573706;6262.780802671885;6292.3078461368295;6292.811215663537;6137.96931015342;6138.662373569318;6146.477549408351;6171.876562468815;6176.382361763787;5581.302337207849;5994.520438365008;6110.236220472441;6134.969325153345;6143.416375444325;5954.732037058429;5962.70186490665;5963.582549221686;5977.820665380045;6022.066579680157;6124.239704855953;6127.479164271087;6141;6156.353582873734;6160.045192995093;5888.3228428731245;5970.134330522137;5990.101484777319;6016.849578760566;6018.849528761816 10:57:48 INFO - PROCESS | 1659 | |1;ext.html;509.9745012749363;518.5747686896747;529.4811085136565;531.7394476706413;635.5138319185824;28935.276618084557;29450.705492945064;37945.43081853771;38812.02969925753;38850;40446.79776601113;41580.58419415805;41621.791891040506;41668.79165604175;41766;7469.514481558695;9688.418694878295;9696.515174241295;9711.320207585472;9724.562394692255;8434.198751118665;8706.564671766386;8710.041895391501;8714.433561818492;8717.084706105863;8879.378443508956;11639.767204655902;11656.708582285426;11671.941640291829;11753.4710938008;11360.545578176863;11582.942085289604;11599.304041757521;11604.129690273263;11609.129315301345;8415.537145456998;11162.553497860075;11416.257943233746;11547.826782598268;11555.2489088209;37740.62259377399;38379.424308635396;38430.65492707742;38492;38753.80623096895;3148.66938971407;3296.868125274986;3320.8173550454717;3361.193313604742;3781.8487260509546;27961.300967475774;28676.569851452245;30004.099877003726;30024.54963175554;30151.09546713602;2684.355754618877;2767.363506393541;2770.3766652503227;2792.4833905727505;2817.323842277859;362557;423129;423330;427703.8614806968;428480.99999999686;60868.47828804315;61195.38804611986;61660;61682.38317616766;61854.69072654698;65683.68632627321;65950.67024664846;65969.34030659728;66102;66107;16402.67194656124;17039;17055.526948592385;17068.57328566771;17103.059331736873;13046.739065218642;13123.409446574928;13124.343782810822;13144.60566183016;13150.60548183556;13427.798583021262;17231;18919.621607568046;18963;19273.807261927202;7473.252674732484;7675.30922216992;7676.616169191518;7682;7763.301302882767;969.2197780786394;971.84450487923;980.8773903262093;1026.0919086608405;1082.2856914436434;28985.275368115967;29129.70870291312;29640;29707.12955256984;29954.55068173979;1065.195777188218;1097.4293367448881;1156.7455159864817;1156.7686462707493;1194.6296648039136;15155.924220378827;15187.936844420785;15357.308921098578;15440.845591544165;15500.68998620044;628712;634092;639170;639184;640104;59842;60477.39522604806;60521;60573;60787.08819367713;1292.9482820687256;1346.6902612399203;1422.679897023203;1474.1302631447497;1488.3525666335179;28566.57150142708;28645.713542864305;28965.565516516846;29149.125526234246;29224;47199.52800471951;48621;49293;49363.753181233864;49551.50448495469;419795;422154;423644;424110;424656;23350.416239594146;25938.22185334443;26592.734072659026;26597.33506662349;26932.326691832863;42528;42535;43000;43559.56440435682;44052.77973610111;28203.71796282011;36150.63849361473;37176.44235336526;38023.429648555844;38059;36528;36631.63368366389;37128.25743485061;37207.566324778796;37652.623473764914;35551.82224088863;36377.09057273589;36618.8169059153;36965;37333.066673333386;31885.36229275355;32471.837640811646;32584.18539536436;32614.83692581522;33400.33199335951;23699;23737.287881363587;23825;24508.754912450648;24614.50770984606 10:57:48 INFO - PROCESS | 1659 | |2;jquery.html;397.71762048945254;399.95000624921886;401.23764846791073;405.33120351420155;411.19405964309954;18838.90580547099;18843.246270149193;19874.403767886968;19894;19935.800641993577;15470.381184752596;18332.908335458338;18714.344997925076;18721.034291399377;19071.618567628673;5368.114261146926;5496.917546236799;5702.315722113352;5714.371419143911;5715.2855893013375;5662.433756624325;5703.488575527488;5719.370869204384;5721.742521586518;5722.313322401297;5617.466340697648;5705.030144875361;5716.228309178249;5720.8283751487315;5728.484436400723;5685.687287199203;5839.386864379243;5882.499987501067;5894.852628684296;5915.645061296336;5481.561475082024;5618.775248990036;5634.408387119334;5645.463680950304;5650.208970744099;23288.417789555228;23314.06743730249;24836.627450588254;25215.117470888432;25215.873920630278;1928.3443629166152;2140.1011575138477;2173.923912663049;2762.033689868755;2771.2240572639494;9457.1015753504;9520.523973801282;9854.014598540089;9924.553395097239;9955.25335599833;1552.5342397280883;1576.448243114912;1642.852143307108;1667.2580701587676;1807.2228941555127;90813;112169.43915280452;112331;112387.87612123856;114376;9174.67888623895;11477.885221147682;11514.36670983104;11523.654290371302;11653.88346116528;12006.579769708018;14716.779248311284;14781.408743650349;14785.926070369795;14791.556253312418;8151.18488151192;8359.791005224797;8373.706920257762;8455.619497122645;8456.66173353059;8154.959225203836;8184.6316915738935;8188.2630563249595;8265.338772898154;8317.916820831715;4428.734275943454;4483;4535.818567257273;4553.3397657340165;4602.953970460252;1587.563420059493;1797.5162302848332;1859.958423282966;1896.5448292409721;1950.4831219726784;781.878808784628;802.3781569283851;951.7858481841669;961.7643677298967;972.0376826941277;19769.50576235577;20603.085413771336;20635.277765278144;20662.966851657657;20669.58660826775;760.4942713095729;874.339873395595;942.1520631431766;956.2015716876487;1033.7002269341956;10262.384256944608;10719.98160174782;10721.088707459798;10733.624323148651;10749.83875241872;555923;573943;581993;589768;596877;132986;134337;134669;138822;141864;998.7353351361895;1041.6874937518714;1058.2433560004633;1059.613241166984;1061.0821639281965;17488.562785930455;17775.555611109827;17798.377056803467;17948.74358794924;18145.183466744293;51592.48407515877;52530.73734631302;53268;53719;54149;71255.64372178106;73840;78762.6061869687;78964;79885.60057199677;6958.965205173941;7907.84184316299;8051.39614528901;8145.959270203611;8150.225728555778;10994.28537145083;12158.696032599255;12291.078169137172;12517.812232816697;12599.118061735591;10694.572217111228;10806.35161890289;10850.728731781453;10871.402072886067;10956.013958743752;10514.894851051391;10587.629432970118;10605.734856628646;10789.62236321725;10824.5128969195;10728.678139655824;10964.177686673373;11182.440877955907;11251.043661288555;11272.718182045515;7850.293473587404;7886.05367355898;7952.562609056557;7991.320737737125;8085.353171746364;8282.958585207036;10524.684259472227;10920.945395272973;11114.277571957797;11336.319820810777 10:57:48 INFO - PROCESS | 1659 | |3;mootools.html;1438.4030627289676;1626.9593260168494;1641.934322627095;1909.436716168731;2018.9899050504746;7955.880661790078;8605.225529702333;8790.692325768583;8808.515531645757;8823;8395.538245396516;8639.65441382344;8643.740687779376;8657.177568131034;8671.869921951176;2161.427221786228;2371.5731168389684;2397.328747950572;2454.631805229212;2466.0998735461517;2447.7185123710824;2477.7398373170827;2480.355107672;2487.092211342865;2488.415222422729;2395.161693407302;2397.6403539469134;2398.436367453647;2399.400149962509;2399.5440866235444;2120.8303335733103;2347.272345572878;2367.490989437271;2412.264259400882;2421.6125419932728;2433.2856802477813;2443.6701045359005;2463.4826686395877;2464.741202173782;2469.715982661999;8663.956680216621;8818.29453643707;8830.161134692195;8836.923323019086;8841.469511829246;4826.396700412449;5237.3453318335205;5415.187721841716;5423.078076726966;5441.83674489766;3552.609212986595;3562.87529936451;3581.7492775505725;3649.033006253345;3674.5590529136407;1026.3687831983277;1033.3076838518211;1043.5095505112586;1047.774728433383;1051.432226597644;9389.953050234773;11820.822687659605;11851.229670071503;11853.9331460169;11870.940645296718;4674.182018146878;4819.638527110411;4843.54693591921;4907.779149938261;4976.377952755905;9900.752481188028;9917.65288214909;9927.354721943051;9930.950345248228;9948.602055917681;5388.218708287276;5393.191021346829;5397.325334333208;5405.21624364465;5432.429594892558;4399.252127138394;4552.112338094106;4561.703489273186;4565.840195593139;4916.434610019822;3610.476480910306;3901.8634347797692;3964.1873415949663;4027.1140349123148;4073.4948006975496;1324.6555895467247;1336.8395792504962;1347.487954577274;1351.966200844967;1368.2406264523086;769.2154002916993;838.7064527415356;900.2527901841456;920.7928216151313;928.79256965944;5410.458954104637;5483.314585676791;5621.578381621394;5656.490915817596;5790.218320526675;928.7554676733075;950.2635457520477;991.3853410885154;1011.0092109732503;1068.823644098715;3728.366177749735;3750.493683352767;3764.7176461765475;3825.215830754689;3836.712246581462;10269.127124194527;10700.464976751131;10713.410762408143;10723.83914241287;10738.94630526858;10048.849267260997;10622.309549879234;10684.786304273872;10688;10693.19801014927;8046.678132874619;8081.797955051054;8152.6331315090965;8226.835463290701;8235.8352832943;4328.177646247203;5520.365158006881;5633.155026746021;5781;5927.614705044159;9635.807283854423;9783.755406114904;9861.408315501092;9987.500624968869;10062.993700629879;10071.546780394754;10305;10321.329113607591;10371.429571373646;10485.895141048491;6468.417842394207;7635.503692259986;7656.425768067305;7660.655270512729;7673.040869891263;7909.209079092045;8138.796530086795;8291.419600627898;8305.543195124084;8313.043999940084;7230.276972302728;7241.384482319062;7322.816929576803;7367;7386.741464048732;5895.469407753323;6959.234484206632;7047.154341479055;7113.3953613943395;7278.563286202845;6892;6917.342852429011;6928.896066559107;6945;6967.407770339578;4603.7556170580165;4750.952490475189;4805.255185446262;4825.734584597881;4938.08645400602;4177.937330939978;4784.497627749036;4797.496262892486;4862.7325497098;4948.134076536519 10:57:48 INFO - PROCESS | 1659 | |4;prototype.html;315.7757991825802;320.9037288813356;329.755980574375;333.4814363664502;334.92296771742485;5196.688198708081;5907;5993.160957465952;6008.759649614021;6063.99944009238;4879.24347234996;4919.827806026789;5608.214849921004;5922.378150294222;5971.940280597204;3915.6280153385383;4466.642668586522;4470.00509658528;4492.640588752892;4505.8422955196575;4495.213337665912;4514.458265008204;4524.3213517972235;4543.5456454354635;4546.977265113686;3442.7762195457217;4181.498220213563;4296.334068219431;4501.279795232764;4531.207038768219;4451.821927122911;4470.552944705536;4470.642348612103;4493;4498.370228168059;3880.4373365861793;3880.9223815523815;3883.145707944276;3884.5915532369827;3893.240818040483;3865.342891708416;5430.809921652763;5569.805056823032;5789.884202315972;5836.445537673914;4260.978695106504;5106.5659418949435;5127.461616530285;5130.563902068291;5163.483651634844;6350.968245158745;6360.459360954278;6386.233651961795;6408.423241908251;6428.935710642881;4064.9837540614844;4227.070044590185;4246.532881383046;4265.38151967966;4268.0183557781575;6535.575187612838;6682.966585167092;6689.76585819494;6690.59856408617;6756.358145976124;4086.8978275542754;4109.198706252312;4256.70203085781;4257.574242575718;4289.592488713567;4064.065264989069;4122.711410201317;4146.896327591774;4314.374415709704;4365.628921541641;4620.3762492063815;5100.744962751847;5125.923111153335;5131.435542090367;5133.4096578893905;5624.29696287964;5899.764009439575;6111.502681842977;6427.839304017437;6437.935620643733;1225.724212052281;1236.567201479475;1407.7184563087424;1487.8512148785035;1507.9698406031819;853.0658928473312;912.0605776050678;937.639008981547;938.1134827587864;957.9233661307079;5837.883242335214;5841.591088623841;5884.382139875337;5899.439553242435;5958.761649534057;6426.967865160645;6530.771423000172;6560.245571759308;6577.079208910756;6656.2345330287635;5856.531477481792;5861.824145275648;5869.593466678642;5878.294604647384;5878.29460464747;2712.8877160364154;3448;3468.4450487921813;3474.756767026284;3476.66971637694;5339.973300133553;6043.7884674036195;6303.810885673437;6799.1840979081835;6853.348931851466;5863.794767183128;6676.899846502306;6687.598744075371;6710.731570737214;6717.6977036033495;6024.27708674953;6532.738690452424;6955.791326260221;6974.930250697428;6988.357735932052;6339.809805705836;6544.821932052277;6629.900551491635;6664.733410663519;6675.23234828001;6389.424951754364;6393.6483493408305;6437.002264648987;6592.8351791205605;6640.767573134917;5560.7219639018695;6879.380855723009;6887.173539175131;6911.479474515599;6939.340762627542;4141.399497072968;4170.270202714452;4173.770442625685;4257.744535327766;4296.720713153635;6620;6645.082638847121;6670.164131004983;6674.132362792806;6682.3317668232785;6408.166938298178;6408.30180002309;6415.871682566416;6423.888711224727;6425.361532809104;5257.211418287287;5288.3918349390315;5311.893762124813;6157.875532941128;6417.679116044085;5716.9142462862255;5837.270341207349;5998.550108741949;6061.605995610271;6275.937240627535;5589.813806130629;5693.914591281217;5815.680137592473;6395.904061438989;6495.480361570969;5349.399516415957;5625.521830644441;6303.747850085945;6306.527010474325;6329.810105696836 10:57:48 INFO - PROCESS | 1659 | |5;yui.html;680.9557378770379;709.879320515512;732.567785006846;740.8851627997662;760.562676461035;14103;14507.202103884281;14507.49223777168;14509.347079381414;14510.201938893357;13565.796513052288;13643.522476713317;13659.931700341509;13679.863201367983;13726.176429414218;717.501336571082;744.5123444144094;893.2273583350387;930.4045410937006;930.9069093090704;913.8583519554479;924.3298608508844;925.4909799610222;925.7454200094994;926.7961048569338;963.4604621411996;977.5600979559191;979.294907666479;980.0248752491245;981.5386768218925;679.0052572980558;752.3153929923743;767.7121079595152;966.2849491376367;969.6993931881104;579.1457600039907;696.1924167965187;721;721.3219573600851;723.7937187901475;14708.411663533447;14788.18664973426;14796.18620975846;14821.555353339418;14830.629234269121;12131.332776697278;12150.513979440811;12346.074044446703;12452.501899923993;12713.491460341575;9561.856572151424;9860.112589866947;9984.500774961296;10263.538140783683;10466.529006194663;3450.6721861423125;3455;3484.5992710838073;3549.8757543486113;3553.200529880756;77871.61064194699;78665.60667196685;79902.40195196122;80012;80567;9340.532973351304;9370.531473426301;9462.668806591737;9522.238220942309;10008.549615267331;20918.372448826558;21121.9439028048;21163;21175.470613234793;21179.78820211809;7409.777706668809;7459.403247740168;7503.512271702322;7511.51175173612;7641.617919104023;4045.8381664733083;4110.650594699484;4140.296149654566;4141.8964525887095;4143.461350024478;2855.971440285612;3538.6992105670793;3551.6448355164794;3555.8755443559867;3560;664.8371149068413;674.3829396102609;676.100785954679;677.3260605697265;679.0628932073706;582.72320647692;585.1427658480346;594.8304733151118;600.9338972712998;604.8669292755586;7430.182679905206;7483.775486735407;7510.624468776539;7632.694692212361;7983.481073730189;483.9758012099381;526.457748519026;544.7221916822449;562.5471495446124;564.4271064869162;3045.573619693245;3611.620779818134;3671.2657468506404;3683.3922402803237;3869.9806500967316;61557.07664385038;78787;82045;82569.17430825735;83620;71539;72465.91301130487;72591;73414;74326;59366.70316648475;65702.67148664226;66228.66885665637;66289.99999999904;67017;5874.676892770939;7309.305615966475;7318.780436586911;7354.816129596803;7480.3641690456925;38104.618953811216;39742.00644983783;41983.790081049396;42193.578064218964;42581.78709106435;53782.46217537775;53787;54611.726941365036;55966;61203.69398152981;10752.462376881282;10813.080888124598;10898.128149747843;11104.666859994213;11331.263467874562;11751.647450576154;11775.17573769862;11873.584424545099;11886.702832429259;12406.317652529198;11179.888201117885;11245.269057511563;11388.37363944991;11500.48247828833;11754.941225293818;11125.833112503156;11402;11435.771284574095;11608.535658573563;11718;10971.670849874517;11136.610218642309;11242.269252498561;11382.94308528452;11625.763968101119;9340.299477539347;9488.33581649278;9512.23902087845;9543.52282385864;9849.556769945226;9027.819443611223;9349.111834375723;9529.666461673809;9911.157551608194;10013.649522266685 10:57:48 INFO - PROCESS | 1659 | __end_tp_report 10:57:48 INFO - PROCESS | 1659 | __start_cc_report 10:57:48 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1127 10:57:48 INFO - PROCESS | 1659 | __end_cc_report 10:57:48 INFO - PROCESS | 1659 | __startTimestamp1461175068326__endTimestamp 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | ------- Summary: start ------- 10:57:48 INFO - PROCESS | 1659 | Number of tests: 6 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5760.08 Median:5990.10 stddev:640.15 (10.7%) stddev-sans-first:600.08 10:57:48 INFO - PROCESS | 1659 | Values: 2851.5 3467.9 3487.5 3508.1 3550.7 5604.6 5677.9 5679.5 5759.3 5785.6 5646.9 5720.3 5721.2 5725.3 5737.8 5151.1 5179.6 5207.0 5218.2 5276.1 5258.3 5264.6 5274.1 5274.8 5290.9 5223.5 5250.8 5268.7 5286.0 5331.0 5292.6 5320.6 5329.4 5334.4 5336.8 5113.0 5133.7 5223.8 5224.3 5247.3 5622.1 5656.7 5668.2 5683.0 5787.2 6135.3 6155.0 6185.5 6188.8 6194.9 6104.6 6116.7 6160.0 6232.0 6234.1 5784.5 5800.7 5805.1 5869.1 5880.2 6268.3 6289.3 6294.8 6296.9 6297.1 6066.6 6116.9 6145.6 6148.6 6153.0 6266.0 6293.2 6302.2 6308.4 6311.2 6209.7 6254.7 6278.3 6286.9 6287.5 6083.8 6131.2 6156.4 6287.4 6345.7 4821.3 4850.9 4867.3 4868.5 4868.8 4409.8 4449.9 4458.6 4473.3 4524.7 5758.1 5770.8 5772.7 5796.8 5814.2 6195.9 6266.9 6291.2 6291.3 6302.0 5571.7 5646.0 5659.7 5725.8 5758.2 5142.1 5324.1 5369.7 5391.4 5395.3 6211.0 6271.2 6273.6 6279.8 6281.0 6216.0 6289.9 6323.4 6332.3 6339.1 6334.7 6340.8 6357.7 6361.3 6373.2 6095.7 6175.5 6255.2 6256.3 6281.4 6234.0 6257.4 6262.8 6292.3 6292.8 6138.0 6138.7 6146.5 6171.9 6176.4 5581.3 5994.5 6110.2 6135.0 6143.4 5954.7 5962.7 5963.6 5977.8 6022.1 6124.2 6127.5 6141.0 6156.4 6160.0 5888.3 5970.1 5990.1 6016.8 6018.8 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:63283.47 Median:36452.55 stddev:133879.49 (367.3%) stddev-sans-first:134172.10 10:57:48 INFO - PROCESS | 1659 | Values: 510.0 518.6 529.5 531.7 635.5 28935.3 29450.7 37945.4 38812.0 38850.0 40446.8 41580.6 41621.8 41668.8 41766.0 7469.5 9688.4 9696.5 9711.3 9724.6 8434.2 8706.6 8710.0 8714.4 8717.1 8879.4 11639.8 11656.7 11671.9 11753.5 11360.5 11582.9 11599.3 11604.1 11609.1 8415.5 11162.6 11416.3 11547.8 11555.2 37740.6 38379.4 38430.7 38492.0 38753.8 3148.7 3296.9 3320.8 3361.2 3781.8 27961.3 28676.6 30004.1 30024.5 30151.1 2684.4 2767.4 2770.4 2792.5 2817.3 362557.0 423129.0 423330.0 427703.9 428481.0 60868.5 61195.4 61660.0 61682.4 61854.7 65683.7 65950.7 65969.3 66102.0 66107.0 16402.7 17039.0 17055.5 17068.6 17103.1 13046.7 13123.4 13124.3 13144.6 13150.6 13427.8 17231.0 18919.6 18963.0 19273.8 7473.3 7675.3 7676.6 7682.0 7763.3 969.2 971.8 980.9 1026.1 1082.3 28985.3 29129.7 29640.0 29707.1 29954.6 1065.2 1097.4 1156.7 1156.8 1194.6 15155.9 15187.9 15357.3 15440.8 15500.7 628712.0 634092.0 639170.0 639184.0 640104.0 59842.0 60477.4 60521.0 60573.0 60787.1 1292.9 1346.7 1422.7 1474.1 1488.4 28566.6 28645.7 28965.6 29149.1 29224.0 47199.5 48621.0 49293.0 49363.8 49551.5 419795.0 422154.0 423644.0 424110.0 424656.0 23350.4 25938.2 26592.7 26597.3 26932.3 42528.0 42535.0 43000.0 43559.6 44052.8 28203.7 36150.6 37176.4 38023.4 38059.0 36528.0 36631.6 37128.3 37207.6 37652.6 35551.8 36377.1 36618.8 36965.0 37333.1 31885.4 32471.8 32584.2 32614.8 33400.3 23699.0 23737.3 23825.0 24508.8 24614.5 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34157.76 Median:2766.63 stddev:97032.13 (3507.2%) stddev-sans-first:97271.22 10:57:48 INFO - PROCESS | 1659 | Values: 397.7 400.0 401.2 405.3 411.2 18838.9 18843.2 19874.4 19894.0 19935.8 15470.4 18332.9 18714.3 18721.0 19071.6 5368.1 5496.9 5702.3 5714.4 5715.3 5662.4 5703.5 5719.4 5721.7 5722.3 5617.5 5705.0 5716.2 5720.8 5728.5 5685.7 5839.4 5882.5 5894.9 5915.6 5481.6 5618.8 5634.4 5645.5 5650.2 23288.4 23314.1 24836.6 25215.1 25215.9 1928.3 2140.1 2173.9 2762.0 2771.2 9457.1 9520.5 9854.0 9924.6 9955.3 1552.5 1576.4 1642.9 1667.3 1807.2 90813.0 112169.4 112331.0 112387.9 114376.0 9174.7 11477.9 11514.4 11523.7 11653.9 12006.6 14716.8 14781.4 14785.9 14791.6 8151.2 8359.8 8373.7 8455.6 8456.7 8155.0 8184.6 8188.3 8265.3 8317.9 4428.7 4483.0 4535.8 4553.3 4603.0 1587.6 1797.5 1860.0 1896.5 1950.5 781.9 802.4 951.8 961.8 972.0 19769.5 20603.1 20635.3 20663.0 20669.6 760.5 874.3 942.2 956.2 1033.7 10262.4 10720.0 10721.1 10733.6 10749.8 555923.0 573943.0 581993.0 589768.0 596877.0 132986.0 134337.0 134669.0 138822.0 141864.0 998.7 1041.7 1058.2 1059.6 1061.1 17488.6 17775.6 17798.4 17948.7 18145.2 51592.5 52530.7 53268.0 53719.0 54149.0 71255.6 73840.0 78762.6 78964.0 79885.6 6959.0 7907.8 8051.4 8146.0 8150.2 10994.3 12158.7 12291.1 12517.8 12599.1 10694.6 10806.4 10850.7 10871.4 10956.0 10514.9 10587.6 10605.7 10789.6 10824.5 10728.7 10964.2 11182.4 11251.0 11272.7 7850.3 7886.1 7952.6 7991.3 8085.4 8283.0 10524.7 10920.9 11114.3 11336.3 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5651.23 Median:4826.07 stddev:3158.41 (65.4%) stddev-sans-first:3151.40 10:57:48 INFO - PROCESS | 1659 | Values: 1438.4 1627.0 1641.9 1909.4 2019.0 7955.9 8605.2 8790.7 8808.5 8823.0 8395.5 8639.7 8643.7 8657.2 8671.9 2161.4 2371.6 2397.3 2454.6 2466.1 2447.7 2477.7 2480.4 2487.1 2488.4 2395.2 2397.6 2398.4 2399.4 2399.5 2120.8 2347.3 2367.5 2412.3 2421.6 2433.3 2443.7 2463.5 2464.7 2469.7 8664.0 8818.3 8830.2 8836.9 8841.5 4826.4 5237.3 5415.2 5423.1 5441.8 3552.6 3562.9 3581.7 3649.0 3674.6 1026.4 1033.3 1043.5 1047.8 1051.4 9390.0 11820.8 11851.2 11853.9 11870.9 4674.2 4819.6 4843.5 4907.8 4976.4 9900.8 9917.7 9927.4 9931.0 9948.6 5388.2 5393.2 5397.3 5405.2 5432.4 4399.3 4552.1 4561.7 4565.8 4916.4 3610.5 3901.9 3964.2 4027.1 4073.5 1324.7 1336.8 1347.5 1352.0 1368.2 769.2 838.7 900.3 920.8 928.8 5410.5 5483.3 5621.6 5656.5 5790.2 928.8 950.3 991.4 1011.0 1068.8 3728.4 3750.5 3764.7 3825.2 3836.7 10269.1 10700.5 10713.4 10723.8 10738.9 10048.8 10622.3 10684.8 10688.0 10693.2 8046.7 8081.8 8152.6 8226.8 8235.8 4328.2 5520.4 5633.2 5781.0 5927.6 9635.8 9783.8 9861.4 9987.5 10063.0 10071.5 10305.0 10321.3 10371.4 10485.9 6468.4 7635.5 7656.4 7660.7 7673.0 7909.2 8138.8 8291.4 8305.5 8313.0 7230.3 7241.4 7322.8 7367.0 7386.7 5895.5 6959.2 7047.2 7113.4 7278.6 6892.0 6917.3 6928.9 6945.0 6967.4 4603.8 4751.0 4805.3 4825.7 4938.1 4177.9 4784.5 4797.5 4862.7 4948.1 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5115.42 Median:5836.86 stddev:1633.05 (28.0%) stddev-sans-first:1597.40 10:57:48 INFO - PROCESS | 1659 | Values: 315.8 320.9 329.8 333.5 334.9 5196.7 5907.0 5993.2 6008.8 6064.0 4879.2 4919.8 5608.2 5922.4 5971.9 3915.6 4466.6 4470.0 4492.6 4505.8 4495.2 4514.5 4524.3 4543.5 4547.0 3442.8 4181.5 4296.3 4501.3 4531.2 4451.8 4470.6 4470.6 4493.0 4498.4 3880.4 3880.9 3883.1 3884.6 3893.2 3865.3 5430.8 5569.8 5789.9 5836.4 4261.0 5106.6 5127.5 5130.6 5163.5 6351.0 6360.5 6386.2 6408.4 6428.9 4065.0 4227.1 4246.5 4265.4 4268.0 6535.6 6683.0 6689.8 6690.6 6756.4 4086.9 4109.2 4256.7 4257.6 4289.6 4064.1 4122.7 4146.9 4314.4 4365.6 4620.4 5100.7 5125.9 5131.4 5133.4 5624.3 5899.8 6111.5 6427.8 6437.9 1225.7 1236.6 1407.7 1487.9 1508.0 853.1 912.1 937.6 938.1 957.9 5837.9 5841.6 5884.4 5899.4 5958.8 6427.0 6530.8 6560.2 6577.1 6656.2 5856.5 5861.8 5869.6 5878.3 5878.3 2712.9 3448.0 3468.4 3474.8 3476.7 5340.0 6043.8 6303.8 6799.2 6853.3 5863.8 6676.9 6687.6 6710.7 6717.7 6024.3 6532.7 6955.8 6974.9 6988.4 6339.8 6544.8 6629.9 6664.7 6675.2 6389.4 6393.6 6437.0 6592.8 6640.8 5560.7 6879.4 6887.2 6911.5 6939.3 4141.4 4170.3 4173.8 4257.7 4296.7 6620.0 6645.1 6670.2 6674.1 6682.3 6408.2 6408.3 6415.9 6423.9 6425.4 5257.2 5288.4 5311.9 6157.9 6417.7 5716.9 5837.3 5998.6 6061.6 6275.9 5589.8 5693.9 5815.7 6395.9 6495.5 5349.4 5625.5 6303.7 6306.5 6329.8 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:16871.03 Median:3229.91 stddev:23018.50 (712.7%) stddev-sans-first:23050.97 10:57:48 INFO - PROCESS | 1659 | Values: 681.0 709.9 732.6 740.9 760.6 14103.0 14507.2 14507.5 14509.3 14510.2 13565.8 13643.5 13659.9 13679.9 13726.2 717.5 744.5 893.2 930.4 930.9 913.9 924.3 925.5 925.7 926.8 963.5 977.6 979.3 980.0 981.5 679.0 752.3 767.7 966.3 969.7 579.1 696.2 721.0 721.3 723.8 14708.4 14788.2 14796.2 14821.6 14830.6 12131.3 12150.5 12346.1 12452.5 12713.5 9561.9 9860.1 9984.5 10263.5 10466.5 3450.7 3455.0 3484.6 3549.9 3553.2 77871.6 78665.6 79902.4 80012.0 80567.0 9340.5 9370.5 9462.7 9522.2 10008.5 20918.4 21121.9 21163.0 21175.5 21179.8 7409.8 7459.4 7503.5 7511.5 7641.6 4045.8 4110.7 4140.3 4141.9 4143.5 2856.0 3538.7 3551.6 3555.9 3560.0 664.8 674.4 676.1 677.3 679.1 582.7 585.1 594.8 600.9 604.9 7430.2 7483.8 7510.6 7632.7 7983.5 484.0 526.5 544.7 562.5 564.4 3045.6 3611.6 3671.3 3683.4 3870.0 61557.1 78787.0 82045.0 82569.2 83620.0 71539.0 72465.9 72591.0 73414.0 74326.0 59366.7 65702.7 66228.7 66290.0 67017.0 5874.7 7309.3 7318.8 7354.8 7480.4 38104.6 39742.0 41983.8 42193.6 42581.8 53782.5 53787.0 54611.7 55966.0 61203.7 10752.5 10813.1 10898.1 11104.7 11331.3 11751.6 11775.2 11873.6 11886.7 12406.3 11179.9 11245.3 11388.4 11500.5 11754.9 11125.8 11402.0 11435.8 11608.5 11718.0 10971.7 11136.6 11242.3 11382.9 11625.8 9340.3 9488.3 9512.2 9543.5 9849.6 9027.8 9349.1 9529.7 9911.2 10013.6 10:57:48 INFO - PROCESS | 1659 | -------- Summary: end -------- 10:57:48 INFO - PROCESS | 1659 | 10:57:48 INFO - TEST-INFO | 1659: exit 0 10:57:48 INFO - TEST-OK | dromaeo_css | took 1116816ms 10:57:48 INFO - TEST-START | kraken 10:57:48 INFO - operating with platform_type : mac_ 10:57:48 INFO - Initialising browser for kraken test... 10:57:48 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp4xXJ9T/profile http://localhost:49275/getInfo.html) 10:57:51 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 10:57:51 INFO - PROCESS | 1669 | colorDepth:24 10:57:51 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 10:57:51 INFO - PROCESS | 1669 | __metrics 10:57:51 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:57:51 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:57:51 INFO - TEST-INFO | 1669: exit 0 10:57:51 INFO - Browser initialized. 10:57:51 INFO - Running cycle 1/1 for kraken test... 10:57:52 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp4xXJ9T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:03 INFO - PROCESS | 1671 | RSS: Main: 237932544 10:58:03 INFO - PROCESS | 1671 | 10:58:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 10:58:07 INFO - PROCESS | 1671 | RSS: Main: 285769728 10:58:07 INFO - PROCESS | 1671 | 10:58:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 10:58:10 INFO - PROCESS | 1671 | RSS: Main: 298901504 10:58:10 INFO - PROCESS | 1671 | 10:58:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 10:58:14 INFO - PROCESS | 1671 | RSS: Main: 384176128 10:58:14 INFO - PROCESS | 1671 | 10:58:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 10:58:17 INFO - PROCESS | 1671 | RSS: Main: 286605312 10:58:17 INFO - PROCESS | 1671 | 10:58:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:58:20 INFO - PROCESS | 1671 | RSS: Main: 291823616 10:58:20 INFO - PROCESS | 1671 | 10:58:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 10:58:23 INFO - PROCESS | 1671 | RSS: Main: 330072064 10:58:23 INFO - PROCESS | 1671 | 10:58:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 10:58:27 INFO - PROCESS | 1671 | RSS: Main: 330760192 10:58:27 INFO - PROCESS | 1671 | 10:58:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 10:58:30 INFO - PROCESS | 1671 | RSS: Main: 327544832 10:58:30 INFO - PROCESS | 1671 | 10:58:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:58:33 INFO - PROCESS | 1671 | RSS: Main: 319959040 10:58:33 INFO - PROCESS | 1671 | 10:58:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:35 INFO - PROCESS | 1671 | RSS: Main: 326213632 10:58:35 INFO - PROCESS | 1671 | 10:58:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:38 INFO - PROCESS | 1671 | RSS: Main: 330129408 10:58:38 INFO - PROCESS | 1671 | 10:58:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:58:41 INFO - PROCESS | 1671 | RSS: Main: 334577664 10:58:41 INFO - PROCESS | 1671 | 10:58:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:58:45 INFO - PROCESS | 1671 | RSS: Main: 331988992 10:58:45 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 10:58:47 INFO - PROCESS | 1671 | RSS: Main: 396001280 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | __start_tp_report 10:58:47 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 10:58:47 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 10:58:47 INFO - PROCESS | 1671 | |i|pagename|runs| 10:58:47 INFO - PROCESS | 1671 | |0;ai-astar;112;114;164;160;113;113;118;110;113;113 10:58:47 INFO - PROCESS | 1671 | |1;audio-beat-detection;156;122;145;167;120;142;140;120;174;144 10:58:47 INFO - PROCESS | 1671 | |2;audio-dft;185;188;186;185;187;180;182;184;184;184 10:58:47 INFO - PROCESS | 1671 | |3;audio-fft;70;75;84;89;55;60;64;101;115;80 10:58:47 INFO - PROCESS | 1671 | |4;audio-oscillator;91;95;130;77;79;81;123;79;78;123 10:58:47 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;86;84;87;83;86;83;87;84;86;84 10:58:47 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;93;93;104;146;95;94;101;148;129 10:58:47 INFO - PROCESS | 1671 | |7;imaging-desaturate;89;86;85;84;86;84;84;91;105;104 10:58:47 INFO - PROCESS | 1671 | |8;json-parse-financial;58;60;59;77;88;88;86;79;60;58 10:58:47 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;64;63;75;74;71;67;66;67;67;67 10:58:47 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;82;82;81;81;80;82;81;85;97;105 10:58:47 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;139;138;139;137;138;135;138;138;170;163 10:58:47 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;170;165;170;167;146;181;215;170;169;174 10:58:47 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;68;69;68;68;67;67;71;68;68 10:58:47 INFO - PROCESS | 1671 | __end_tp_report 10:58:47 INFO - PROCESS | 1671 | __start_cc_report 10:58:47 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1965 10:58:47 INFO - PROCESS | 1671 | __end_cc_report 10:58:47 INFO - PROCESS | 1671 | __startTimestamp1461175127405__endTimestamp 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | ------- Summary: start ------- 10:58:47 INFO - PROCESS | 1671 | Number of tests: 14 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:123.00 Median:113.50 stddev:20.67 (18.2%) stddev-sans-first:21.54 10:58:47 INFO - PROCESS | 1671 | Values: 112.0 114.0 164.0 160.0 113.0 113.0 118.0 110.0 113.0 113.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:144.50 stddev:18.92 (13.1%) stddev-sans-first:19.47 10:58:47 INFO - PROCESS | 1671 | Values: 156.0 122.0 145.0 167.0 120.0 142.0 140.0 120.0 174.0 144.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:2.32 (1.3%) stddev-sans-first:2.46 10:58:47 INFO - PROCESS | 1671 | Values: 185.0 188.0 186.0 185.0 187.0 180.0 182.0 184.0 184.0 184.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:79.30 Median:72.50 stddev:18.75 (25.9%) stddev-sans-first:19.58 10:58:47 INFO - PROCESS | 1671 | Values: 70.0 75.0 84.0 89.0 55.0 60.0 64.0 101.0 115.0 80.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:79.00 stddev:21.41 (27.1%) stddev-sans-first:22.65 10:58:47 INFO - PROCESS | 1671 | Values: 91.0 95.0 130.0 77.0 79.0 81.0 123.0 79.0 78.0 123.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 10:58:47 INFO - PROCESS | 1671 | Values: 86.0 84.0 87.0 83.0 86.0 83.0 87.0 84.0 86.0 84.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:93.00 stddev:22.52 (24.2%) stddev-sans-first:23.07 10:58:47 INFO - PROCESS | 1671 | Values: 93.0 93.0 93.0 104.0 146.0 95.0 94.0 101.0 148.0 129.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:89.80 Median:85.50 stddev:8.08 (9.5%) stddev-sans-first:8.57 10:58:47 INFO - PROCESS | 1671 | Values: 89.0 86.0 85.0 84.0 86.0 84.0 84.0 91.0 105.0 104.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:71.30 Median:78.00 stddev:13.44 (17.2%) stddev-sans-first:13.37 10:58:47 INFO - PROCESS | 1671 | Values: 58.0 60.0 59.0 77.0 88.0 88.0 86.0 79.0 60.0 58.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.00 stddev:3.98 (5.9%) stddev-sans-first:3.94 10:58:47 INFO - PROCESS | 1671 | Values: 64.0 63.0 75.0 74.0 71.0 67.0 66.0 67.0 67.0 67.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:82.00 stddev:8.44 (10.3%) stddev-sans-first:8.85 10:58:47 INFO - PROCESS | 1671 | Values: 82.0 82.0 81.0 81.0 80.0 82.0 81.0 85.0 97.0 105.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:138.50 stddev:12.29 (8.9%) stddev-sans-first:12.92 10:58:47 INFO - PROCESS | 1671 | Values: 139.0 138.0 139.0 137.0 138.0 135.0 138.0 138.0 170.0 163.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:170.00 stddev:17.32 (10.2%) stddev-sans-first:18.34 10:58:47 INFO - PROCESS | 1671 | Values: 170.0 165.0 170.0 167.0 146.0 181.0 215.0 170.0 169.0 174.0 10:58:47 INFO - PROCESS | 1671 | 10:58:47 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 10:58:47 INFO - PROCESS | 1671 | Values: 69.0 68.0 69.0 68.0 68.0 67.0 67.0 71.0 68.0 68.0 10:58:47 INFO - PROCESS | 1671 | -------- Summary: end -------- 10:58:47 INFO - PROCESS | 1671 | 10:58:48 INFO - TEST-INFO | 1671: exit 0 10:58:48 INFO - TEST-OK | kraken | took 59384ms 10:58:48 INFO - SUITE-END | took 1176s 10:58:48 INFO - Completed test suite (00:19:36) 10:58:48 INFO - javascript benchmark 10:58:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2851.48673238817, 3467.9479807802886, 3487.5291835602193, 3508.087897146741, 3550.733694972876, 5604.551635869131, 5677.943220567793, 5679.460451257124, 5759.251297331346, 5785.595008349417, 5646.915296270559, 5720.256366672337, 5721.227634269372, 5725.2843394575675, 5737.770489180428, 5151.0728068947665, 5179.637425380225, 5206.973965130188, 5218.1650935850275, 5276.12943864262, 5258.342707161605, 5264.552513036378, 5274.129768588178, 5274.841754747364, 5290.867728306785, 5223.529882310591, 5250.816221432251, 5268.736563171845, 5286.0, 5331.013762453939, 5292.629515933886, 5320.574354051705, 5329.387120481156, 5334.413214546396, 5336.813211537577, 5113.028524580318, 5133.6919784813035, 5223.843284701465, 5224.268602395668, 5247.344081989751, 5622.128570071645, 5656.745446454919, 5668.234788303567, 5682.977064128455, 5787.247657804501, 6135.263768347782, 6155.0, 6185.474234690012, 6188.81433556994, 6194.94685903393, 6104.633721976696, 6116.67056464255, 6159.952808022647, 6231.968840155816, 6234.064890266451, 5784.479396854219, 5800.738966746507, 5805.129230615442, 5869.06095024794, 5880.206172166745, 6268.341824108494, 6289.276733175652, 6294.8111556653375, 6296.905546416808, 6297.086922396227, 6066.575339726265, 6116.908246376308, 6145.631262124287, 6148.555089553951, 6153.0, 6266.0, 6293.244810622663, 6302.212223472066, 6308.432241098323, 6311.242650881832, 6209.689515524296, 6254.655993920287, 6278.30938596754, 6286.9056964145575, 6287.528435367366, 6083.8479038023515, 6131.223750760645, 6156.415140561639, 6287.402696743802, 6345.650989195547, 4821.349117869113, 4850.927236091461, 4867.34290870735, 4868.513148685174, 4868.756562171877, 4409.823607055682, 4449.888752781141, 4458.554144585515, 4473.261911784584, 4524.6832721709825, 5758.107493338539, 5770.769169233267, 5772.7113644317615, 5796.797112101056, 5814.215080964101, 6195.907061393992, 6266.905996410058, 6291.245050593958, 6291.276503202099, 6302.023186406114, 5571.721413929287, 5646.040173170571, 5659.745311460994, 5725.828225153252, 5758.165066065397, 5142.100132476877, 5324.068288049576, 5369.731513424314, 5391.353037635509, 5395.298611180521, 6211.006239001738, 6271.216097987752, 6273.592216505913, 6279.843003924939, 6280.995040793542, 6215.96892015537, 6289.874202515833, 6323.36766323364, 6332.30344662096, 6339.112524246517, 6334.651594162366, 6340.809775706736, 6357.650329231937, 6361.268454127835, 6373.203349581302, 6095.710389288371, 6175.505959523317, 6255.249370075438, 6256.280527739368, 6281.403266689657, 6233.96883015582, 6257.374262573706, 6262.780802671885, 6292.3078461368295, 6292.811215663537, 6137.96931015342, 6138.662373569318, 6146.477549408351, 6171.876562468815, 6176.382361763787, 5581.302337207849, 5994.520438365008, 6110.236220472441, 6134.969325153345, 6143.416375444325, 5954.732037058429, 5962.70186490665, 5963.582549221686, 5977.820665380045, 6022.066579680157, 6124.239704855953, 6127.479164271087, 6141.0, 6156.353582873734, 6160.045192995093, 5888.3228428731245, 5970.134330522137, 5990.101484777319, 6016.849578760566, 6018.849528761816], "value": 5718.446175291652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.9745012749363, 518.5747686896747, 529.4811085136565, 531.7394476706413, 635.5138319185824, 28935.276618084557, 29450.705492945064, 37945.43081853771, 38812.02969925753, 38850.0, 40446.79776601113, 41580.58419415805, 41621.791891040506, 41668.79165604175, 41766.0, 7469.514481558695, 9688.418694878295, 9696.515174241295, 9711.320207585472, 9724.562394692255, 8434.198751118665, 8706.564671766386, 8710.041895391501, 8714.433561818492, 8717.084706105863, 8879.378443508956, 11639.767204655902, 11656.708582285426, 11671.941640291829, 11753.4710938008, 11360.545578176863, 11582.942085289604, 11599.304041757521, 11604.129690273263, 11609.129315301345, 8415.537145456998, 11162.553497860075, 11416.257943233746, 11547.826782598268, 11555.2489088209, 37740.62259377399, 38379.424308635396, 38430.65492707742, 38492.0, 38753.80623096895, 3148.66938971407, 3296.868125274986, 3320.8173550454717, 3361.193313604742, 3781.8487260509546, 27961.300967475774, 28676.569851452245, 30004.099877003726, 30024.54963175554, 30151.09546713602, 2684.355754618877, 2767.363506393541, 2770.3766652503227, 2792.4833905727505, 2817.323842277859, 362557.0, 423129.0, 423330.0, 427703.8614806968, 428480.99999999686, 60868.47828804315, 61195.38804611986, 61660.0, 61682.38317616766, 61854.69072654698, 65683.68632627321, 65950.67024664846, 65969.34030659728, 66102.0, 66107.0, 16402.67194656124, 17039.0, 17055.526948592385, 17068.57328566771, 17103.059331736873, 13046.739065218642, 13123.409446574928, 13124.343782810822, 13144.60566183016, 13150.60548183556, 13427.798583021262, 17231.0, 18919.621607568046, 18963.0, 19273.807261927202, 7473.252674732484, 7675.30922216992, 7676.616169191518, 7682.0, 7763.301302882767, 969.2197780786394, 971.84450487923, 980.8773903262093, 1026.0919086608405, 1082.2856914436434, 28985.275368115967, 29129.70870291312, 29640.0, 29707.12955256984, 29954.55068173979, 1065.195777188218, 1097.4293367448881, 1156.7455159864817, 1156.7686462707493, 1194.6296648039136, 15155.924220378827, 15187.936844420785, 15357.308921098578, 15440.845591544165, 15500.68998620044, 628712.0, 634092.0, 639170.0, 639184.0, 640104.0, 59842.0, 60477.39522604806, 60521.0, 60573.0, 60787.08819367713, 1292.9482820687256, 1346.6902612399203, 1422.679897023203, 1474.1302631447497, 1488.3525666335179, 28566.57150142708, 28645.713542864305, 28965.565516516846, 29149.125526234246, 29224.0, 47199.52800471951, 48621.0, 49293.0, 49363.753181233864, 49551.50448495469, 419795.0, 422154.0, 423644.0, 424110.0, 424656.0, 23350.416239594146, 25938.22185334443, 26592.734072659026, 26597.33506662349, 26932.326691832863, 42528.0, 42535.0, 43000.0, 43559.56440435682, 44052.77973610111, 28203.71796282011, 36150.63849361473, 37176.44235336526, 38023.429648555844, 38059.0, 36528.0, 36631.63368366389, 37128.25743485061, 37207.566324778796, 37652.623473764914, 35551.82224088863, 36377.09057273589, 36618.8169059153, 36965.0, 37333.066673333386, 31885.36229275355, 32471.837640811646, 32584.18539536436, 32614.83692581522, 33400.33199335951, 23699.0, 23737.287881363587, 23825.0, 24508.754912450648, 24614.50770984606], "value": 19587.321586966613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.71762048945254, 399.95000624921886, 401.23764846791073, 405.33120351420155, 411.19405964309954, 18838.90580547099, 18843.246270149193, 19874.403767886968, 19894.0, 19935.800641993577, 15470.381184752596, 18332.908335458338, 18714.344997925076, 18721.034291399377, 19071.618567628673, 5368.114261146926, 5496.917546236799, 5702.315722113352, 5714.371419143911, 5715.2855893013375, 5662.433756624325, 5703.488575527488, 5719.370869204384, 5721.742521586518, 5722.313322401297, 5617.466340697648, 5705.030144875361, 5716.228309178249, 5720.8283751487315, 5728.484436400723, 5685.687287199203, 5839.386864379243, 5882.499987501067, 5894.852628684296, 5915.645061296336, 5481.561475082024, 5618.775248990036, 5634.408387119334, 5645.463680950304, 5650.208970744099, 23288.417789555228, 23314.06743730249, 24836.627450588254, 25215.117470888432, 25215.873920630278, 1928.3443629166152, 2140.1011575138477, 2173.923912663049, 2762.033689868755, 2771.2240572639494, 9457.1015753504, 9520.523973801282, 9854.014598540089, 9924.553395097239, 9955.25335599833, 1552.5342397280883, 1576.448243114912, 1642.852143307108, 1667.2580701587676, 1807.2228941555127, 90813.0, 112169.43915280452, 112331.0, 112387.87612123856, 114376.0, 9174.67888623895, 11477.885221147682, 11514.36670983104, 11523.654290371302, 11653.88346116528, 12006.579769708018, 14716.779248311284, 14781.408743650349, 14785.926070369795, 14791.556253312418, 8151.18488151192, 8359.791005224797, 8373.706920257762, 8455.619497122645, 8456.66173353059, 8154.959225203836, 8184.6316915738935, 8188.2630563249595, 8265.338772898154, 8317.916820831715, 4428.734275943454, 4483.0, 4535.818567257273, 4553.3397657340165, 4602.953970460252, 1587.563420059493, 1797.5162302848332, 1859.958423282966, 1896.5448292409721, 1950.4831219726784, 781.878808784628, 802.3781569283851, 951.7858481841669, 961.7643677298967, 972.0376826941277, 19769.50576235577, 20603.085413771336, 20635.277765278144, 20662.966851657657, 20669.58660826775, 760.4942713095729, 874.339873395595, 942.1520631431766, 956.2015716876487, 1033.7002269341956, 10262.384256944608, 10719.98160174782, 10721.088707459798, 10733.624323148651, 10749.83875241872, 555923.0, 573943.0, 581993.0, 589768.0, 596877.0, 132986.0, 134337.0, 134669.0, 138822.0, 141864.0, 998.7353351361895, 1041.6874937518714, 1058.2433560004633, 1059.613241166984, 1061.0821639281965, 17488.562785930455, 17775.555611109827, 17798.377056803467, 17948.74358794924, 18145.183466744293, 51592.48407515877, 52530.73734631302, 53268.0, 53719.0, 54149.0, 71255.64372178106, 73840.0, 78762.6061869687, 78964.0, 79885.60057199677, 6958.965205173941, 7907.84184316299, 8051.39614528901, 8145.959270203611, 8150.225728555778, 10994.28537145083, 12158.696032599255, 12291.078169137172, 12517.812232816697, 12599.118061735591, 10694.572217111228, 10806.35161890289, 10850.728731781453, 10871.402072886067, 10956.013958743752, 10514.894851051391, 10587.629432970118, 10605.734856628646, 10789.62236321725, 10824.5128969195, 10728.678139655824, 10964.177686673373, 11182.440877955907, 11251.043661288555, 11272.718182045515, 7850.293473587404, 7886.05367355898, 7952.562609056557, 7991.320737737125, 8085.353171746364, 8282.958585207036, 10524.684259472227, 10920.945395272973, 11114.277571957797, 11336.319820810777], "value": 9326.358832706188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.4030627289676, 1626.9593260168494, 1641.934322627095, 1909.436716168731, 2018.9899050504746, 7955.880661790078, 8605.225529702333, 8790.692325768583, 8808.515531645757, 8823.0, 8395.538245396516, 8639.65441382344, 8643.740687779376, 8657.177568131034, 8671.869921951176, 2161.427221786228, 2371.5731168389684, 2397.328747950572, 2454.631805229212, 2466.0998735461517, 2447.7185123710824, 2477.7398373170827, 2480.355107672, 2487.092211342865, 2488.415222422729, 2395.161693407302, 2397.6403539469134, 2398.436367453647, 2399.400149962509, 2399.5440866235444, 2120.8303335733103, 2347.272345572878, 2367.490989437271, 2412.264259400882, 2421.6125419932728, 2433.2856802477813, 2443.6701045359005, 2463.4826686395877, 2464.741202173782, 2469.715982661999, 8663.956680216621, 8818.29453643707, 8830.161134692195, 8836.923323019086, 8841.469511829246, 4826.396700412449, 5237.3453318335205, 5415.187721841716, 5423.078076726966, 5441.83674489766, 3552.609212986595, 3562.87529936451, 3581.7492775505725, 3649.033006253345, 3674.5590529136407, 1026.3687831983277, 1033.3076838518211, 1043.5095505112586, 1047.774728433383, 1051.432226597644, 9389.953050234773, 11820.822687659605, 11851.229670071503, 11853.9331460169, 11870.940645296718, 4674.182018146878, 4819.638527110411, 4843.54693591921, 4907.779149938261, 4976.377952755905, 9900.752481188028, 9917.65288214909, 9927.354721943051, 9930.950345248228, 9948.602055917681, 5388.218708287276, 5393.191021346829, 5397.325334333208, 5405.21624364465, 5432.429594892558, 4399.252127138394, 4552.112338094106, 4561.703489273186, 4565.840195593139, 4916.434610019822, 3610.476480910306, 3901.8634347797692, 3964.1873415949663, 4027.1140349123148, 4073.4948006975496, 1324.6555895467247, 1336.8395792504962, 1347.487954577274, 1351.966200844967, 1368.2406264523086, 769.2154002916993, 838.7064527415356, 900.2527901841456, 920.7928216151313, 928.79256965944, 5410.458954104637, 5483.314585676791, 5621.578381621394, 5656.490915817596, 5790.218320526675, 928.7554676733075, 950.2635457520477, 991.3853410885154, 1011.0092109732503, 1068.823644098715, 3728.366177749735, 3750.493683352767, 3764.7176461765475, 3825.215830754689, 3836.712246581462, 10269.127124194527, 10700.464976751131, 10713.410762408143, 10723.83914241287, 10738.94630526858, 10048.849267260997, 10622.309549879234, 10684.786304273872, 10688.0, 10693.19801014927, 8046.678132874619, 8081.797955051054, 8152.6331315090965, 8226.835463290701, 8235.8352832943, 4328.177646247203, 5520.365158006881, 5633.155026746021, 5781.0, 5927.614705044159, 9635.807283854423, 9783.755406114904, 9861.408315501092, 9987.500624968869, 10062.993700629879, 10071.546780394754, 10305.0, 10321.329113607591, 10371.429571373646, 10485.895141048491, 6468.417842394207, 7635.503692259986, 7656.425768067305, 7660.655270512729, 7673.040869891263, 7909.209079092045, 8138.796530086795, 8291.419600627898, 8305.543195124084, 8313.043999940084, 7230.276972302728, 7241.384482319062, 7322.816929576803, 7367.0, 7386.741464048732, 5895.469407753323, 6959.234484206632, 7047.154341479055, 7113.3953613943395, 7278.563286202845, 6892.0, 6917.342852429011, 6928.896066559107, 6945.0, 6967.407770339578, 4603.7556170580165, 4750.952490475189, 4805.255185446262, 4825.734584597881, 4938.08645400602, 4177.937330939978, 4784.497627749036, 4797.496262892486, 4862.7325497098, 4948.134076536519], "value": 4568.290678413657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.7757991825802, 320.9037288813356, 329.755980574375, 333.4814363664502, 334.92296771742485, 5196.688198708081, 5907.0, 5993.160957465952, 6008.759649614021, 6063.99944009238, 4879.24347234996, 4919.827806026789, 5608.214849921004, 5922.378150294222, 5971.940280597204, 3915.6280153385383, 4466.642668586522, 4470.00509658528, 4492.640588752892, 4505.8422955196575, 4495.213337665912, 4514.458265008204, 4524.3213517972235, 4543.5456454354635, 4546.977265113686, 3442.7762195457217, 4181.498220213563, 4296.334068219431, 4501.279795232764, 4531.207038768219, 4451.821927122911, 4470.552944705536, 4470.642348612103, 4493.0, 4498.370228168059, 3880.4373365861793, 3880.9223815523815, 3883.145707944276, 3884.5915532369827, 3893.240818040483, 3865.342891708416, 5430.809921652763, 5569.805056823032, 5789.884202315972, 5836.445537673914, 4260.978695106504, 5106.5659418949435, 5127.461616530285, 5130.563902068291, 5163.483651634844, 6350.968245158745, 6360.459360954278, 6386.233651961795, 6408.423241908251, 6428.935710642881, 4064.9837540614844, 4227.070044590185, 4246.532881383046, 4265.38151967966, 4268.0183557781575, 6535.575187612838, 6682.966585167092, 6689.76585819494, 6690.59856408617, 6756.358145976124, 4086.8978275542754, 4109.198706252312, 4256.70203085781, 4257.574242575718, 4289.592488713567, 4064.065264989069, 4122.711410201317, 4146.896327591774, 4314.374415709704, 4365.628921541641, 4620.3762492063815, 5100.744962751847, 5125.923111153335, 5131.435542090367, 5133.4096578893905, 5624.29696287964, 5899.764009439575, 6111.502681842977, 6427.839304017437, 6437.935620643733, 1225.724212052281, 1236.567201479475, 1407.7184563087424, 1487.8512148785035, 1507.9698406031819, 853.0658928473312, 912.0605776050678, 937.639008981547, 938.1134827587864, 957.9233661307079, 5837.883242335214, 5841.591088623841, 5884.382139875337, 5899.439553242435, 5958.761649534057, 6426.967865160645, 6530.771423000172, 6560.245571759308, 6577.079208910756, 6656.2345330287635, 5856.531477481792, 5861.824145275648, 5869.593466678642, 5878.294604647384, 5878.29460464747, 2712.8877160364154, 3448.0, 3468.4450487921813, 3474.756767026284, 3476.66971637694, 5339.973300133553, 6043.7884674036195, 6303.810885673437, 6799.1840979081835, 6853.348931851466, 5863.794767183128, 6676.899846502306, 6687.598744075371, 6710.731570737214, 6717.6977036033495, 6024.27708674953, 6532.738690452424, 6955.791326260221, 6974.930250697428, 6988.357735932052, 6339.809805705836, 6544.821932052277, 6629.900551491635, 6664.733410663519, 6675.23234828001, 6389.424951754364, 6393.6483493408305, 6437.002264648987, 6592.8351791205605, 6640.767573134917, 5560.7219639018695, 6879.380855723009, 6887.173539175131, 6911.479474515599, 6939.340762627542, 4141.399497072968, 4170.270202714452, 4173.770442625685, 4257.744535327766, 4296.720713153635, 6620.0, 6645.082638847121, 6670.164131004983, 6674.132362792806, 6682.3317668232785, 6408.166938298178, 6408.30180002309, 6415.871682566416, 6423.888711224727, 6425.361532809104, 5257.211418287287, 5288.3918349390315, 5311.893762124813, 6157.875532941128, 6417.679116044085, 5716.9142462862255, 5837.270341207349, 5998.550108741949, 6061.605995610271, 6275.937240627535, 5589.813806130629, 5693.914591281217, 5815.680137592473, 6395.904061438989, 6495.480361570969, 5349.399516415957, 5625.521830644441, 6303.747850085945, 6306.527010474325, 6329.810105696836], "value": 4580.191959800593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9557378770379, 709.879320515512, 732.567785006846, 740.8851627997662, 760.562676461035, 14103.0, 14507.202103884281, 14507.49223777168, 14509.347079381414, 14510.201938893357, 13565.796513052288, 13643.522476713317, 13659.931700341509, 13679.863201367983, 13726.176429414218, 717.501336571082, 744.5123444144094, 893.2273583350387, 930.4045410937006, 930.9069093090704, 913.8583519554479, 924.3298608508844, 925.4909799610222, 925.7454200094994, 926.7961048569338, 963.4604621411996, 977.5600979559191, 979.294907666479, 980.0248752491245, 981.5386768218925, 679.0052572980558, 752.3153929923743, 767.7121079595152, 966.2849491376367, 969.6993931881104, 579.1457600039907, 696.1924167965187, 721.0, 721.3219573600851, 723.7937187901475, 14708.411663533447, 14788.18664973426, 14796.18620975846, 14821.555353339418, 14830.629234269121, 12131.332776697278, 12150.513979440811, 12346.074044446703, 12452.501899923993, 12713.491460341575, 9561.856572151424, 9860.112589866947, 9984.500774961296, 10263.538140783683, 10466.529006194663, 3450.6721861423125, 3455.0, 3484.5992710838073, 3549.8757543486113, 3553.200529880756, 77871.61064194699, 78665.60667196685, 79902.40195196122, 80012.0, 80567.0, 9340.532973351304, 9370.531473426301, 9462.668806591737, 9522.238220942309, 10008.549615267331, 20918.372448826558, 21121.9439028048, 21163.0, 21175.470613234793, 21179.78820211809, 7409.777706668809, 7459.403247740168, 7503.512271702322, 7511.51175173612, 7641.617919104023, 4045.8381664733083, 4110.650594699484, 4140.296149654566, 4141.8964525887095, 4143.461350024478, 2855.971440285612, 3538.6992105670793, 3551.6448355164794, 3555.8755443559867, 3560.0, 664.8371149068413, 674.3829396102609, 676.100785954679, 677.3260605697265, 679.0628932073706, 582.72320647692, 585.1427658480346, 594.8304733151118, 600.9338972712998, 604.8669292755586, 7430.182679905206, 7483.775486735407, 7510.624468776539, 7632.694692212361, 7983.481073730189, 483.9758012099381, 526.457748519026, 544.7221916822449, 562.5471495446124, 564.4271064869162, 3045.573619693245, 3611.620779818134, 3671.2657468506404, 3683.3922402803237, 3869.9806500967316, 61557.07664385038, 78787.0, 82045.0, 82569.17430825735, 83620.0, 71539.0, 72465.91301130487, 72591.0, 73414.0, 74326.0, 59366.70316648475, 65702.67148664226, 66228.66885665637, 66289.99999999904, 67017.0, 5874.676892770939, 7309.305615966475, 7318.780436586911, 7354.816129596803, 7480.3641690456925, 38104.618953811216, 39742.00644983783, 41983.790081049396, 42193.578064218964, 42581.78709106435, 53782.46217537775, 53787.0, 54611.726941365036, 55966.0, 61203.69398152981, 10752.462376881282, 10813.080888124598, 10898.128149747843, 11104.666859994213, 11331.263467874562, 11751.647450576154, 11775.17573769862, 11873.584424545099, 11886.702832429259, 12406.317652529198, 11179.888201117885, 11245.269057511563, 11388.37363944991, 11500.48247828833, 11754.941225293818, 11125.833112503156, 11402.0, 11435.771284574095, 11608.535658573563, 11718.0, 10971.670849874517, 11136.610218642309, 11242.269252498561, 11382.94308528452, 11625.763968101119, 9340.299477539347, 9488.33581649278, 9512.23902087845, 9543.52282385864, 9849.556769945226, 9027.819443611223, 9349.111834375723, 9529.666461673809, 9911.157551608194, 10013.649522266685], "value": 6647.766628836945, "unit": "score"}], "name": "dromaeo_css", "value": 7250.80931050117, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 164.0, 160.0, 113.0, 113.0, 118.0, 110.0, 113.0, 113.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 145.0, 167.0, 120.0, 142.0, 140.0, 120.0, 174.0, 144.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 186.0, 185.0, 187.0, 180.0, 182.0, 184.0, 184.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 84.0, 89.0, 55.0, 60.0, 64.0, 101.0, 115.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 130.0, 77.0, 79.0, 81.0, 123.0, 79.0, 78.0, 123.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 87.0, 84.0, 86.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 104.0, 146.0, 95.0, 94.0, 101.0, 148.0, 129.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 85.0, 84.0, 86.0, 84.0, 84.0, 91.0, 105.0, 104.0], "value": 89.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 77.0, 88.0, 88.0, 86.0, 79.0, 60.0, 58.0], "value": 71.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 75.0, 74.0, 71.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 81.0, 80.0, 82.0, 81.0, 85.0, 97.0, 105.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 139.0, 137.0, 138.0, 135.0, 138.0, 138.0, 170.0, 163.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 170.0, 167.0, 146.0, 181.0, 215.0, 170.0, 169.0, 174.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 71.0, 68.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1519.2999999999997, "alertThreshold": 2.0}]} 10:58:48 INFO - Return code: 0 10:58:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:58:48 ERROR - # TBPL SUCCESS # 10:58:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:58:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:58:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:58:48 INFO - 2016-04-20 10:58:48.741 screenresolution[1675:10126] starting screenresolution argv=screenresolution get 10:58:48 INFO - 2016-04-20 10:58:48.743 screenresolution[1675:10126] Display 0: 1600x1200x32@60 10:58:48 INFO - 2016-04-20 10:58:48.749 screenresolution[1676:10129] starting screenresolution argv=screenresolution list 10:58:48 INFO - Available Modes on Display 0 10:58:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:58:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:58:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:58:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:58:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:58:48 INFO - Intel Iris: 10:58:48 INFO - Chipset Model: Intel Iris 10:58:48 INFO - Type: GPU 10:58:48 INFO - Bus: Built-In 10:58:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:58:48 INFO - Vendor: Intel (0x8086) 10:58:48 INFO - Device ID: 0x0a2e 10:58:48 INFO - Revision ID: 0x0009 10:58:48 INFO - Displays: 10:58:48 INFO - Display: 10:58:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:58:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:58:48 INFO - Display Serial Number: 1600x1200 60 10:58:48 INFO - Main Display: Yes 10:58:48 INFO - Mirror: Off 10:58:48 INFO - Online: Yes 10:58:48 INFO - Rotation: Supported 10:58:48 INFO - Return code: 0 10:58:48 INFO - Running post-action listener: _resource_record_post_action 10:58:48 INFO - Running post-run listener: _resource_record_post_run 10:58:50 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 37635584; Write bytes: 696379392; Read time: 396; Write time: 1941 10:58:50 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375695872; Write bytes: 369866240; Read time: 27979; Write time: 678 10:58:50 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36713984; Write bytes: 299213312; Read time: 382; Write time: 1215 10:58:50 INFO - Running post-run listener: _upload_blobber_files 10:58:50 INFO - Blob upload gear active. 10:58:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:58:50 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 10:58:50 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'] 10:58:50 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 10:58:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:51 INFO - (blobuploader) - INFO - Done attempting. 10:58:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:58:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:52 INFO - (blobuploader) - INFO - Done attempting. 10:58:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:58:52 INFO - Return code: 0 10:58:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:58:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:58:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1372c7896bc641268bf400c63939e8863f47d3066a79c4c7312c8715f76dd21f3d981eb553225c90d7c57d360c3f878e7231ba4efc7c9892b31d52b58a8c4138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de6d65b51a0a193323fab405ed2b16debe5808a2fe5d52d75694760a0160cdac6b774c225da2d3d39ccaff1e78965d69b177dc05f2997ca81799c03a92d1989"} 10:58:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:58:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:58:52 INFO - Contents: 10:58:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1372c7896bc641268bf400c63939e8863f47d3066a79c4c7312c8715f76dd21f3d981eb553225c90d7c57d360c3f878e7231ba4efc7c9892b31d52b58a8c4138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de6d65b51a0a193323fab405ed2b16debe5808a2fe5d52d75694760a0160cdac6b774c225da2d3d39ccaff1e78965d69b177dc05f2997ca81799c03a92d1989"} 10:58:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:58:52 INFO - Copying logs to upload dir... 10:58:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:58:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.745191 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 10:58:52.299970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:58:52.303277) ========= 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.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1372c7896bc641268bf400c63939e8863f47d3066a79c4c7312c8715f76dd21f3d981eb553225c90d7c57d360c3f878e7231ba4efc7c9892b31d52b58a8c4138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de6d65b51a0a193323fab405ed2b16debe5808a2fe5d52d75694760a0160cdac6b774c225da2d3d39ccaff1e78965d69b177dc05f2997ca81799c03a92d1989"} build_url:https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/cG8M9ovIRYOxGU3rY0CzXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1372c7896bc641268bf400c63939e8863f47d3066a79c4c7312c8715f76dd21f3d981eb553225c90d7c57d360c3f878e7231ba4efc7c9892b31d52b58a8c4138", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8de6d65b51a0a193323fab405ed2b16debe5808a2fe5d52d75694760a0160cdac6b774c225da2d3d39ccaff1e78965d69b177dc05f2997ca81799c03a92d1989"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:58:52.333724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:58:52.334217) ========= 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.b40sY5MVDa/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.4IYW4fbnYo/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005133 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:58:52.384854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:58:52.385356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:58:52.386015) ========= ========= Total master_lag: 15.32 =========