builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1461949962.78 results: success (0) buildid: 20160429091440 builduid: 2cad76d3c4f24b37b76b3fe477d5d9a8 revision: 3a2d51262a88796314ae1a3c19beeb7ebadfc349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:42.785249) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:42.785817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:42.786142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:42.805242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:42.805561) ========= 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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-29 10:12:42-- 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% 73.7M=0s 2016-04-29 10:12:43 (73.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:43.015767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:43.016098) ========= 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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.027593 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:43.064424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 10:12:43.064745) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a2d51262a88796314ae1a3c19beeb7ebadfc349 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a2d51262a88796314ae1a3c19beeb7ebadfc349 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-29 10:12:43,141 truncating revision to first 12 chars 2016-04-29 10:12:43,141 Setting DEBUG logging. 2016-04-29 10:12:43,141 attempt 1/10 2016-04-29 10:12:43,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3a2d51262a88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 10:12:44,182 unpacking tar archive at: mozilla-beta-3a2d51262a88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 10:12:44.363975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:44.364299) ========= script_repo_revision: 3a2d51262a88796314ae1a3c19beeb7ebadfc349 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:44.364699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:44.364985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 10:12:44.378397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-29 10:12:44.378769) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:12:44 INFO - MultiFileLogger online at 20160429 10:12:44 in /builds/slave/test 10:12:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:12:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:44 INFO - {'append_to_log': False, 10:12:44 INFO - 'base_work_dir': '/builds/slave/test', 10:12:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:12:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:44 INFO - 'branch': 'Mozilla-Beta', 10:12:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:44 INFO - 'config_files': ('talos/mac_config.py',), 10:12:44 INFO - 'default_actions': ('clobber', 10:12:44 INFO - 'read-buildbot-config', 10:12:44 INFO - 'download-and-extract', 10:12:44 INFO - 'populate-webroot', 10:12:44 INFO - 'create-virtualenv', 10:12:44 INFO - 'install', 10:12:44 INFO - 'run-tests'), 10:12:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:44 INFO - 'download_minidump_stackwalk': True, 10:12:44 INFO - 'download_symbols': 'ondemand', 10:12:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:44 INFO - 'installer_path': 'installer.exe', 10:12:44 INFO - 'log_level': 'info', 10:12:44 INFO - 'log_name': 'talos', 10:12:44 INFO - 'log_to_console': True, 10:12:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:44 INFO - 'opt_config_files': (), 10:12:44 INFO - 'pip_index': False, 10:12:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:44 INFO - 'cmd': ('bash', 10:12:44 INFO - '-c', 10:12:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:44 INFO - 'enabled': True, 10:12:44 INFO - 'halt_on_failure': False, 10:12:44 INFO - 'name': 'check_screen_resolution'},), 10:12:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:44 INFO - 'cmd': ('bash', 10:12:44 INFO - '-c', 10:12:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:44 INFO - 'enabled': True, 10:12:44 INFO - 'halt_on_failure': False, 10:12:44 INFO - 'name': 'check_screen_resolution'},), 10:12:44 INFO - 'run_cmd_checks_enabled': True, 10:12:44 INFO - 'sps_profile': False, 10:12:44 INFO - 'sps_profile_interval': 0, 10:12:44 INFO - 'suite': 'dromaeojs', 10:12:44 INFO - 'system_bits': '32', 10:12:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:44 INFO - 'title': 't-yosemite-r7-0182', 10:12:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:44 INFO - 'use_talos_json': True, 10:12:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:44 INFO - 'work_dir': 'build'} 10:12:44 INFO - ##### 10:12:44 INFO - ##### Running clobber step. 10:12:44 INFO - ##### 10:12:44 INFO - Running pre-action listener: _resource_record_pre_action 10:12:44 INFO - Running main action method: clobber 10:12:44 INFO - rmtree: /builds/slave/test/build 10:12:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:46 INFO - Running post-action listener: _resource_record_post_action 10:12:46 INFO - ##### 10:12:46 INFO - ##### Running read-buildbot-config step. 10:12:46 INFO - ##### 10:12:46 INFO - Running pre-action listener: _resource_record_pre_action 10:12:46 INFO - Running main action method: read_buildbot_config 10:12:46 INFO - Using buildbot properties: 10:12:46 INFO - { 10:12:46 INFO - "project": "", 10:12:46 INFO - "product": "firefox", 10:12:46 INFO - "script_repo_revision": "production", 10:12:46 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:12:46 INFO - "repository": "", 10:12:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:12:46 INFO - "buildid": "20160429091440", 10:12:46 INFO - "pgo_build": "False", 10:12:46 INFO - "basedir": "/builds/slave/test", 10:12:46 INFO - "buildnumber": 4, 10:12:46 INFO - "slavename": "t-yosemite-r7-0182", 10:12:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:12:46 INFO - "platform": "yosemite_r7", 10:12:46 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:12:46 INFO - "branch": "mozilla-beta", 10:12:46 INFO - "repo_path": "releases/mozilla-beta", 10:12:46 INFO - "revision": "3a2d51262a88796314ae1a3c19beeb7ebadfc349", 10:12:46 INFO - "stage_platform": "macosx64", 10:12:46 INFO - "builduid": "2cad76d3c4f24b37b76b3fe477d5d9a8", 10:12:46 INFO - "slavebuilddir": "test" 10:12:46 INFO - } 10:12:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:12:46 INFO - Running post-action listener: _resource_record_post_action 10:12:46 INFO - ##### 10:12:46 INFO - ##### Running download-and-extract step. 10:12:46 INFO - ##### 10:12:46 INFO - Running pre-action listener: _resource_record_pre_action 10:12:46 INFO - Running main action method: download_and_extract 10:12:46 INFO - mkdir: /builds/slave/test/build/tests 10:12:46 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:12:46 INFO - https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:12:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:12:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:12:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:12:48 INFO - Downloaded 1241 bytes. 10:12:48 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:12:48 INFO - Using the following test package requirements: 10:12:48 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:12:48 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:12:48 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:12:48 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:12:48 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:12:48 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:12:48 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:12:48 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:12:48 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:12:48 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:12:48 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:12:48 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:12:48 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:48 INFO - https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:12:53 INFO - Downloaded 17745620 bytes. 10:12:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:12:56 INFO - Return code: 0 10:12:56 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:56 INFO - https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:13:06 INFO - Downloaded 17745620 bytes. 10:13:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:13:10 INFO - Return code: 0 10:13: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:13:10 INFO - https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:13:11 INFO - Downloaded 10845194 bytes. 10:13:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:13:11 INFO - Return code: 0 10:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:11 INFO - https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:13:16 INFO - Downloaded 88299265 bytes. 10:13:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:13:16 INFO - mkdir: /builds/slave/test/properties 10:13:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:16 INFO - Contents: 10:13:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:13:17 INFO - Running post-action listener: _resource_record_post_action 10:13:17 INFO - Running post-action listener: set_extra_try_arguments 10:13:17 INFO - ##### 10:13:17 INFO - ##### Running populate-webroot step. 10:13:17 INFO - ##### 10:13:17 INFO - Running pre-action listener: _resource_record_pre_action 10:13:17 INFO - Running main action method: populate_webroot 10:13:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:17 INFO - '--tppagecycles', 10:13:17 INFO - '7'], 10:13:17 INFO - 'tests': ['tsvgm']}}, 10:13:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:13:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:13:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['damp', 'tps']}, 10:13:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['damp', 'tps']}, 10:13:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:13:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:17 INFO - 'other': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other_l64': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other_nol64': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'svgr': {'tests': ['tsvgx', 10:13:17 INFO - 'tsvgr_opacity', 10:13:17 INFO - 'tart', 10:13:17 INFO - 'tscrollx', 10:13:17 INFO - 'cart']}, 10:13:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['tsvgx', 10:13:17 INFO - 'tsvgr_opacity', 10:13:17 INFO - 'tart', 10:13:17 INFO - 'tscrollx', 10:13:17 INFO - 'cart']}, 10:13:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['tp5o']}, 10:13:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--e10s'], 10:13:17 INFO - 'tests': ['tp5o']}, 10:13:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--xperf_path', 10:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:17 INFO - 'tests': ['tp5n']}, 10:13:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--e10s', 10:13:17 INFO - '--xperf_path', 10:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:17 INFO - 'tests': ['tp5n']}}, 10:13:17 INFO - 'talos.zip': {'path': '', 10:13:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:17 INFO - Running post-action listener: _resource_record_post_action 10:13:17 INFO - ##### 10:13:17 INFO - ##### Running create-virtualenv step. 10:13:17 INFO - ##### 10:13:17 INFO - Running pre-action listener: _resource_record_pre_action 10:13:17 INFO - Running main action method: create_virtualenv 10:13:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:17 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:13:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:17 INFO - Using real prefix '/tools/python27' 10:13:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:20 INFO - Installing pip.................done. 10:13:20 INFO - Return code: 0 10:13:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:20 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:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:20 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:13:20 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:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:20 INFO - 'HOME': '/Users/cltbld', 10:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:20 INFO - 'LOGNAME': 'cltbld', 10:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:20 INFO - 'MOZ_NO_REMOTE': '1', 10:13:20 INFO - 'NO_EM_RESTART': '1', 10:13:20 INFO - 'PAGER': '/bin/cat', 10:13:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:20 INFO - 'PWD': '/builds/slave/test', 10:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:20 INFO - 'SHELL': '/bin/bash', 10:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:20 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:20 INFO - 'USER': 'cltbld', 10:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:20 INFO - 'XPC_FLAGS': '0x0', 10:13:20 INFO - 'XPC_SERVICE_NAME': '0', 10:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:21 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:13:21 INFO - Cleaning up... 10:13:21 INFO - Return code: 0 10:13:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:21 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:21 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:13:21 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:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:21 INFO - 'HOME': '/Users/cltbld', 10:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:21 INFO - 'LOGNAME': 'cltbld', 10:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:21 INFO - 'MOZ_NO_REMOTE': '1', 10:13:21 INFO - 'NO_EM_RESTART': '1', 10:13:21 INFO - 'PAGER': '/bin/cat', 10:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:21 INFO - 'PWD': '/builds/slave/test', 10:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:21 INFO - 'SHELL': '/bin/bash', 10:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:21 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:21 INFO - 'USER': 'cltbld', 10:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:21 INFO - 'XPC_FLAGS': '0x0', 10:13:21 INFO - 'XPC_SERVICE_NAME': '0', 10:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:21 INFO - Downloading/unpacking psutil>=0.7.1 10:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:24 INFO - Installing collected packages: psutil 10:13:24 INFO - Running setup.py install for psutil 10:13:24 INFO - building 'psutil._psutil_osx' extension 10:13:24 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:13:24 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:13:24 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:13:25 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:13:25 INFO - building 'psutil._psutil_posix' extension 10:13:25 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:13:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:13:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:13:25 INFO - ^ 10:13:25 INFO - 1 warning generated. 10:13:25 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:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:25 INFO - Successfully installed psutil 10:13:25 INFO - Cleaning up... 10:13:25 INFO - Return code: 0 10:13:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:13:25 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:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:25 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:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:25 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:25 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:13:25 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:13:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:25 INFO - 'HOME': '/Users/cltbld', 10:13:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:25 INFO - 'LOGNAME': 'cltbld', 10:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:25 INFO - 'MOZ_NO_REMOTE': '1', 10:13:25 INFO - 'NO_EM_RESTART': '1', 10:13:25 INFO - 'PAGER': '/bin/cat', 10:13:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:25 INFO - 'PWD': '/builds/slave/test', 10:13:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:25 INFO - 'SHELL': '/bin/bash', 10:13:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:25 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:25 INFO - 'USER': 'cltbld', 10:13:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:25 INFO - 'XPC_FLAGS': '0x0', 10:13:25 INFO - 'XPC_SERVICE_NAME': '0', 10:13:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:13: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:13: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:13: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:13: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:13: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:13: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:13:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:28 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:13:28 INFO - Installing collected packages: mozsystemmonitor 10:13:28 INFO - Running setup.py install for mozsystemmonitor 10:13:28 INFO - Successfully installed mozsystemmonitor 10:13:28 INFO - Cleaning up... 10:13:28 INFO - Return code: 0 10:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13: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:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', '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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:13: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 blobuploader==1.2.4 10:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:28 INFO - 'HOME': '/Users/cltbld', 10:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:28 INFO - 'LOGNAME': 'cltbld', 10:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:28 INFO - 'MOZ_NO_REMOTE': '1', 10:13:28 INFO - 'NO_EM_RESTART': '1', 10:13:28 INFO - 'PAGER': '/bin/cat', 10:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:28 INFO - 'PWD': '/builds/slave/test', 10:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:28 INFO - 'SHELL': '/bin/bash', 10:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:28 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:28 INFO - 'USER': 'cltbld', 10:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:28 INFO - 'XPC_FLAGS': '0x0', 10:13:28 INFO - 'XPC_SERVICE_NAME': '0', 10:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 10:13: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:13: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:13: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:13: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:13: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:13: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:13:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13: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:13: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:13: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:13: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:13: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:13: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:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13: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:13: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:13: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:13: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:13: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:13: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:13:32 INFO - Downloading docopt-0.6.1.tar.gz 10:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:32 INFO - Running setup.py install for blobuploader 10:13:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:32 INFO - Running setup.py install for requests 10:13:32 INFO - Running setup.py install for docopt 10:13:33 INFO - Successfully installed blobuploader requests docopt 10:13:33 INFO - Cleaning up... 10:13:33 INFO - Return code: 0 10:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:33 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:13:33 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:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:33 INFO - 'HOME': '/Users/cltbld', 10:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:33 INFO - 'LOGNAME': 'cltbld', 10:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:33 INFO - 'MOZ_NO_REMOTE': '1', 10:13:33 INFO - 'NO_EM_RESTART': '1', 10:13:33 INFO - 'PAGER': '/bin/cat', 10:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:33 INFO - 'PWD': '/builds/slave/test', 10:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:33 INFO - 'SHELL': '/bin/bash', 10:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:33 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:33 INFO - 'USER': 'cltbld', 10:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:33 INFO - 'XPC_FLAGS': '0x0', 10:13:33 INFO - 'XPC_SERVICE_NAME': '0', 10:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:33 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dLLyRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:33 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-nskVZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:33 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-q_Con7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:33 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-HZxnbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:33 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-TDT5bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-q4vNTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9nuLd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xLQhD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-WCgaBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-8jHSXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-259kLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ERXuQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-bJfVUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-I357u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:34 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Zctukv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:35 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-zchilP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:35 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-4l5v8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:35 INFO - Running setup.py install for manifestparser 10:13:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:35 INFO - Running setup.py install for mozcrash 10:13:35 INFO - Running setup.py install for mozdebug 10:13:35 INFO - Running setup.py install for mozdevice 10:13:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:35 INFO - Running setup.py install for mozfile 10:13:36 INFO - Running setup.py install for mozhttpd 10:13:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Running setup.py install for mozinfo 10:13:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Running setup.py install for mozInstall 10:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Running setup.py install for mozleak 10:13:36 INFO - Running setup.py install for mozlog 10:13:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Running setup.py install for moznetwork 10:13:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:36 INFO - Running setup.py install for mozprocess 10:13:37 INFO - Running setup.py install for mozprofile 10:13:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:37 INFO - Running setup.py install for mozrunner 10:13:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:37 INFO - Running setup.py install for mozscreenshot 10:13:37 INFO - Running setup.py install for moztest 10:13:37 INFO - Running setup.py install for mozversion 10:13:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:37 INFO - Cleaning up... 10:13:37 INFO - Return code: 0 10:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:37 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:37 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:13:37 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:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:37 INFO - 'HOME': '/Users/cltbld', 10:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:37 INFO - 'LOGNAME': 'cltbld', 10:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:37 INFO - 'MOZ_NO_REMOTE': '1', 10:13:37 INFO - 'NO_EM_RESTART': '1', 10:13:37 INFO - 'PAGER': '/bin/cat', 10:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:37 INFO - 'PWD': '/builds/slave/test', 10:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:37 INFO - 'SHELL': '/bin/bash', 10:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:37 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:37 INFO - 'USER': 'cltbld', 10:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:37 INFO - 'XPC_FLAGS': '0x0', 10:13:37 INFO - 'XPC_SERVICE_NAME': '0', 10:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-SLrxYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ngbQw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-epp3zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-YrhQbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Xc4hDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dWXKzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ga6Imp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-OcEbsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:38 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:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:38 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Oif12j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-4qRErp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-bamsEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-B2uuKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RHfI8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-mLu9TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-aFusEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-tAt1pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:39 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:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:39 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-him877-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:39 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:13:39 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:13:39 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:13:39 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:13:39 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:13:39 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:13:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:42 INFO - Downloading blessings-1.6.tar.gz 10:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:42 INFO - Installing collected packages: blessings 10:13:42 INFO - Running setup.py install for blessings 10:13:42 INFO - Successfully installed blessings 10:13:42 INFO - Cleaning up... 10:13:42 INFO - Return code: 0 10:13:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:43 INFO - Reading from file tmpfile_stdout 10:13:43 INFO - Current package versions: 10:13:43 INFO - blessings == 1.6 10:13:43 INFO - blobuploader == 1.2.4 10:13:43 INFO - docopt == 0.6.1 10:13:43 INFO - manifestparser == 1.1 10:13:43 INFO - mozInstall == 1.12 10:13:43 INFO - mozcrash == 0.17 10:13:43 INFO - mozdebug == 0.1 10:13:43 INFO - mozdevice == 0.48 10:13:43 INFO - mozfile == 1.2 10:13:43 INFO - mozhttpd == 0.7 10:13:43 INFO - mozinfo == 0.9 10:13:43 INFO - mozleak == 0.1 10:13:43 INFO - mozlog == 3.1 10:13:43 INFO - moznetwork == 0.27 10:13:43 INFO - mozprocess == 0.22 10:13:43 INFO - mozprofile == 0.28 10:13:43 INFO - mozrunner == 6.11 10:13:43 INFO - mozscreenshot == 0.1 10:13:43 INFO - mozsystemmonitor == 0.0 10:13:43 INFO - moztest == 0.7 10:13:43 INFO - mozversion == 1.4 10:13:43 INFO - psutil == 3.1.1 10:13:43 INFO - requests == 1.2.3 10:13:43 INFO - wsgiref == 0.1.2 10:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:43 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:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:43 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:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:43 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:43 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:13:43 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:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:43 INFO - 'HOME': '/Users/cltbld', 10:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:43 INFO - 'LOGNAME': 'cltbld', 10:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:43 INFO - 'MOZ_NO_REMOTE': '1', 10:13:43 INFO - 'NO_EM_RESTART': '1', 10:13:43 INFO - 'PAGER': '/bin/cat', 10:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:43 INFO - 'PWD': '/builds/slave/test', 10:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:43 INFO - 'SHELL': '/bin/bash', 10:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:43 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:43 INFO - 'USER': 'cltbld', 10:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:43 INFO - 'XPC_FLAGS': '0x0', 10:13:43 INFO - 'XPC_SERVICE_NAME': '0', 10:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 INFO - Cleaning up... 10:13:43 INFO - Return code: 0 10:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:43 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:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:43 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:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:43 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:43 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:13:43 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:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:43 INFO - 'HOME': '/Users/cltbld', 10:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:43 INFO - 'LOGNAME': 'cltbld', 10:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:43 INFO - 'MOZ_NO_REMOTE': '1', 10:13:43 INFO - 'NO_EM_RESTART': '1', 10:13:43 INFO - 'PAGER': '/bin/cat', 10:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:43 INFO - 'PWD': '/builds/slave/test', 10:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:43 INFO - 'SHELL': '/bin/bash', 10:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:43 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:43 INFO - 'USER': 'cltbld', 10:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:43 INFO - 'XPC_FLAGS': '0x0', 10:13:43 INFO - 'XPC_SERVICE_NAME': '0', 10:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:43 INFO - Downloading/unpacking jsonschema 10:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:43 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:13:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:46 INFO - Downloading/unpacking functools32 (from jsonschema) 10:13:46 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:13:46 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:13:46 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:13:46 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:13:46 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:13:46 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:13:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:47 INFO - warning: no files found matching '*.txt' 10:13:47 INFO - no previously-included directories found matching 'build' 10:13:47 INFO - no previously-included directories found matching 'dist' 10:13:47 INFO - no previously-included directories found matching '.git*' 10:13:47 INFO - Installing collected packages: jsonschema, functools32 10:13:47 INFO - Running setup.py install for functools32 10:13:47 INFO - warning: no files found matching '*.txt' 10:13:47 INFO - no previously-included directories found matching 'build' 10:13:47 INFO - no previously-included directories found matching 'dist' 10:13:47 INFO - no previously-included directories found matching '.git*' 10:13:47 INFO - Successfully installed jsonschema functools32 10:13:47 INFO - Cleaning up... 10:13:47 INFO - Return code: 0 10:13:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:47 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 0x1047dca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047e34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830bcc3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, '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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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:13:47 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:13:47 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:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:47 INFO - 'HOME': '/Users/cltbld', 10:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:47 INFO - 'LOGNAME': 'cltbld', 10:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:47 INFO - 'MOZ_NO_REMOTE': '1', 10:13:47 INFO - 'NO_EM_RESTART': '1', 10:13:47 INFO - 'PAGER': '/bin/cat', 10:13:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:47 INFO - 'PWD': '/builds/slave/test', 10:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:47 INFO - 'SHELL': '/bin/bash', 10:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:13:47 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:47 INFO - 'USER': 'cltbld', 10:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:47 INFO - 'XPC_FLAGS': '0x0', 10:13:47 INFO - 'XPC_SERVICE_NAME': '0', 10:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:47 INFO - Downloading/unpacking flake8 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:51 INFO - no previously-included directories found matching 'docs/_build' 10:13:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:51 INFO - Running setup.py install for pep8 10:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:52 INFO - no previously-included directories found matching 'docs/_build' 10:13:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:52 INFO - Cleaning up... 10:13:52 INFO - Return code: 0 10:13:52 INFO - Running post-action listener: _resource_record_post_action 10:13:52 INFO - Running post-action listener: _start_resource_monitoring 10:13:52 INFO - Starting resource monitoring. 10:13:52 INFO - ##### 10:13:52 INFO - ##### Running install step. 10:13:52 INFO - ##### 10:13:52 INFO - Running pre-action listener: _resource_record_pre_action 10:13:52 INFO - Running main action method: install 10:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:52 INFO - Reading from file tmpfile_stdout 10:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:52 INFO - Reading from file tmpfile_stdout 10:13:52 INFO - Output received: 10:13:52 INFO - Usage: mozinstall [options] installer 10:13:52 INFO - Options: 10:13:52 INFO - -h, --help show this help message and exit 10:13:52 INFO - -d DEST, --destination=DEST 10:13:52 INFO - Directory to install application into. [default: 10:13:52 INFO - "/builds/slave/test"] 10:13:52 INFO - --app=APP Application being installed. [default: firefox] 10:13:52 INFO - mkdir: /builds/slave/test/build/application 10:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:14:15 INFO - Reading from file tmpfile_stdout 10:14:15 INFO - Output received: 10:14:15 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:14:15 INFO - Running post-action listener: _resource_record_post_action 10:14:15 INFO - ##### 10:14:15 INFO - ##### Running run-tests step. 10:14:15 INFO - ##### 10:14:15 INFO - Running pre-action listener: _resource_record_pre_action 10:14:15 INFO - Running main action method: run_tests 10:14:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:15 INFO - 2016-04-29 10:14:15.674 screenresolution[1640:7704] starting screenresolution argv=screenresolution get 10:14:15 INFO - 2016-04-29 10:14:15.676 screenresolution[1640:7704] Display 0: 1600x1200x32@60 10:14:15 INFO - 2016-04-29 10:14:15.682 screenresolution[1641:7707] starting screenresolution argv=screenresolution list 10:14:15 INFO - Available Modes on Display 0 10:14:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:15 INFO - Intel Iris: 10:14:15 INFO - Chipset Model: Intel Iris 10:14:15 INFO - Type: GPU 10:14:15 INFO - Bus: Built-In 10:14:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:15 INFO - Vendor: Intel (0x8086) 10:14:15 INFO - Device ID: 0x0a2e 10:14:15 INFO - Revision ID: 0x0009 10:14:15 INFO - Displays: 10:14:15 INFO - Display: 10:14:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:15 INFO - Display Serial Number: 1600x1200 60 10:14:15 INFO - Main Display: Yes 10:14:15 INFO - Mirror: Off 10:14:15 INFO - Online: Yes 10:14:15 INFO - Rotation: Supported 10:14:15 INFO - Return code: 0 10:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:15 INFO - Python 2.7.3 10:14:15 INFO - Return code: 0 10:14:15 INFO - grabbing minidump binary from tooltool 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104680d30>, '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 0x1044e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104677b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:14:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:14:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:16 INFO - Return code: 0 10:14:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:14:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:14:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:14:17 INFO - Return code: 0 10:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XK6Bqjl6oo/Render', 10:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:17 INFO - 'HOME': '/Users/cltbld', 10:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:17 INFO - 'LOGNAME': 'cltbld', 10:14:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:17 INFO - 'MOZ_NO_REMOTE': '1', 10:14:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:17 INFO - 'NO_EM_RESTART': '1', 10:14:17 INFO - 'PAGER': '/bin/cat', 10:14:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:17 INFO - 'PWD': '/builds/slave/test', 10:14:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:17 INFO - 'SHELL': '/bin/bash', 10:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nSJVxG1vMr/Listeners', 10:14:17 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 10:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:17 INFO - 'USER': 'cltbld', 10:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:17 INFO - 'XPC_FLAGS': '0x0', 10:14:17 INFO - 'XPC_SERVICE_NAME': '0', 10:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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:14:17 INFO - mozversion application_buildid: 20160429091440 10:14:17 INFO - mozversion application_changeset: 3a2d51262a88796314ae1a3c19beeb7ebadfc349 10:14:17 INFO - mozversion application_display_name: Firefox 10:14:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:17 INFO - mozversion application_name: Firefox 10:14:17 INFO - mozversion application_remotingname: firefox 10:14:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:14:17 INFO - mozversion application_vendor: Mozilla 10:14:17 INFO - mozversion application_version: 47.0 10:14:17 INFO - mozversion platform_buildid: 20160429091440 10:14:17 INFO - mozversion platform_changeset: 3a2d51262a88796314ae1a3c19beeb7ebadfc349 10:14:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:14:17 INFO - mozversion platform_version: 47.0 10:14:17 INFO - using testdate: 1461950057 10:14:17 INFO - actual date: 1461950057 10:14:17 INFO - starting webserver on 'localhost:49275' 10:14:17 INFO - SUITE-START | Running 2 tests 10:14:17 INFO - TEST-START | dromaeo_css 10:14:17 INFO - operating with platform_type : mac_ 10:14:17 INFO - Initialising browser for dromaeo_css test... 10:14:17 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp6FJBy6/profile http://localhost:49275/getInfo.html) 10:14:19 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 10:14:19 INFO - PROCESS | 1659 | colorDepth:24 10:14:19 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 10:14:19 INFO - PROCESS | 1659 | __metrics 10:14:19 INFO - PROCESS | 1659 | 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:14:19 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:20 INFO - TEST-INFO | 1659: exit 0 10:14:20 INFO - Browser initialized. 10:14:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:20 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmp6FJBy6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:32 INFO - PROCESS | 1662 | RSS: Main: 156700672 10:14:32 INFO - PROCESS | 1662 | 10:15:23 INFO - PROCESS | 1662 | 1461950123055 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:17:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 10:17:34 INFO - PROCESS | 1662 | RSS: Main: 290500608 10:17:34 INFO - PROCESS | 1662 | 10:20:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 10:20:37 INFO - PROCESS | 1662 | RSS: Main: 296542208 10:20:37 INFO - PROCESS | 1662 | 10:23:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 10:23:39 INFO - PROCESS | 1662 | RSS: Main: 299683840 10:23:39 INFO - PROCESS | 1662 | 10:26:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 10:26:42 INFO - PROCESS | 1662 | RSS: Main: 255238144 10:26:42 INFO - PROCESS | 1662 | 10:29:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:29:45 INFO - PROCESS | 1662 | RSS: Main: 259043328 10:29:45 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:32:48 INFO - PROCESS | 1662 | RSS: Main: 306126848 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | __start_tp_report 10:32:48 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 10:32:48 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 10:32:48 INFO - PROCESS | 1662 | |i|pagename|runs| 10:32:48 INFO - PROCESS | 1662 | |0;dojo.html;3589.4436362363836;3644.7084233261344;3652.5982141964396;3699.5375578052744;3699.815009249537;6010.308814486335;6035.18524999125;6037.06425504047;6050.576459647827;6053.424924632164;6038.969805150968;6072.02847544393;6081.361457047013;6088.02017024888;6121.449069583737;5288.682679039251;5377.166539186423;5406;5464.726763661821;5489.505944464997;5463.31708536433;5490.176473528983;5492.972535137319;5496.7526461309135;5496.945030549683;5411.891762164754;5429.158480435539;5478.205660179272;5481.095619222823;5483.040467918118;5476.397596264428;5477;5500.7524661390335;5512.724363781815;5518.91721624176;5247.86880327991;5331.573474122061;5446.319210098738;5448.42791506894;5456.699881506515;4848.903021939542;5881.14723365114;5897.970510147422;5901.4098590141075;5958.553108516835;6134.865219626364;6228.532860035515;6251.156093927307;6376.521760867907;6386.904196437011;6188.257409110935;6208.472279856218;6213.782517611907;6226.844328891814;6228.22147231596;5880.970595146997;5916.437938395846;5961.552883533709;6065.363136870653;6101.786437474667;5451.972740136274;6396.488280937514;6405.007223880306;6407.743690252338;6428.614283143026;6118.541109416722;6153.046277826855;6231.657258850807;6253.843653908689;6262.749490020348;6198.318184999646;6263.217097862767;6305.653189074553;6357.936420635827;6364.872702545923;6199.814005579839;6201;6213.502919766408;6224.004159334485;6226;6085.17850090241;6148.1085242639565;6210.627362358273;6271.122042913996;6274.811755647338;4989.877277612581;4999.075171093359;5001.124803159432;5002.699838009731;5009.44896061433;4488.820447182142;4511.751853648081;4512.165249428866;4530.524294948983;4558.133954548625;6019.819405417845;6033.396660333931;6034.974054410761;6053.243344581927;6056.848578785478;6182.907256391158;6203.131561581382;6218.595791273553;6255.249370075529;6333.493320534346;6027.698615069229;6034.366391528914;6062.787802426894;6066.150738896558;6104.2064531611495;5502.532284755841;5523.143912693539;5523.392426833045;5524.977879092381;5526.226328314039;6371.840703982438;6493.967530162319;6520.445762110179;6581.703823327962;6581.934180658132;5340.759665815125;6299.811005669837;6350.333215012357;6362.904556431565;6372.458341041063;6544.476441884733;6562.015697645392;6564.343565643398;6566.704498297684;6574;6150.7847225346895;6174.938250617436;6190.81427557174;6249.0626406039455;6249.437550620466;6252.124702541739;6277.874442511215;6279.058141278845;6287.717052732546;6318.462930650946;6079.878402431838;6250.312465628868;6250.968745156245;6259.593126446766;6260.060990851227;5258.184981327748;6142.560166306883;6172.660503672161;6205.627662340274;6251.374862513712;6196.287426945959;6201.348858369806;6201.596896201732;6204.5967012144065;6212.378762123933;5294.682319060868;6297.338779428094;6310;6313.43179113882;6324.177856878577;5611.270534830609;5936.317323507679;6056.424639659225;6135.662538560244;6141.301904043499 10:32:48 INFO - PROCESS | 1662 | |1;ext.html;517.4980269138933;534.2627174499193;596.7046312075523;619.7768803230836;667.542733227739;32054.358912821728;32730.67269327306;32736.690532378678;32746.017619471426;32795.836020819894;42526;42600.3789677877;42657.14685706284;42662.57337426625;42736.572634273645;9877.11106000458;10090.990900909923;10091.243156763236;10095.596176152982;10109.342892711988;9894.604215831358;10041.19670426364;10059;10059.798804023914;10069.748256293578;9991.90008099917;10102.14131798798;10111.443870587114;10116.848247276297;10118.54466549007;10003.349782264166;10083.344582602143;10087.949560252151;10091.243156763272;10092.646757363531;9984;10146.543405546694;10222.284440089197;10250.692479225636;10252.89747102527;39877.80061099676;40420;43108.78445607752;43531.56468435338;43584;3464.688178063961;3585.623509531488;3593.784372937606;4034.0519977805193;4063.3498640217717;29775.980242667178;30608.551315894674;30912;31021.122359705038;31095.533566996513;2844.21784009397;2850.144956513038;2860.942781144386;2864.2982469295157;2885.581590669341;484893;484930;485003;485707;486609;47723;67088.6645566769;67340.3265967334;67564.6621766888;67832;47032.5296747035;47195;47226.76386618045;47323;47429.76285118552;16931.746023809654;17314.480565583053;17340.91329543344;17347.698922580857;17376.652466950844;14029.508967186304;14035.157890526601;14071.507497237548;14114.929425352808;14122.929385353007;15099.849001510063;15258.771118433233;15537.766933496006;15576.376944922304;15681.764773528406;6504.414602685781;6615.66921653925;6656.434203092695;6659;6666.83332916681;994.418265314799;1124.2748427264369;1168.696139003865;1178.834963105166;1189.1675826921016;31147.532787008215;31347.902823401073;31360.37279254402;31825.68174318227;31911.883084091944;1117.620009196877;1161.6863446869468;1234.8703386144325;1251.4368534159664;1303.7197002644477;15786.368545258061;15989.68020639604;15990;16100.275487603087;16186.919065404598;516770;520363;524812;524837;526275;62641.68679156575;63208.41978950471;63212.683936580026;63246.68376658087;63269.68365158145;1405.416752047909;1419.7586410310273;1494.7832564278335;1512.4101600375861;1546.3350759173663;29631.25921851971;29707.851460742557;29810.552841706958;30298.545521817632;30476.085717428512;47890.760546197045;48226.75886620545;48247.5175248243;48253.75873120612;48287;319022;320614;321176;321431;321476;34171.82914085413;36261.81869090637;36311.81844090763;36314.273714525036;36451.63548364482;47339.76330118327;47841;49210.75394623004;49840;49868.25197622111;38776;39759;39770;40502;40604.18791624092;38761.80619096886;39293.60706393014;39599.80200098981;39964.000899977735;40258.597414026655;38741.03147421337;39413.408798868615;40052.399214012396;40108.799456003704;40181.1963760729;31503.68496315099;34092.31815363629;34813.30373392467;34819.955401338004;34953.300933981685;26253.868730656224;26258.21225363242;26283.737162628895;26549.469010620065;26723 10:32:48 INFO - PROCESS | 1662 | |2;jquery.html;370.61641201356593;372.223913141101;373.12874438186833;378.7386703174809;378.79734342126966;20295.59408811823;21338.786612133892;21685.3494395168;22595.209167679135;22597.661035084446;21790.692558446503;21897.890510547426;22075.558488830215;22171.556568868655;22176.8891155544;5588.3014623172;5731.369549349568;5876.412358764111;5905.763769449217;5909.9704501477645;5968.074948383008;6009.519238460913;6013.398660133974;6022.909656355158;6023.457888790008;5911.876743418737;5944.613600115978;6163.537734669895;6173.444390004899;6185.041318595625;6096.573239873211;6102.359252278514;6134.263888333384;6138.416850399205;6140.631562106288;5315.627906046579;5608.831735047915;5609.9902017636805;5611.354694210137;5612.017896868073;13707.794383084261;13918.721625567432;14229.14625122496;14249.358778854976;14277.14337139775;2166.0361139293022;2230.264012875747;2237.9104835806547;2348.8355815092777;2410.9879450602634;15745.212739362985;15924.920375398166;16147.304533024098;16969.66060678792;17087.316507339816;1938.2925232290113;2022.646036943529;2047.3346162497098;2089.5879671650346;2151.38685474639;118221.40889295499;120153.79846201514;124308.37845810804;132178.33910830482;133329;14489;16721.749173762404;20392.98035098239;20516;20672.999999999698;30935.226619334248;30987.845060775002;31781.205469862976;31782.523262151088;31882;10256.641017564349;11732.94133529327;11739.002184814386;11791.646250612495;11856.88143118575;9963.80072398548;10002.249831262685;10071.748206294902;10092.697219083439;10109.848352274721;8965.686200982935;9015.549222538977;9079.909200907907;9095.27237820986;9119;3106.8446577671025;3535.8585656573964;3596.5144705464427;3620.0089950527104;3683.5558752566435;936.6347124621403;969.9757506062405;1081.9459027048615;1094.7027772090098;1099.598646494024;17121.315147394213;20198.39404817858;20509.487262818548;21168.470788230108;21293;1000.8340283569705;1027.275770581738;1029.9227557933184;1052.1162223732101;1086.0768346905068;9178.954105229432;10670.679879603624;11231.15766317513;11232.49453774582;11268;654083;687414;696786;701851;707466;122379;124010;125171;125976;127256.36371818082;1054.3463052907246;1063.3566692151292;1076.0799516413354;1078.0405439159154;1078.0674716370283;14761.335739891516;18582.721259181395;18603;18986.335478258196;19072.904635476734;50769.984600308526;50897.49102508927;51895.2215716757;53649.463505364445;53709;76498.61750691211;77338.22661773536;78598.6070069646;78698.31064359593;80316;8259.95870020646;8333.125021872616;8446.788830279293;8588.141185881363;8808.955955220183;11725;13367.66580835448;13410.463581457023;13704.383302751201;13836.654083647587;8299.336053115858;8530.488170709777;8740.21338079576;11716.94141529287;11914.821277680669;7953.8409231816195;8558.700445484626;8580.785480363042;8627.180417860292;8802.559872006246;8601.870971935301;8623.094575069528;8780.03419623828;8858.689945851864;9269.212116969864;12134.33261170644;12142.028637708785;12178.57374991871;12380.504779809067;12547.435365408395;11694.415279236175;11725.941370293094;11961.162718609961;12185.268883866996;12321.01431885465 10:32:48 INFO - PROCESS | 1662 | |3;mootools.html;1514.000759498731;1669.8998060116392;1712.1610410898659;2088.383926741611;2136.3377353020555;8350.457220280685;9003;9166.99999999999;9176.908230917705;9199.63201471942;8750.299976001921;9020.188183063523;9024.548772561362;9045.592948317326;9055.320850936174;2570.2160840943507;2592.131635901975;2596.1302963507246;2600.505903878257;2605.374710069579;2512.484940587175;2540.9328082205516;2613.869306534675;2614.1765343916604;2617.5942728876958;2339.391758142878;2581.1998280533094;2617.5550156473446;2621.3970786719065;2625.1074634624224;2577.9226623201334;2595.338188761863;2607.804414668898;2622.763951244397;2626.9737302626922;2570.8586027768465;2602.9479410411686;2615.8953641854305;2620.227033025243;2623.7507436793667;9113.043130471271;9148.634054637807;9172.587233574504;9177.265818734486;9217.893852737714;5630.408807075239;5790.565707571949;5798.246227990377;5798.362180160179;5802.65184088956;3643.927121457556;3648.6351364863567;3684.871029513954;3816.9045773855596;3819.1788765415567;1067.6103222323795;1090.9454527273683;1091.061686949223;1106.5186643809968;1130.2822707580663;12371.566995155126;12380.504779808796;12411.875881241253;12417.62747117588;12463.937680311541;4984.975075124601;5000.349954505891;5084.2627818966785;5090.694558326512;5097.08252514551;10427.11369533583;10445.216608754374;10457.215708821868;10464.843027354596;10481.947590262;5671.602987790898;5716.399778023331;5720.542356611461;5723.656580605177;5734.39788822176;4231.555686652857;4606.861794146181;4780.784864681098;5115.258287548285;5155.38135423744;4046.7167298288837;4087.6116768906904;4095.1604920991126;4149.730267532601;4154.376843473503;1358.517726207202;1375.9518416855362;1377.1668140774887;1380.5858242527202;1385.452746165259;1365.7268546290782;1401.8528054554124;1422.9857701423061;1425.6578421178842;1427.47183542088;8424.031236407769;8551.273141783018;8558;8558.700445484377;8564.100769419121;525.6740820691195;535.4404647143745;537.5994883811585;540.5918531508686;544.5480251391335;6257.937420625735;6324.9051264231075;6342.492600592034;6350.523710721714;6351.174347334817;10691.83962240567;11024.062954648783;11087.944560277147;11218;11237.494312755945;10595.894041059644;10918.836217456745;11030.117590592734;11049.392283424328;11076.280041797258;8592.570371481526;8621.655133794704;8662.22040016389;8676.392652514263;8684.78288042804;8035.316998054997;8109.148539403278;8150.388720846079;8201;8203.687410014369;8427.789305267417;9501.287403444907;9700.75748106303;9730.270229732656;9819.9018009819;9993.300468967393;10276.332038417479;10301.484925753832;10441.112505436819;10493.790124197625;7556.65995030236;7702.653380597774;7749.690012399441;7805.141434442094;7829.177936316605;8554.401191916506;8557.44376615518;8590;8611.741647750578;8620.82758344817;7426.554406735613;7579.886301705368;7663.27198916102;7705.460617756703;7724.1117271514495;7376.668049937658;7509.924900751141;7524.811879702832;7620.580868052089;7660.310572048543;8003.439759217032;8074.1522140176785;8085.555294458626;8087.8786818196595;8089.069756978023;7298.197198308076;7309.597972111585;7360.668769905475;7391.152211947013;7398.223186565333;7374.815629609088;7399;7430.517016393917;7443.590602516913;7459.179490256176 10:32:48 INFO - PROCESS | 1662 | |4;prototype.html;277.7833290033774;333.83475179785995;338.3199768465384;340.8636545381847;343.03948942959704;6724.7310107595695;6762.459003279738;6804.047433359321;6804.557703749253;6810.863782724343;6707.396334329909;6712.664366781653;6731.8653626927435;6734.528582999192;6746.987951807219;4155.376693495969;4863.197572400567;5015.348004759376;5074.188129899217;5089.058524173021;5040.647154699154;5042.672226305297;5058.494150584949;5070.74646267687;5073.695578265298;4996.075725990685;5010.72441015744;5016.423111342187;5020.146575082226;5031.471695471978;4778.880527986811;4832.4684284729;4867.661393116886;4882.194437917739;4956.925646115311;4273.978630106861;4283.764392958386;4286.271333873218;4290.635295999844;4312.978435107804;6447.838804029937;6464.41820236181;6467.611943283418;6480.546361754679;6481.805545833632;5905.320888097838;5909.8227053188475;5931.614445061057;5935.673537955411;5953.851153721148;6792.0830687857;7112.857742845166;7116.715331386738;7120.430365570794;7124.786256412316;4610.838620648295;4645.651576131803;4653.906921861578;4663.463701674317;4667.579917807414;7410.407167426593;7501.699932002659;7522.3229909307875;7534.886976695354;7541.283578060075;3974.7813870237414;4708.976455117702;4717.292406139107;4720.433547974197;4722.268048452495;4779.928301075487;4789.616830653539;4791.856244312607;4797.712137271775;4799.928001079987;4769.809207631725;5756.539476841926;5762.4525670061275;5767.942320576824;5778.451047150514;5895.882082358329;7041.436685065182;7140.500164988505;7170.784876453715;7172.605506697182;1634.5096471058873;1674.1545519512567;1677.4632117722213;1677.8489935905584;1687.7637130801697;1044.806710758512;1051.8685164354456;1063.8989296016866;1070.7002039428971;1080.1682704317632;5590.944090559124;6726.192856857208;6752.561083529555;6760.628165450849;6777.830554236085;5412.161115027177;5812.866491034292;7229.349358557755;7306.8173295666975;7465.029546158965;6580.80257592273;6802.183737951477;6802.965985170043;6805.557638753564;6810.250872404032;3883.2233553289457;3909.9609003909595;3919.8040097994985;3921.156951255494;3925.2149570085526;7513.323800857949;7746.109197442366;7763.92236077632;7786.377089832799;7787.727429539939;7614.162442131361;7652.808679782938;7657.310842024244;7668.923310766821;7674.462787604925;6147.72335244915;7709.959155514046;7796.103448103428;7801.1808760079375;7820.491668041559;7179.748708795167;7477.70089196426;7489;7490.70037198506;7500.174980752004;7299.160596531467;7333.523320984119;7334.779956601311;7363.447741419308;7368.115826100902;7782.455228133977;7813.3749300057;7823.217678232131;7829.491083079582;7835.333996610352;4705.7411842349;4749.762511874462;4750.643701722453;4759.881002974815;4766.428028636586;6070.605410648293;7171.820704482429;7426.92573074284;7427.180340816319;7435.8884616731875;5919.294161141816;7085.256048114874;7188.676509557187;7202.927970720435;7230.927690723025;7112.182099058675;7142.678579463833;7154.712151812516;7165.749198778018;7174.390176835028;6983.336583024605;7005.544639598614;7017.403520700797;7040;7046.26014268515;6185.969070154801;6902.516823822284;7178.102737157856;7225.891611625725;7231.5299505531975;6747.122874026345;6871.656417179221;6877.346652068046;7023.754168604074;7037.577745335297 10:32:48 INFO - PROCESS | 1662 | |5;yui.html;793.3771988988641;808.2725547007692;810.2545657994644;815.7756616930343;820.7291593774055;14914.17972011539;15064.39742410305;15277.618059548517;15399.615009624766;15492.457763978264;11399.658010259705;14852.257387130654;14884.404623815035;14912.701745965074;15375.077495350286;794.3645083932873;817.5544328341068;981.2101258486915;1005.3465247589089;1007.3804610164769;984.9753756156082;987.3088837813523;987.9654212102578;988.4711679251602;990.5443495991852;840.2353857989231;1049.979000419995;1054.984175237372;1056.4031322302912;1059.0838924330476;1023.1456733627393;1038.242083279203;1038.2835843268197;1038.600138946511;1039.3348257115451;691.3294104718415;744.9180590135081;764.8049747314454;768.3046842607394;774.3069952392577;15641.921790391089;15729.606759830982;15730.606734831721;15768;15809.209539522977;13093.148945318619;13304.733905321937;13528;13547.59357219285;13636.659083522893;10307.175425965905;10404.895951040544;10468.267221294436;10659.733506662396;10962.232643714942;3582.0686621478344;3591.9281614367565;3642.653947874948;3680.4479328100733;3857.035741064734;84092;87438;88940.55529722439;90879.18241635131;91247.08752912452;8681.175288347724;9865.802683946424;9906.851397229048;9951.800963980824;10166.542505587266;22713.432164195696;22910;22918.541629167325;22970.310890673307;22973;7830.725924592612;7887.84224315522;7932.444728869039;7977.082635496876;8146.266835984789;4318.093200427883;4374.103308821684;4384.430024096847;4459.308807134899;4684.203685373494;3658.70730341572;3797.525309336333;3831.635994580566;3861.67175790061;3864.8067596620617;694.187800273681;700.2017699822206;703.1210986267166;703.7466512055656;704.844934114494;587.8877253610933;588.6703446070129;589.7051474262869;595.967221802805;600.8133935477484;8008.879866802003;8030.879536806952;8152.184781521801;8184.54984975832;8356.247937685637;524.0357741755189;556.3046192259675;571.2915984179671;599.6312267955263;618.1932577985682;3395.6943875051365;3783.7162212834146;3841.4814000110186;3964.60353964607;3966.211903622143;92384.07615923889;94311;94488;95993.04006959981;96869.51565242269;81831.95420114425;82327.58836205781;84724.99999999876;84757;85629.57185214035;72331;73243.33783310813;75171;75788.62105689326;76157.61921190358;7603.657835397531;7733.7679869604;7826.373890088666;7877.291043806085;8081.313088387553;49487;50740.49259507358;52243;52272.47727522676;52726.2091068642;71379;71707.64146179236;72217.6389118051;73091;74122.25877741369;10011;10025.097741203326;10197.541110650187;10208.387496750218;10296.330738501973;10675.57297708083;11270.605528806453;11281.661550153509;11287.774244515227;11539.07687385024;9921.851172232278;10039.895611482585;10196.235282354002;10310.123639490726;10513.78972420532;10376.866061175657;10591.417472039111;10619.30974486656;10647.041766240765;10723.94638026805;10206.438645874548;10354.482275886327;10367.585296588051;10464.267501274837;10565.366078035342;8909.643614255358;9131.086891310815;9146.48471670296;9202.953985230031;9349.439033658002;8749.343799214957;8795.428297160664;8877.378583499092;8944.016158222461;9027.548622568715 10:32:48 INFO - PROCESS | 1662 | __end_tp_report 10:32:48 INFO - PROCESS | 1662 | __start_cc_report 10:32:48 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1123 10:32:48 INFO - PROCESS | 1662 | __end_cc_report 10:32:48 INFO - PROCESS | 1662 | __startTimestamp1461951168769__endTimestamp 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | ------- Summary: start ------- 10:32:48 INFO - PROCESS | 1662 | Number of tests: 6 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5875.93 Median:6104.21 stddev:609.98 (10.0%) stddev-sans-first:584.89 10:32:48 INFO - PROCESS | 1662 | Values: 3589.4 3644.7 3652.6 3699.5 3699.8 6010.3 6035.2 6037.1 6050.6 6053.4 6039.0 6072.0 6081.4 6088.0 6121.4 5288.7 5377.2 5406.0 5464.7 5489.5 5463.3 5490.2 5493.0 5496.8 5496.9 5411.9 5429.2 5478.2 5481.1 5483.0 5476.4 5477.0 5500.8 5512.7 5518.9 5247.9 5331.6 5446.3 5448.4 5456.7 4848.9 5881.1 5898.0 5901.4 5958.6 6134.9 6228.5 6251.2 6376.5 6386.9 6188.3 6208.5 6213.8 6226.8 6228.2 5881.0 5916.4 5961.6 6065.4 6101.8 5452.0 6396.5 6405.0 6407.7 6428.6 6118.5 6153.0 6231.7 6253.8 6262.7 6198.3 6263.2 6305.7 6357.9 6364.9 6199.8 6201.0 6213.5 6224.0 6226.0 6085.2 6148.1 6210.6 6271.1 6274.8 4989.9 4999.1 5001.1 5002.7 5009.4 4488.8 4511.8 4512.2 4530.5 4558.1 6019.8 6033.4 6035.0 6053.2 6056.8 6182.9 6203.1 6218.6 6255.2 6333.5 6027.7 6034.4 6062.8 6066.2 6104.2 5502.5 5523.1 5523.4 5525.0 5526.2 6371.8 6494.0 6520.4 6581.7 6581.9 5340.8 6299.8 6350.3 6362.9 6372.5 6544.5 6562.0 6564.3 6566.7 6574.0 6150.8 6174.9 6190.8 6249.1 6249.4 6252.1 6277.9 6279.1 6287.7 6318.5 6079.9 6250.3 6251.0 6259.6 6260.1 5258.2 6142.6 6172.7 6205.6 6251.4 6196.3 6201.3 6201.6 6204.6 6212.4 5294.7 6297.3 6310.0 6313.4 6324.2 5611.3 5936.3 6056.4 6135.7 6141.3 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59875.73 Median:33444.08 stddev:119887.09 (358.5%) stddev-sans-first:120140.57 10:32:48 INFO - PROCESS | 1662 | Values: 517.5 534.3 596.7 619.8 667.5 32054.4 32730.7 32736.7 32746.0 32795.8 42526.0 42600.4 42657.1 42662.6 42736.6 9877.1 10091.0 10091.2 10095.6 10109.3 9894.6 10041.2 10059.0 10059.8 10069.7 9991.9 10102.1 10111.4 10116.8 10118.5 10003.3 10083.3 10087.9 10091.2 10092.6 9984.0 10146.5 10222.3 10250.7 10252.9 39877.8 40420.0 43108.8 43531.6 43584.0 3464.7 3585.6 3593.8 4034.1 4063.3 29776.0 30608.6 30912.0 31021.1 31095.5 2844.2 2850.1 2860.9 2864.3 2885.6 484893.0 484930.0 485003.0 485707.0 486609.0 47723.0 67088.7 67340.3 67564.7 67832.0 47032.5 47195.0 47226.8 47323.0 47429.8 16931.7 17314.5 17340.9 17347.7 17376.7 14029.5 14035.2 14071.5 14114.9 14122.9 15099.8 15258.8 15537.8 15576.4 15681.8 6504.4 6615.7 6656.4 6659.0 6666.8 994.4 1124.3 1168.7 1178.8 1189.2 31147.5 31347.9 31360.4 31825.7 31911.9 1117.6 1161.7 1234.9 1251.4 1303.7 15786.4 15989.7 15990.0 16100.3 16186.9 516770.0 520363.0 524812.0 524837.0 526275.0 62641.7 63208.4 63212.7 63246.7 63269.7 1405.4 1419.8 1494.8 1512.4 1546.3 29631.3 29707.9 29810.6 30298.5 30476.1 47890.8 48226.8 48247.5 48253.8 48287.0 319022.0 320614.0 321176.0 321431.0 321476.0 34171.8 36261.8 36311.8 36314.3 36451.6 47339.8 47841.0 49210.8 49840.0 49868.3 38776.0 39759.0 39770.0 40502.0 40604.2 38761.8 39293.6 39599.8 39964.0 40258.6 38741.0 39413.4 40052.4 40108.8 40181.2 31503.7 34092.3 34813.3 34820.0 34953.3 26253.9 26258.2 26283.7 26549.5 26723.0 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:38560.91 Median:22174.22 stddev:114271.98 (515.3%) stddev-sans-first:114556.56 10:32:48 INFO - PROCESS | 1662 | Values: 370.6 372.2 373.1 378.7 378.8 20295.6 21338.8 21685.3 22595.2 22597.7 21790.7 21897.9 22075.6 22171.6 22176.9 5588.3 5731.4 5876.4 5905.8 5910.0 5968.1 6009.5 6013.4 6022.9 6023.5 5911.9 5944.6 6163.5 6173.4 6185.0 6096.6 6102.4 6134.3 6138.4 6140.6 5315.6 5608.8 5610.0 5611.4 5612.0 13707.8 13918.7 14229.1 14249.4 14277.1 2166.0 2230.3 2237.9 2348.8 2411.0 15745.2 15924.9 16147.3 16969.7 17087.3 1938.3 2022.6 2047.3 2089.6 2151.4 118221.4 120153.8 124308.4 132178.3 133329.0 14489.0 16721.7 20393.0 20516.0 20673.0 30935.2 30987.8 31781.2 31782.5 31882.0 10256.6 11732.9 11739.0 11791.6 11856.9 9963.8 10002.2 10071.7 10092.7 10109.8 8965.7 9015.5 9079.9 9095.3 9119.0 3106.8 3535.9 3596.5 3620.0 3683.6 936.6 970.0 1081.9 1094.7 1099.6 17121.3 20198.4 20509.5 21168.5 21293.0 1000.8 1027.3 1029.9 1052.1 1086.1 9179.0 10670.7 11231.2 11232.5 11268.0 654083.0 687414.0 696786.0 701851.0 707466.0 122379.0 124010.0 125171.0 125976.0 127256.4 1054.3 1063.4 1076.1 1078.0 1078.1 14761.3 18582.7 18603.0 18986.3 19072.9 50770.0 50897.5 51895.2 53649.5 53709.0 76498.6 77338.2 78598.6 78698.3 80316.0 8260.0 8333.1 8446.8 8588.1 8809.0 11725.0 13367.7 13410.5 13704.4 13836.7 8299.3 8530.5 8740.2 11716.9 11914.8 7953.8 8558.7 8580.8 8627.2 8802.6 8601.9 8623.1 8780.0 8858.7 9269.2 12134.3 12142.0 12178.6 12380.5 12547.4 11694.4 11725.9 11961.2 12185.3 12321.0 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6277.56 Median:536.52 stddev:3304.88 (616.0%) stddev-sans-first:3294.76 10:32:48 INFO - PROCESS | 1662 | Values: 1514.0 1669.9 1712.2 2088.4 2136.3 8350.5 9003.0 9167.0 9176.9 9199.6 8750.3 9020.2 9024.5 9045.6 9055.3 2570.2 2592.1 2596.1 2600.5 2605.4 2512.5 2540.9 2613.9 2614.2 2617.6 2339.4 2581.2 2617.6 2621.4 2625.1 2577.9 2595.3 2607.8 2622.8 2627.0 2570.9 2602.9 2615.9 2620.2 2623.8 9113.0 9148.6 9172.6 9177.3 9217.9 5630.4 5790.6 5798.2 5798.4 5802.7 3643.9 3648.6 3684.9 3816.9 3819.2 1067.6 1090.9 1091.1 1106.5 1130.3 12371.6 12380.5 12411.9 12417.6 12463.9 4985.0 5000.3 5084.3 5090.7 5097.1 10427.1 10445.2 10457.2 10464.8 10481.9 5671.6 5716.4 5720.5 5723.7 5734.4 4231.6 4606.9 4780.8 5115.3 5155.4 4046.7 4087.6 4095.2 4149.7 4154.4 1358.5 1376.0 1377.2 1380.6 1385.5 1365.7 1401.9 1423.0 1425.7 1427.5 8424.0 8551.3 8558.0 8558.7 8564.1 525.7 535.4 537.6 540.6 544.5 6257.9 6324.9 6342.5 6350.5 6351.2 10691.8 11024.1 11087.9 11218.0 11237.5 10595.9 10918.8 11030.1 11049.4 11076.3 8592.6 8621.7 8662.2 8676.4 8684.8 8035.3 8109.1 8150.4 8201.0 8203.7 8427.8 9501.3 9700.8 9730.3 9819.9 9993.3 10276.3 10301.5 10441.1 10493.8 7556.7 7702.7 7749.7 7805.1 7829.2 8554.4 8557.4 8590.0 8611.7 8620.8 7426.6 7579.9 7663.3 7705.5 7724.1 7376.7 7509.9 7524.8 7620.6 7660.3 8003.4 8074.2 8085.6 8087.9 8089.1 7298.2 7309.6 7360.7 7391.2 7398.2 7374.8 7399.0 7430.5 7443.6 7459.2 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5836.05 Median:6718.70 stddev:1860.11 (27.7%) stddev-sans-first:1817.95 10:32:48 INFO - PROCESS | 1662 | Values: 277.8 333.8 338.3 340.9 343.0 6724.7 6762.5 6804.0 6804.6 6810.9 6707.4 6712.7 6731.9 6734.5 6747.0 4155.4 4863.2 5015.3 5074.2 5089.1 5040.6 5042.7 5058.5 5070.7 5073.7 4996.1 5010.7 5016.4 5020.1 5031.5 4778.9 4832.5 4867.7 4882.2 4956.9 4274.0 4283.8 4286.3 4290.6 4313.0 6447.8 6464.4 6467.6 6480.5 6481.8 5905.3 5909.8 5931.6 5935.7 5953.9 6792.1 7112.9 7116.7 7120.4 7124.8 4610.8 4645.7 4653.9 4663.5 4667.6 7410.4 7501.7 7522.3 7534.9 7541.3 3974.8 4709.0 4717.3 4720.4 4722.3 4779.9 4789.6 4791.9 4797.7 4799.9 4769.8 5756.5 5762.5 5767.9 5778.5 5895.9 7041.4 7140.5 7170.8 7172.6 1634.5 1674.2 1677.5 1677.8 1687.8 1044.8 1051.9 1063.9 1070.7 1080.2 5590.9 6726.2 6752.6 6760.6 6777.8 5412.2 5812.9 7229.3 7306.8 7465.0 6580.8 6802.2 6803.0 6805.6 6810.3 3883.2 3910.0 3919.8 3921.2 3925.2 7513.3 7746.1 7763.9 7786.4 7787.7 7614.2 7652.8 7657.3 7668.9 7674.5 6147.7 7710.0 7796.1 7801.2 7820.5 7179.7 7477.7 7489.0 7490.7 7500.2 7299.2 7333.5 7334.8 7363.4 7368.1 7782.5 7813.4 7823.2 7829.5 7835.3 4705.7 4749.8 4750.6 4759.9 4766.4 6070.6 7171.8 7426.9 7427.2 7435.9 5919.3 7085.3 7188.7 7202.9 7230.9 7112.2 7142.7 7154.7 7165.7 7174.4 6983.3 7005.5 7017.4 7040.0 7046.3 6186.0 6902.5 7178.1 7225.9 7231.5 6747.1 6871.7 6877.3 7023.8 7037.6 10:32:48 INFO - PROCESS | 1662 | 10:32:48 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19031.79 Median:26625.12 stddev:27395.42 (102.9%) stddev-sans-first:27438.04 10:32:48 INFO - PROCESS | 1662 | Values: 793.4 808.3 810.3 815.8 820.7 14914.2 15064.4 15277.6 15399.6 15492.5 11399.7 14852.3 14884.4 14912.7 15375.1 794.4 817.6 981.2 1005.3 1007.4 985.0 987.3 988.0 988.5 990.5 840.2 1050.0 1055.0 1056.4 1059.1 1023.1 1038.2 1038.3 1038.6 1039.3 691.3 744.9 764.8 768.3 774.3 15641.9 15729.6 15730.6 15768.0 15809.2 13093.1 13304.7 13528.0 13547.6 13636.7 10307.2 10404.9 10468.3 10659.7 10962.2 3582.1 3591.9 3642.7 3680.4 3857.0 84092.0 87438.0 88940.6 90879.2 91247.1 8681.2 9865.8 9906.9 9951.8 10166.5 22713.4 22910.0 22918.5 22970.3 22973.0 7830.7 7887.8 7932.4 7977.1 8146.3 4318.1 4374.1 4384.4 4459.3 4684.2 3658.7 3797.5 3831.6 3861.7 3864.8 694.2 700.2 703.1 703.7 704.8 587.9 588.7 589.7 596.0 600.8 8008.9 8030.9 8152.2 8184.5 8356.2 524.0 556.3 571.3 599.6 618.2 3395.7 3783.7 3841.5 3964.6 3966.2 92384.1 94311.0 94488.0 95993.0 96869.5 81832.0 82327.6 84725.0 84757.0 85629.6 72331.0 73243.3 75171.0 75788.6 76157.6 7603.7 7733.8 7826.4 7877.3 8081.3 49487.0 50740.5 52243.0 52272.5 52726.2 71379.0 71707.6 72217.6 73091.0 74122.3 10011.0 10025.1 10197.5 10208.4 10296.3 10675.6 11270.6 11281.7 11287.8 11539.1 9921.9 10039.9 10196.2 10310.1 10513.8 10376.9 10591.4 10619.3 10647.0 10723.9 10206.4 10354.5 10367.6 10464.3 10565.4 8909.6 9131.1 9146.5 9203.0 9349.4 8749.3 8795.4 8877.4 8944.0 9027.5 10:32:48 INFO - PROCESS | 1662 | -------- Summary: end -------- 10:32:48 INFO - PROCESS | 1662 | 10:32:49 INFO - TEST-INFO | 1662: exit 0 10:32:49 INFO - TEST-OK | dromaeo_css | took 1111898ms 10:32:49 INFO - TEST-START | kraken 10:32:49 INFO - operating with platform_type : mac_ 10:32:49 INFO - Initialising browser for kraken test... 10:32:49 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpptZ5_M/profile http://localhost:49275/getInfo.html) 10:32:51 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 10:32:51 INFO - PROCESS | 1673 | colorDepth:24 10:32:51 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 10:32:51 INFO - PROCESS | 1673 | __metrics 10:32:51 INFO - PROCESS | 1673 | 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:32:51 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:52 INFO - TEST-INFO | 1673: exit 0 10:32:52 INFO - Browser initialized. 10:32:52 INFO - Running cycle 1/1 for kraken test... 10:32:52 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpptZ5_M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:03 INFO - PROCESS | 1676 | RSS: Main: 157102080 10:33:03 INFO - PROCESS | 1676 | 10:33:06 INFO - PROCESS | 1676 | 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:33:07 INFO - PROCESS | 1676 | RSS: Main: 213233664 10:33:07 INFO - PROCESS | 1676 | 10:33:09 INFO - PROCESS | 1676 | 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:33:10 INFO - PROCESS | 1676 | RSS: Main: 223137792 10:33:10 INFO - PROCESS | 1676 | 10:33:13 INFO - PROCESS | 1676 | 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:33:13 INFO - PROCESS | 1676 | RSS: Main: 213127168 10:33:13 INFO - PROCESS | 1676 | 10:33:15 INFO - PROCESS | 1676 | 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:33:16 INFO - PROCESS | 1676 | RSS: Main: 215171072 10:33:16 INFO - PROCESS | 1676 | 10:33:18 INFO - PROCESS | 1676 | 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:33:19 INFO - PROCESS | 1676 | RSS: Main: 214831104 10:33:19 INFO - PROCESS | 1676 | 10:33:22 INFO - PROCESS | 1676 | 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:33:22 INFO - PROCESS | 1676 | RSS: Main: 215285760 10:33:22 INFO - PROCESS | 1676 | 10:33:25 INFO - PROCESS | 1676 | 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:33:26 INFO - PROCESS | 1676 | RSS: Main: 215203840 10:33:26 INFO - PROCESS | 1676 | 10:33:29 INFO - PROCESS | 1676 | 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:33:29 INFO - PROCESS | 1676 | RSS: Main: 215670784 10:33:29 INFO - PROCESS | 1676 | 10:33:31 INFO - PROCESS | 1676 | 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:33:31 INFO - PROCESS | 1676 | RSS: Main: 249065472 10:33:31 INFO - PROCESS | 1676 | 10:33:33 INFO - PROCESS | 1676 | 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:33:34 INFO - PROCESS | 1676 | RSS: Main: 249380864 10:33:34 INFO - PROCESS | 1676 | 10:33:36 INFO - PROCESS | 1676 | 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:33:36 INFO - PROCESS | 1676 | RSS: Main: 254906368 10:33:36 INFO - PROCESS | 1676 | 10:33:39 INFO - PROCESS | 1676 | 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:33:39 INFO - PROCESS | 1676 | RSS: Main: 256344064 10:33:39 INFO - PROCESS | 1676 | 10:33:42 INFO - PROCESS | 1676 | 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:33:43 INFO - PROCESS | 1676 | RSS: Main: 256557056 10:33:43 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | 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:33:44 INFO - PROCESS | 1676 | RSS: Main: 319102976 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | __start_tp_report 10:33:44 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 10:33:44 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 10:33:44 INFO - PROCESS | 1676 | |i|pagename|runs| 10:33:44 INFO - PROCESS | 1676 | |0;ai-astar;111;109;111;111;111;111;120;111;109;110 10:33:44 INFO - PROCESS | 1676 | |1;audio-beat-detection;152;122;143;156;117;136;117;151;150;118 10:33:44 INFO - PROCESS | 1676 | |2;audio-dft;182;184;182;186;185;181;183;184;181;185 10:33:44 INFO - PROCESS | 1676 | |3;audio-fft;73;78;72;114;55;60;79;77;143;55 10:33:44 INFO - PROCESS | 1676 | |4;audio-oscillator;87;94;128;77;79;83;115;101;111;147 10:33:44 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;93;89;92;88;91;94;130;118;92;88 10:33:44 INFO - PROCESS | 1676 | |6;imaging-darkroom;95;96;96;95;95;96;96;96;95;117 10:33:44 INFO - PROCESS | 1676 | |7;imaging-desaturate;85;97;131;130;87;85;85;85;84;85 10:33:44 INFO - PROCESS | 1676 | |8;json-parse-financial;54;57;56;56;56;56;56;66;54;51 10:33:44 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;60;61;71;76;69;66;66;65;64;66 10:33:44 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;80;80;80;80;80;79;78;81;82;84 10:33:44 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;120;117;137;128;122;117;114;117;116;128 10:33:44 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;134;122;132;155;161;138;135;132;133;131 10:33:44 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;65;65;64;65;67;65;64;66;66;64 10:33:44 INFO - PROCESS | 1676 | __end_tp_report 10:33:44 INFO - PROCESS | 1676 | __start_cc_report 10:33:44 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1205 10:33:44 INFO - PROCESS | 1676 | __end_cc_report 10:33:44 INFO - PROCESS | 1676 | __startTimestamp1461951224955__endTimestamp 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | ------- Summary: start ------- 10:33:44 INFO - PROCESS | 1676 | Number of tests: 14 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:3.32 10:33:44 INFO - PROCESS | 1676 | Values: 111.0 109.0 111.0 111.0 111.0 111.0 120.0 111.0 109.0 110.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:146.50 stddev:16.22 (11.1%) stddev-sans-first:16.16 10:33:44 INFO - PROCESS | 1676 | Values: 152.0 122.0 143.0 156.0 117.0 136.0 117.0 151.0 150.0 118.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.77 (1.0%) stddev-sans-first:1.81 10:33:44 INFO - PROCESS | 1676 | Values: 182.0 184.0 182.0 186.0 185.0 181.0 183.0 184.0 181.0 185.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:27.69 (38.2%) stddev-sans-first:29.23 10:33:44 INFO - PROCESS | 1676 | Values: 73.0 78.0 72.0 114.0 55.0 60.0 79.0 77.0 143.0 55.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:78.00 stddev:22.99 (29.5%) stddev-sans-first:23.71 10:33:44 INFO - PROCESS | 1676 | Values: 87.0 94.0 128.0 77.0 79.0 83.0 115.0 101.0 111.0 147.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:91.50 stddev:14.39 (15.7%) stddev-sans-first:15.17 10:33:44 INFO - PROCESS | 1676 | Values: 93.0 89.0 92.0 88.0 91.0 94.0 130.0 118.0 92.0 88.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:96.00 stddev:6.80 (7.1%) stddev-sans-first:7.14 10:33:44 INFO - PROCESS | 1676 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 117.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:85.00 stddev:18.88 (22.2%) stddev-sans-first:19.65 10:33:44 INFO - PROCESS | 1676 | Values: 85.0 97.0 131.0 130.0 87.0 85.0 85.0 85.0 84.0 85.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.85 (6.9%) stddev-sans-first:4.00 10:33:44 INFO - PROCESS | 1676 | Values: 54.0 57.0 56.0 56.0 56.0 56.0 56.0 66.0 54.0 51.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:4.70 (7.1%) stddev-sans-first:4.37 10:33:44 INFO - PROCESS | 1676 | Values: 60.0 61.0 71.0 76.0 69.0 66.0 66.0 65.0 64.0 66.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.74 10:33:44 INFO - PROCESS | 1676 | Values: 80.0 80.0 80.0 80.0 80.0 79.0 78.0 81.0 82.0 84.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.00 stddev:7.26 (6.0%) stddev-sans-first:7.68 10:33:44 INFO - PROCESS | 1676 | Values: 120.0 117.0 137.0 128.0 122.0 117.0 114.0 117.0 116.0 128.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:134.50 stddev:11.74 (8.7%) stddev-sans-first:12.39 10:33:44 INFO - PROCESS | 1676 | Values: 134.0 122.0 132.0 155.0 161.0 138.0 135.0 132.0 133.0 131.0 10:33:44 INFO - PROCESS | 1676 | 10:33:44 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 10:33:44 INFO - PROCESS | 1676 | Values: 65.0 65.0 64.0 65.0 67.0 65.0 64.0 66.0 66.0 64.0 10:33:44 INFO - PROCESS | 1676 | -------- Summary: end -------- 10:33:44 INFO - PROCESS | 1676 | 10:33:45 INFO - TEST-INFO | 1676: exit 0 10:33:45 INFO - TEST-OK | kraken | took 56390ms 10:33:45 INFO - SUITE-END | took 1168s 10:33:46 INFO - Completed test suite (00:19:28) 10:33:46 INFO - javascript benchmark 10:33:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3589.4436362363836, 3644.7084233261344, 3652.5982141964396, 3699.5375578052744, 3699.815009249537, 6010.308814486335, 6035.18524999125, 6037.06425504047, 6050.576459647827, 6053.424924632164, 6038.969805150968, 6072.02847544393, 6081.361457047013, 6088.02017024888, 6121.449069583737, 5288.682679039251, 5377.166539186423, 5406.0, 5464.726763661821, 5489.505944464997, 5463.31708536433, 5490.176473528983, 5492.972535137319, 5496.7526461309135, 5496.945030549683, 5411.891762164754, 5429.158480435539, 5478.205660179272, 5481.095619222823, 5483.040467918118, 5476.397596264428, 5477.0, 5500.7524661390335, 5512.724363781815, 5518.91721624176, 5247.86880327991, 5331.573474122061, 5446.319210098738, 5448.42791506894, 5456.699881506515, 4848.903021939542, 5881.14723365114, 5897.970510147422, 5901.4098590141075, 5958.553108516835, 6134.865219626364, 6228.532860035515, 6251.156093927307, 6376.521760867907, 6386.904196437011, 6188.257409110935, 6208.472279856218, 6213.782517611907, 6226.844328891814, 6228.22147231596, 5880.970595146997, 5916.437938395846, 5961.552883533709, 6065.363136870653, 6101.786437474667, 5451.972740136274, 6396.488280937514, 6405.007223880306, 6407.743690252338, 6428.614283143026, 6118.541109416722, 6153.046277826855, 6231.657258850807, 6253.843653908689, 6262.749490020348, 6198.318184999646, 6263.217097862767, 6305.653189074553, 6357.936420635827, 6364.872702545923, 6199.814005579839, 6201.0, 6213.502919766408, 6224.004159334485, 6226.0, 6085.17850090241, 6148.1085242639565, 6210.627362358273, 6271.122042913996, 6274.811755647338, 4989.877277612581, 4999.075171093359, 5001.124803159432, 5002.699838009731, 5009.44896061433, 4488.820447182142, 4511.751853648081, 4512.165249428866, 4530.524294948983, 4558.133954548625, 6019.819405417845, 6033.396660333931, 6034.974054410761, 6053.243344581927, 6056.848578785478, 6182.907256391158, 6203.131561581382, 6218.595791273553, 6255.249370075529, 6333.493320534346, 6027.698615069229, 6034.366391528914, 6062.787802426894, 6066.150738896558, 6104.2064531611495, 5502.532284755841, 5523.143912693539, 5523.392426833045, 5524.977879092381, 5526.226328314039, 6371.840703982438, 6493.967530162319, 6520.445762110179, 6581.703823327962, 6581.934180658132, 5340.759665815125, 6299.811005669837, 6350.333215012357, 6362.904556431565, 6372.458341041063, 6544.476441884733, 6562.015697645392, 6564.343565643398, 6566.704498297684, 6574.0, 6150.7847225346895, 6174.938250617436, 6190.81427557174, 6249.0626406039455, 6249.437550620466, 6252.124702541739, 6277.874442511215, 6279.058141278845, 6287.717052732546, 6318.462930650946, 6079.878402431838, 6250.312465628868, 6250.968745156245, 6259.593126446766, 6260.060990851227, 5258.184981327748, 6142.560166306883, 6172.660503672161, 6205.627662340274, 6251.374862513712, 6196.287426945959, 6201.348858369806, 6201.596896201732, 6204.5967012144065, 6212.378762123933, 5294.682319060868, 6297.338779428094, 6310.0, 6313.43179113882, 6324.177856878577, 5611.270534830609, 5936.317323507679, 6056.424639659225, 6135.662538560244, 6141.301904043499], "unit": "score", "name": "dojo.html", "value": 5841.466291509736}, {"lowerIsBetter": false, "replicates": [517.4980269138933, 534.2627174499193, 596.7046312075523, 619.7768803230836, 667.542733227739, 32054.358912821728, 32730.67269327306, 32736.690532378678, 32746.017619471426, 32795.836020819894, 42526.0, 42600.3789677877, 42657.14685706284, 42662.57337426625, 42736.572634273645, 9877.11106000458, 10090.990900909923, 10091.243156763236, 10095.596176152982, 10109.342892711988, 9894.604215831358, 10041.19670426364, 10059.0, 10059.798804023914, 10069.748256293578, 9991.90008099917, 10102.14131798798, 10111.443870587114, 10116.848247276297, 10118.54466549007, 10003.349782264166, 10083.344582602143, 10087.949560252151, 10091.243156763272, 10092.646757363531, 9984.0, 10146.543405546694, 10222.284440089197, 10250.692479225636, 10252.89747102527, 39877.80061099676, 40420.0, 43108.78445607752, 43531.56468435338, 43584.0, 3464.688178063961, 3585.623509531488, 3593.784372937606, 4034.0519977805193, 4063.3498640217717, 29775.980242667178, 30608.551315894674, 30912.0, 31021.122359705038, 31095.533566996513, 2844.21784009397, 2850.144956513038, 2860.942781144386, 2864.2982469295157, 2885.581590669341, 484893.0, 484930.0, 485003.0, 485707.0, 486609.0, 47723.0, 67088.6645566769, 67340.3265967334, 67564.6621766888, 67832.0, 47032.5296747035, 47195.0, 47226.76386618045, 47323.0, 47429.76285118552, 16931.746023809654, 17314.480565583053, 17340.91329543344, 17347.698922580857, 17376.652466950844, 14029.508967186304, 14035.157890526601, 14071.507497237548, 14114.929425352808, 14122.929385353007, 15099.849001510063, 15258.771118433233, 15537.766933496006, 15576.376944922304, 15681.764773528406, 6504.414602685781, 6615.66921653925, 6656.434203092695, 6659.0, 6666.83332916681, 994.418265314799, 1124.2748427264369, 1168.696139003865, 1178.834963105166, 1189.1675826921016, 31147.532787008215, 31347.902823401073, 31360.37279254402, 31825.68174318227, 31911.883084091944, 1117.620009196877, 1161.6863446869468, 1234.8703386144325, 1251.4368534159664, 1303.7197002644477, 15786.368545258061, 15989.68020639604, 15990.0, 16100.275487603087, 16186.919065404598, 516770.0, 520363.0, 524812.0, 524837.0, 526275.0, 62641.68679156575, 63208.41978950471, 63212.683936580026, 63246.68376658087, 63269.68365158145, 1405.416752047909, 1419.7586410310273, 1494.7832564278335, 1512.4101600375861, 1546.3350759173663, 29631.25921851971, 29707.851460742557, 29810.552841706958, 30298.545521817632, 30476.085717428512, 47890.760546197045, 48226.75886620545, 48247.5175248243, 48253.75873120612, 48287.0, 319022.0, 320614.0, 321176.0, 321431.0, 321476.0, 34171.82914085413, 36261.81869090637, 36311.81844090763, 36314.273714525036, 36451.63548364482, 47339.76330118327, 47841.0, 49210.75394623004, 49840.0, 49868.25197622111, 38776.0, 39759.0, 39770.0, 40502.0, 40604.18791624092, 38761.80619096886, 39293.60706393014, 39599.80200098981, 39964.000899977735, 40258.597414026655, 38741.03147421337, 39413.408798868615, 40052.399214012396, 40108.799456003704, 40181.1963760729, 31503.68496315099, 34092.31815363629, 34813.30373392467, 34819.955401338004, 34953.300933981685, 26253.868730656224, 26258.21225363242, 26283.737162628895, 26549.469010620065, 26723.0], "unit": "score", "name": "ext.html", "value": 19977.53104406114}, {"lowerIsBetter": false, "replicates": [370.61641201356593, 372.223913141101, 373.12874438186833, 378.7386703174809, 378.79734342126966, 20295.59408811823, 21338.786612133892, 21685.3494395168, 22595.209167679135, 22597.661035084446, 21790.692558446503, 21897.890510547426, 22075.558488830215, 22171.556568868655, 22176.8891155544, 5588.3014623172, 5731.369549349568, 5876.412358764111, 5905.763769449217, 5909.9704501477645, 5968.074948383008, 6009.519238460913, 6013.398660133974, 6022.909656355158, 6023.457888790008, 5911.876743418737, 5944.613600115978, 6163.537734669895, 6173.444390004899, 6185.041318595625, 6096.573239873211, 6102.359252278514, 6134.263888333384, 6138.416850399205, 6140.631562106288, 5315.627906046579, 5608.831735047915, 5609.9902017636805, 5611.354694210137, 5612.017896868073, 13707.794383084261, 13918.721625567432, 14229.14625122496, 14249.358778854976, 14277.14337139775, 2166.0361139293022, 2230.264012875747, 2237.9104835806547, 2348.8355815092777, 2410.9879450602634, 15745.212739362985, 15924.920375398166, 16147.304533024098, 16969.66060678792, 17087.316507339816, 1938.2925232290113, 2022.646036943529, 2047.3346162497098, 2089.5879671650346, 2151.38685474639, 118221.40889295499, 120153.79846201514, 124308.37845810804, 132178.33910830482, 133329.0, 14489.0, 16721.749173762404, 20392.98035098239, 20516.0, 20672.999999999698, 30935.226619334248, 30987.845060775002, 31781.205469862976, 31782.523262151088, 31882.0, 10256.641017564349, 11732.94133529327, 11739.002184814386, 11791.646250612495, 11856.88143118575, 9963.80072398548, 10002.249831262685, 10071.748206294902, 10092.697219083439, 10109.848352274721, 8965.686200982935, 9015.549222538977, 9079.909200907907, 9095.27237820986, 9119.0, 3106.8446577671025, 3535.8585656573964, 3596.5144705464427, 3620.0089950527104, 3683.5558752566435, 936.6347124621403, 969.9757506062405, 1081.9459027048615, 1094.7027772090098, 1099.598646494024, 17121.315147394213, 20198.39404817858, 20509.487262818548, 21168.470788230108, 21293.0, 1000.8340283569705, 1027.275770581738, 1029.9227557933184, 1052.1162223732101, 1086.0768346905068, 9178.954105229432, 10670.679879603624, 11231.15766317513, 11232.49453774582, 11268.0, 654083.0, 687414.0, 696786.0, 701851.0, 707466.0, 122379.0, 124010.0, 125171.0, 125976.0, 127256.36371818082, 1054.3463052907246, 1063.3566692151292, 1076.0799516413354, 1078.0405439159154, 1078.0674716370283, 14761.335739891516, 18582.721259181395, 18603.0, 18986.335478258196, 19072.904635476734, 50769.984600308526, 50897.49102508927, 51895.2215716757, 53649.463505364445, 53709.0, 76498.61750691211, 77338.22661773536, 78598.6070069646, 78698.31064359593, 80316.0, 8259.95870020646, 8333.125021872616, 8446.788830279293, 8588.141185881363, 8808.955955220183, 11725.0, 13367.66580835448, 13410.463581457023, 13704.383302751201, 13836.654083647587, 8299.336053115858, 8530.488170709777, 8740.21338079576, 11716.94141529287, 11914.821277680669, 7953.8409231816195, 8558.700445484626, 8580.785480363042, 8627.180417860292, 8802.559872006246, 8601.870971935301, 8623.094575069528, 8780.03419623828, 8858.689945851864, 9269.212116969864, 12134.33261170644, 12142.028637708785, 12178.57374991871, 12380.504779809067, 12547.435365408395, 11694.415279236175, 11725.941370293094, 11961.162718609961, 12185.268883866996, 12321.01431885465], "unit": "score", "name": "jquery.html", "value": 10562.63121428702}, {"lowerIsBetter": false, "replicates": [1514.000759498731, 1669.8998060116392, 1712.1610410898659, 2088.383926741611, 2136.3377353020555, 8350.457220280685, 9003.0, 9166.99999999999, 9176.908230917705, 9199.63201471942, 8750.299976001921, 9020.188183063523, 9024.548772561362, 9045.592948317326, 9055.320850936174, 2570.2160840943507, 2592.131635901975, 2596.1302963507246, 2600.505903878257, 2605.374710069579, 2512.484940587175, 2540.9328082205516, 2613.869306534675, 2614.1765343916604, 2617.5942728876958, 2339.391758142878, 2581.1998280533094, 2617.5550156473446, 2621.3970786719065, 2625.1074634624224, 2577.9226623201334, 2595.338188761863, 2607.804414668898, 2622.763951244397, 2626.9737302626922, 2570.8586027768465, 2602.9479410411686, 2615.8953641854305, 2620.227033025243, 2623.7507436793667, 9113.043130471271, 9148.634054637807, 9172.587233574504, 9177.265818734486, 9217.893852737714, 5630.408807075239, 5790.565707571949, 5798.246227990377, 5798.362180160179, 5802.65184088956, 3643.927121457556, 3648.6351364863567, 3684.871029513954, 3816.9045773855596, 3819.1788765415567, 1067.6103222323795, 1090.9454527273683, 1091.061686949223, 1106.5186643809968, 1130.2822707580663, 12371.566995155126, 12380.504779808796, 12411.875881241253, 12417.62747117588, 12463.937680311541, 4984.975075124601, 5000.349954505891, 5084.2627818966785, 5090.694558326512, 5097.08252514551, 10427.11369533583, 10445.216608754374, 10457.215708821868, 10464.843027354596, 10481.947590262, 5671.602987790898, 5716.399778023331, 5720.542356611461, 5723.656580605177, 5734.39788822176, 4231.555686652857, 4606.861794146181, 4780.784864681098, 5115.258287548285, 5155.38135423744, 4046.7167298288837, 4087.6116768906904, 4095.1604920991126, 4149.730267532601, 4154.376843473503, 1358.517726207202, 1375.9518416855362, 1377.1668140774887, 1380.5858242527202, 1385.452746165259, 1365.7268546290782, 1401.8528054554124, 1422.9857701423061, 1425.6578421178842, 1427.47183542088, 8424.031236407769, 8551.273141783018, 8558.0, 8558.700445484377, 8564.100769419121, 525.6740820691195, 535.4404647143745, 537.5994883811585, 540.5918531508686, 544.5480251391335, 6257.937420625735, 6324.9051264231075, 6342.492600592034, 6350.523710721714, 6351.174347334817, 10691.83962240567, 11024.062954648783, 11087.944560277147, 11218.0, 11237.494312755945, 10595.894041059644, 10918.836217456745, 11030.117590592734, 11049.392283424328, 11076.280041797258, 8592.570371481526, 8621.655133794704, 8662.22040016389, 8676.392652514263, 8684.78288042804, 8035.316998054997, 8109.148539403278, 8150.388720846079, 8201.0, 8203.687410014369, 8427.789305267417, 9501.287403444907, 9700.75748106303, 9730.270229732656, 9819.9018009819, 9993.300468967393, 10276.332038417479, 10301.484925753832, 10441.112505436819, 10493.790124197625, 7556.65995030236, 7702.653380597774, 7749.690012399441, 7805.141434442094, 7829.177936316605, 8554.401191916506, 8557.44376615518, 8590.0, 8611.741647750578, 8620.82758344817, 7426.554406735613, 7579.886301705368, 7663.27198916102, 7705.460617756703, 7724.1117271514495, 7376.668049937658, 7509.924900751141, 7524.811879702832, 7620.580868052089, 7660.310572048543, 8003.439759217032, 8074.1522140176785, 8085.555294458626, 8087.8786818196595, 8089.069756978023, 7298.197198308076, 7309.597972111585, 7360.668769905475, 7391.152211947013, 7398.223186565333, 7374.815629609088, 7399.0, 7430.517016393917, 7443.590602516913, 7459.179490256176], "unit": "score", "name": "mootools.html", "value": 5052.328588404408}, {"lowerIsBetter": false, "replicates": [277.7833290033774, 333.83475179785995, 338.3199768465384, 340.8636545381847, 343.03948942959704, 6724.7310107595695, 6762.459003279738, 6804.047433359321, 6804.557703749253, 6810.863782724343, 6707.396334329909, 6712.664366781653, 6731.8653626927435, 6734.528582999192, 6746.987951807219, 4155.376693495969, 4863.197572400567, 5015.348004759376, 5074.188129899217, 5089.058524173021, 5040.647154699154, 5042.672226305297, 5058.494150584949, 5070.74646267687, 5073.695578265298, 4996.075725990685, 5010.72441015744, 5016.423111342187, 5020.146575082226, 5031.471695471978, 4778.880527986811, 4832.4684284729, 4867.661393116886, 4882.194437917739, 4956.925646115311, 4273.978630106861, 4283.764392958386, 4286.271333873218, 4290.635295999844, 4312.978435107804, 6447.838804029937, 6464.41820236181, 6467.611943283418, 6480.546361754679, 6481.805545833632, 5905.320888097838, 5909.8227053188475, 5931.614445061057, 5935.673537955411, 5953.851153721148, 6792.0830687857, 7112.857742845166, 7116.715331386738, 7120.430365570794, 7124.786256412316, 4610.838620648295, 4645.651576131803, 4653.906921861578, 4663.463701674317, 4667.579917807414, 7410.407167426593, 7501.699932002659, 7522.3229909307875, 7534.886976695354, 7541.283578060075, 3974.7813870237414, 4708.976455117702, 4717.292406139107, 4720.433547974197, 4722.268048452495, 4779.928301075487, 4789.616830653539, 4791.856244312607, 4797.712137271775, 4799.928001079987, 4769.809207631725, 5756.539476841926, 5762.4525670061275, 5767.942320576824, 5778.451047150514, 5895.882082358329, 7041.436685065182, 7140.500164988505, 7170.784876453715, 7172.605506697182, 1634.5096471058873, 1674.1545519512567, 1677.4632117722213, 1677.8489935905584, 1687.7637130801697, 1044.806710758512, 1051.8685164354456, 1063.8989296016866, 1070.7002039428971, 1080.1682704317632, 5590.944090559124, 6726.192856857208, 6752.561083529555, 6760.628165450849, 6777.830554236085, 5412.161115027177, 5812.866491034292, 7229.349358557755, 7306.8173295666975, 7465.029546158965, 6580.80257592273, 6802.183737951477, 6802.965985170043, 6805.557638753564, 6810.250872404032, 3883.2233553289457, 3909.9609003909595, 3919.8040097994985, 3921.156951255494, 3925.2149570085526, 7513.323800857949, 7746.109197442366, 7763.92236077632, 7786.377089832799, 7787.727429539939, 7614.162442131361, 7652.808679782938, 7657.310842024244, 7668.923310766821, 7674.462787604925, 6147.72335244915, 7709.959155514046, 7796.103448103428, 7801.1808760079375, 7820.491668041559, 7179.748708795167, 7477.70089196426, 7489.0, 7490.70037198506, 7500.174980752004, 7299.160596531467, 7333.523320984119, 7334.779956601311, 7363.447741419308, 7368.115826100902, 7782.455228133977, 7813.3749300057, 7823.217678232131, 7829.491083079582, 7835.333996610352, 4705.7411842349, 4749.762511874462, 4750.643701722453, 4759.881002974815, 4766.428028636586, 6070.605410648293, 7171.820704482429, 7426.92573074284, 7427.180340816319, 7435.8884616731875, 5919.294161141816, 7085.256048114874, 7188.676509557187, 7202.927970720435, 7230.927690723025, 7112.182099058675, 7142.678579463833, 7154.712151812516, 7165.749198778018, 7174.390176835028, 6983.336583024605, 7005.544639598614, 7017.403520700797, 7040.0, 7046.26014268515, 6185.969070154801, 6902.516823822284, 7178.102737157856, 7225.891611625725, 7231.5299505531975, 6747.122874026345, 6871.656417179221, 6877.346652068046, 7023.754168604074, 7037.577745335297], "unit": "score", "name": "prototype.html", "value": 5212.400434430369}, {"lowerIsBetter": false, "replicates": [793.3771988988641, 808.2725547007692, 810.2545657994644, 815.7756616930343, 820.7291593774055, 14914.17972011539, 15064.39742410305, 15277.618059548517, 15399.615009624766, 15492.457763978264, 11399.658010259705, 14852.257387130654, 14884.404623815035, 14912.701745965074, 15375.077495350286, 794.3645083932873, 817.5544328341068, 981.2101258486915, 1005.3465247589089, 1007.3804610164769, 984.9753756156082, 987.3088837813523, 987.9654212102578, 988.4711679251602, 990.5443495991852, 840.2353857989231, 1049.979000419995, 1054.984175237372, 1056.4031322302912, 1059.0838924330476, 1023.1456733627393, 1038.242083279203, 1038.2835843268197, 1038.600138946511, 1039.3348257115451, 691.3294104718415, 744.9180590135081, 764.8049747314454, 768.3046842607394, 774.3069952392577, 15641.921790391089, 15729.606759830982, 15730.606734831721, 15768.0, 15809.209539522977, 13093.148945318619, 13304.733905321937, 13528.0, 13547.59357219285, 13636.659083522893, 10307.175425965905, 10404.895951040544, 10468.267221294436, 10659.733506662396, 10962.232643714942, 3582.0686621478344, 3591.9281614367565, 3642.653947874948, 3680.4479328100733, 3857.035741064734, 84092.0, 87438.0, 88940.55529722439, 90879.18241635131, 91247.08752912452, 8681.175288347724, 9865.802683946424, 9906.851397229048, 9951.800963980824, 10166.542505587266, 22713.432164195696, 22910.0, 22918.541629167325, 22970.310890673307, 22973.0, 7830.725924592612, 7887.84224315522, 7932.444728869039, 7977.082635496876, 8146.266835984789, 4318.093200427883, 4374.103308821684, 4384.430024096847, 4459.308807134899, 4684.203685373494, 3658.70730341572, 3797.525309336333, 3831.635994580566, 3861.67175790061, 3864.8067596620617, 694.187800273681, 700.2017699822206, 703.1210986267166, 703.7466512055656, 704.844934114494, 587.8877253610933, 588.6703446070129, 589.7051474262869, 595.967221802805, 600.8133935477484, 8008.879866802003, 8030.879536806952, 8152.184781521801, 8184.54984975832, 8356.247937685637, 524.0357741755189, 556.3046192259675, 571.2915984179671, 599.6312267955263, 618.1932577985682, 3395.6943875051365, 3783.7162212834146, 3841.4814000110186, 3964.60353964607, 3966.211903622143, 92384.07615923889, 94311.0, 94488.0, 95993.04006959981, 96869.51565242269, 81831.95420114425, 82327.58836205781, 84724.99999999876, 84757.0, 85629.57185214035, 72331.0, 73243.33783310813, 75171.0, 75788.62105689326, 76157.61921190358, 7603.657835397531, 7733.7679869604, 7826.373890088666, 7877.291043806085, 8081.313088387553, 49487.0, 50740.49259507358, 52243.0, 52272.47727522676, 52726.2091068642, 71379.0, 71707.64146179236, 72217.6389118051, 73091.0, 74122.25877741369, 10011.0, 10025.097741203326, 10197.541110650187, 10208.387496750218, 10296.330738501973, 10675.57297708083, 11270.605528806453, 11281.661550153509, 11287.774244515227, 11539.07687385024, 9921.851172232278, 10039.895611482585, 10196.235282354002, 10310.123639490726, 10513.78972420532, 10376.866061175657, 10591.417472039111, 10619.30974486656, 10647.041766240765, 10723.94638026805, 10206.438645874548, 10354.482275886327, 10367.585296588051, 10464.267501274837, 10565.366078035342, 8909.643614255358, 9131.086891310815, 9146.48471670296, 9202.953985230031, 9349.439033658002, 8749.343799214957, 8795.428297160664, 8877.378583499092, 8944.016158222461, 9027.548622568715], "unit": "score", "name": "yui.html", "value": 7061.682312614747}], "name": "dromaeo_css", "value": 7823.204906927983}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 111.0, 111.0, 111.0, 120.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [152.0, 122.0, 143.0, 156.0, 117.0, 136.0, 117.0, 151.0, 150.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 136.2}, {"lowerIsBetter": true, "replicates": [182.0, 184.0, 182.0, 186.0, 185.0, 181.0, 183.0, 184.0, 181.0, 185.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [73.0, 78.0, 72.0, 114.0, 55.0, 60.0, 79.0, 77.0, 143.0, 55.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 128.0, 77.0, 79.0, 83.0, 115.0, 101.0, 111.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 102.2}, {"lowerIsBetter": true, "replicates": [93.0, 89.0, 92.0, 88.0, 91.0, 94.0, 130.0, 118.0, 92.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 117.0], "unit": "score", "name": "imaging-darkroom", "value": 97.7}, {"lowerIsBetter": true, "replicates": [85.0, 97.0, 131.0, 130.0, 87.0, 85.0, 85.0, 85.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 66.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 71.0, 76.0, 69.0, 66.0, 66.0, 65.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 80.0, 80.0, 80.0, 79.0, 78.0, 81.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 137.0, 128.0, 122.0, 117.0, 114.0, 117.0, 116.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [134.0, 122.0, 132.0, 155.0, 161.0, 138.0, 135.0, 132.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 67.0, 65.0, 64.0, 66.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1431.3}]} 10:33:46 INFO - Return code: 0 10:33:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:46 INFO - # TBPL SUCCESS # 10:33:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:46 INFO - 2016-04-29 10:33:46.281 screenresolution[1680:10005] starting screenresolution argv=screenresolution get 10:33:46 INFO - 2016-04-29 10:33:46.283 screenresolution[1680:10005] Display 0: 1600x1200x32@60 10:33:46 INFO - 2016-04-29 10:33:46.289 screenresolution[1681:10008] starting screenresolution argv=screenresolution list 10:33:46 INFO - Available Modes on Display 0 10:33:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:46 INFO - Intel Iris: 10:33:46 INFO - Chipset Model: Intel Iris 10:33:46 INFO - Type: GPU 10:33:46 INFO - Bus: Built-In 10:33:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:46 INFO - Vendor: Intel (0x8086) 10:33:46 INFO - Device ID: 0x0a2e 10:33:46 INFO - Revision ID: 0x0009 10:33:46 INFO - Displays: 10:33:46 INFO - Display: 10:33:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:46 INFO - Display Serial Number: 1600x1200 60 10:33:46 INFO - Main Display: Yes 10:33:46 INFO - Mirror: Off 10:33:46 INFO - Online: Yes 10:33:46 INFO - Rotation: Supported 10:33:46 INFO - Return code: 0 10:33:46 INFO - Running post-action listener: _resource_record_post_action 10:33:46 INFO - Running post-run listener: _resource_record_post_run 10:33:47 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 37705216; Write bytes: 508022784; Read time: 408; Write time: 1634 10:33:47 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200684032; Write bytes: 197949440; Read time: 18838; Write time: 428 10:33:47 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35890688; Write bytes: 299280384; Read time: 385; Write time: 1167 10:33:47 INFO - Running post-run listener: _upload_blobber_files 10:33:47 INFO - Blob upload gear active. 10:33:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:47 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:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:33:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:48 INFO - (blobuploader) - INFO - Done attempting. 10:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:49 INFO - (blobuploader) - INFO - Done attempting. 10:33:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:49 INFO - Return code: 0 10:33:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/158aa18a1e020be2fdb502430898df543210b2a39dbb78477303f944d357323fef9a1163dd62592fe1d20e10bb8a1e32ab63b8e0ba2e6c7b46bb8e0066f9f541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df513bcc56d5914404818d90d96b09af52d77df058a023289cc114fb7a9a6ae53707441d7a02cd3733b2f5d543048f862e19486f1d7be0defc3192e0a015b5dc"} 10:33:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:49 INFO - Contents: 10:33:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/158aa18a1e020be2fdb502430898df543210b2a39dbb78477303f944d357323fef9a1163dd62592fe1d20e10bb8a1e32ab63b8e0ba2e6c7b46bb8e0066f9f541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df513bcc56d5914404818d90d96b09af52d77df058a023289cc114fb7a9a6ae53707441d7a02cd3733b2f5d543048f862e19486f1d7be0defc3192e0a015b5dc"} 10:33:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:49 INFO - Copying logs to upload dir... 10:33:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.338075 ========= master_lag: 18.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-29 10:34:08.360973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-29 10:34:08.362000) ========= 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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/158aa18a1e020be2fdb502430898df543210b2a39dbb78477303f944d357323fef9a1163dd62592fe1d20e10bb8a1e32ab63b8e0ba2e6c7b46bb8e0066f9f541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df513bcc56d5914404818d90d96b09af52d77df058a023289cc114fb7a9a6ae53707441d7a02cd3733b2f5d543048f862e19486f1d7be0defc3192e0a015b5dc"} build_url:https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010995 build_url: 'https://queue.taskcluster.net/v1/task/SBgp1cVSQ5SK9Pk5XNcNVg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/158aa18a1e020be2fdb502430898df543210b2a39dbb78477303f944d357323fef9a1163dd62592fe1d20e10bb8a1e32ab63b8e0ba2e6c7b46bb8e0066f9f541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df513bcc56d5914404818d90d96b09af52d77df058a023289cc114fb7a9a6ae53707441d7a02cd3733b2f5d543048f862e19486f1d7be0defc3192e0a015b5dc"}' ========= master_lag: 2.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-29 10:34:10.730414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-29 10:34:10.730721) ========= 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.XK6Bqjl6oo/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.nSJVxG1vMr/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005047 ========= master_lag: 8.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-29 10:34:18.973694) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-29 10:34:18.974042) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-29 10:34:21.897883) ========= ========= Total master_lag: 29.29 =========