builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0074 starttime: 1461956984.72 results: success (0) buildid: 20160429101348 builduid: 201814c460594d4ba49129a13698efa5 revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.718685) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.719207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.719574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.747699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.748129) ========= 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.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:09:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.10M=0.001s 2016-04-29 12:09:44 (8.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.846324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.846683) ========= 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.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.020234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:44.895007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 12:09:44.895407) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e828b778e62c0795a1e85dd39f782b59dcebd445 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e828b778e62c0795a1e85dd39f782b59dcebd445 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:09:44,971 truncating revision to first 12 chars 2016-04-29 12:09:44,971 Setting DEBUG logging. 2016-04-29 12:09:44,971 attempt 1/10 2016-04-29 12:09:44,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e828b778e62c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 12:09:46,093 unpacking tar archive at: fx-team-e828b778e62c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 12:09:46.298009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:46.298755) ========= script_repo_revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:46.299689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:46.300378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 12:09:46.316220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-29 12:09:46.316850) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:09:46 INFO - MultiFileLogger online at 20160429 12:09:46 in /builds/slave/test 12:09:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:09:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:09:46 INFO - {'append_to_log': False, 12:09:46 INFO - 'base_work_dir': '/builds/slave/test', 12:09:46 INFO - 'blob_upload_branch': 'Fx-Team', 12:09:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:09:46 INFO - 'branch': 'Fx-Team', 12:09:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:09:46 INFO - 'config_files': ('talos/mac_config.py',), 12:09:46 INFO - 'default_actions': ('clobber', 12:09:46 INFO - 'read-buildbot-config', 12:09:46 INFO - 'download-and-extract', 12:09:46 INFO - 'populate-webroot', 12:09:46 INFO - 'create-virtualenv', 12:09:46 INFO - 'install', 12:09:46 INFO - 'run-tests'), 12:09:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:09:46 INFO - 'download_minidump_stackwalk': True, 12:09:46 INFO - 'download_symbols': 'ondemand', 12:09:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:09:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:09:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:09:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:09:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:09:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:09:46 INFO - 'installer_path': 'installer.exe', 12:09:46 INFO - 'log_level': 'info', 12:09:46 INFO - 'log_name': 'talos', 12:09:46 INFO - 'log_to_console': True, 12:09:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:09:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:09:46 INFO - 'opt_config_files': (), 12:09:46 INFO - 'pip_index': False, 12:09:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:09:46 INFO - 'cmd': ('bash', 12:09:46 INFO - '-c', 12:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:09:46 INFO - 'enabled': True, 12:09:46 INFO - 'halt_on_failure': False, 12:09:46 INFO - 'name': 'check_screen_resolution'},), 12:09:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:09:46 INFO - 'cmd': ('bash', 12:09:46 INFO - '-c', 12:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:09:46 INFO - 'enabled': True, 12:09:46 INFO - 'halt_on_failure': False, 12:09:46 INFO - 'name': 'check_screen_resolution'},), 12:09:46 INFO - 'run_cmd_checks_enabled': True, 12:09:46 INFO - 'sps_profile': False, 12:09:46 INFO - 'sps_profile_interval': 0, 12:09:46 INFO - 'suite': 'dromaeojs-e10s', 12:09:46 INFO - 'system_bits': '32', 12:09:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:09:46 INFO - 'title': 't-yosemite-r7-0074', 12:09:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:09:46 INFO - 'use_talos_json': True, 12:09:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:09:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:09:46 INFO - 'work_dir': 'build'} 12:09:46 INFO - ##### 12:09:46 INFO - ##### Running clobber step. 12:09:46 INFO - ##### 12:09:46 INFO - Running pre-action listener: _resource_record_pre_action 12:09:46 INFO - Running main action method: clobber 12:09:46 INFO - rmtree: /builds/slave/test/build 12:09:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:09:47 INFO - Running post-action listener: _resource_record_post_action 12:09:47 INFO - ##### 12:09:47 INFO - ##### Running read-buildbot-config step. 12:09:47 INFO - ##### 12:09:47 INFO - Running pre-action listener: _resource_record_pre_action 12:09:47 INFO - Running main action method: read_buildbot_config 12:09:47 INFO - Using buildbot properties: 12:09:47 INFO - { 12:09:47 INFO - "project": "", 12:09:47 INFO - "product": "firefox", 12:09:47 INFO - "script_repo_revision": "production", 12:09:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:09:47 INFO - "repository": "", 12:09:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:09:47 INFO - "buildid": "20160429101348", 12:09:47 INFO - "pgo_build": "False", 12:09:47 INFO - "basedir": "/builds/slave/test", 12:09:47 INFO - "buildnumber": 646, 12:09:47 INFO - "slavename": "t-yosemite-r7-0074", 12:09:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:09:47 INFO - "platform": "yosemite_r7", 12:09:47 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:09:47 INFO - "branch": "fx-team", 12:09:47 INFO - "repo_path": "integration/fx-team", 12:09:47 INFO - "revision": "e828b778e62c0795a1e85dd39f782b59dcebd445", 12:09:47 INFO - "stage_platform": "macosx64", 12:09:47 INFO - "builduid": "201814c460594d4ba49129a13698efa5", 12:09:47 INFO - "slavebuilddir": "test" 12:09:47 INFO - } 12:09:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 12:09:47 INFO - Running post-action listener: _resource_record_post_action 12:09:47 INFO - ##### 12:09:47 INFO - ##### Running download-and-extract step. 12:09:47 INFO - ##### 12:09:47 INFO - Running pre-action listener: _resource_record_pre_action 12:09:47 INFO - Running main action method: download_and_extract 12:09:47 INFO - mkdir: /builds/slave/test/build/tests 12:09: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')]} 12:09:47 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 12:09:49 INFO - Downloaded 1199 bytes. 12:09:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:09:49 INFO - Using the following test package requirements: 12:09:49 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:09:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 12:09:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 12:09:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'jsshell-mac.zip'], 12:09:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 12:09:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:09:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 12:09:49 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 12:09:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 12:09:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:09:49 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 12:09:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:49 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:09:50 INFO - Downloaded 18124297 bytes. 12:09:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:09:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:09:53 INFO - Return code: 0 12:09:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:09:53 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')]} 12:09:53 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:09:55 INFO - Downloaded 18124297 bytes. 12:09:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:09:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:09:58 INFO - Return code: 0 12:09:58 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')]} 12:09:58 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:10:00 INFO - Downloaded 10840145 bytes. 12:10:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:10:00 INFO - Return code: 0 12:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:00 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 12:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 12:10:03 INFO - Downloaded 110274242 bytes. 12:10:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:03 INFO - mkdir: /builds/slave/test/properties 12:10:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:10:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:10:03 INFO - Contents: 12:10:03 INFO - build_url:https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:05 INFO - Running post-action listener: _resource_record_post_action 12:10:05 INFO - Running post-action listener: set_extra_try_arguments 12:10:05 INFO - ##### 12:10:05 INFO - ##### Running populate-webroot step. 12:10:05 INFO - ##### 12:10:05 INFO - Running pre-action listener: _resource_record_pre_action 12:10:05 INFO - Running main action method: populate_webroot 12:10:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:10:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:10:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:10:05 INFO - '--tppagecycles', 12:10:05 INFO - '7'], 12:10:05 INFO - 'tests': ['tsvgm']}}, 12:10:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:10:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:10:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:10:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:10:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['damp', 'tps']}, 12:10:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'tests': ['damp', 'tps']}, 12:10:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['dromaeo_dom']}, 12:10:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:10:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'other-e10s': {'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['a11yr', 12:10:05 INFO - 'ts_paint', 12:10:05 INFO - 'tpaint', 12:10:05 INFO - 'sessionrestore', 12:10:05 INFO - 'sessionrestore_no_auto_restore', 12:10:05 INFO - 'tabpaint']}, 12:10:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['tsvgx', 12:10:05 INFO - 'tsvgr_opacity', 12:10:05 INFO - 'tart', 12:10:05 INFO - 'tscrollx', 12:10:05 INFO - 'cart']}, 12:10:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:10:05 INFO - 'tsvgr_opacity', 12:10:05 INFO - 'tart', 12:10:05 INFO - 'tscrollx', 12:10:05 INFO - 'cart']}, 12:10:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'talos_options': ['--disable-e10s'], 12:10:05 INFO - 'tests': ['tp5o']}, 12:10:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'tests': ['tp5o']}, 12:10:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'talos_options': ['--disable-e10s', 12:10:05 INFO - '--xperf_path', 12:10:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:05 INFO - 'tests': ['tp5n']}, 12:10:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:05 INFO - 'talos_options': ['--xperf_path', 12:10:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:05 INFO - 'tests': ['tp5n']}}, 12:10:05 INFO - 'talos.zip': {'path': '', 12:10:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:10:05 INFO - Running post-action listener: _resource_record_post_action 12:10:05 INFO - ##### 12:10:05 INFO - ##### Running create-virtualenv step. 12:10:05 INFO - ##### 12:10:05 INFO - Running pre-action listener: _resource_record_pre_action 12:10:05 INFO - Running main action method: create_virtualenv 12:10:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:10:05 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 12:10:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:10:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:10:05 INFO - Using real prefix '/tools/python27' 12:10:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:10:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:10:08 INFO - Installing pip.................done. 12:10:08 INFO - Return code: 0 12:10:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:10:08 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')]} 12:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:08 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')]} 12:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:08 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:08 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 12:10:08 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 12:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:08 INFO - 'HOME': '/Users/cltbld', 12:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:08 INFO - 'LOGNAME': 'cltbld', 12:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:08 INFO - 'MOZ_NO_REMOTE': '1', 12:10:08 INFO - 'NO_EM_RESTART': '1', 12:10:08 INFO - 'PAGER': '/bin/cat', 12:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:08 INFO - 'PWD': '/builds/slave/test', 12:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:08 INFO - 'SHELL': '/bin/bash', 12:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:08 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:08 INFO - 'USER': 'cltbld', 12:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:08 INFO - 'XPC_FLAGS': '0x0', 12:10:08 INFO - 'XPC_SERVICE_NAME': '0', 12:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:09 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 12:10:09 INFO - Cleaning up... 12:10:09 INFO - Return code: 0 12:10:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:09 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:09 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 12:10:09 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 12:10:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:09 INFO - 'HOME': '/Users/cltbld', 12:10:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:09 INFO - 'LOGNAME': 'cltbld', 12:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:09 INFO - 'MOZ_NO_REMOTE': '1', 12:10:09 INFO - 'NO_EM_RESTART': '1', 12:10:09 INFO - 'PAGER': '/bin/cat', 12:10:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:09 INFO - 'PWD': '/builds/slave/test', 12:10:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:09 INFO - 'SHELL': '/bin/bash', 12:10:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:09 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:09 INFO - 'USER': 'cltbld', 12:10:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:09 INFO - 'XPC_FLAGS': '0x0', 12:10:09 INFO - 'XPC_SERVICE_NAME': '0', 12:10:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:09 INFO - Downloading/unpacking psutil>=0.7.1 12:10:09 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 12:10:09 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 12:10:09 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 12:10:09 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 12:10:09 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 12:10:09 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 12:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:12 INFO - Installing collected packages: psutil 12:10:12 INFO - Running setup.py install for psutil 12:10:12 INFO - building 'psutil._psutil_osx' extension 12:10:12 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 12:10:12 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 12:10:12 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 12:10:13 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 12:10:13 INFO - building 'psutil._psutil_posix' extension 12:10:13 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 12:10:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:10:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:10:13 INFO - ^ 12:10:13 INFO - 1 warning generated. 12:10:13 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 12:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:13 INFO - Successfully installed psutil 12:10:13 INFO - Cleaning up... 12:10:13 INFO - Return code: 0 12:10:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:13 INFO - 'HOME': '/Users/cltbld', 12:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:13 INFO - 'LOGNAME': 'cltbld', 12:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:13 INFO - 'MOZ_NO_REMOTE': '1', 12:10:13 INFO - 'NO_EM_RESTART': '1', 12:10:13 INFO - 'PAGER': '/bin/cat', 12:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:13 INFO - 'PWD': '/builds/slave/test', 12:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:13 INFO - 'SHELL': '/bin/bash', 12:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:13 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:13 INFO - 'USER': 'cltbld', 12:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:13 INFO - 'XPC_FLAGS': '0x0', 12:10:13 INFO - 'XPC_SERVICE_NAME': '0', 12:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:10:16 INFO - Installing collected packages: mozsystemmonitor 12:10:16 INFO - Running setup.py install for mozsystemmonitor 12:10:16 INFO - Successfully installed mozsystemmonitor 12:10:16 INFO - Cleaning up... 12:10:16 INFO - Return code: 0 12:10:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:16 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:16 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 12:10:16 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 12:10:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:16 INFO - 'HOME': '/Users/cltbld', 12:10:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:16 INFO - 'LOGNAME': 'cltbld', 12:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:16 INFO - 'MOZ_NO_REMOTE': '1', 12:10:16 INFO - 'NO_EM_RESTART': '1', 12:10:16 INFO - 'PAGER': '/bin/cat', 12:10:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:16 INFO - 'PWD': '/builds/slave/test', 12:10:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:16 INFO - 'SHELL': '/bin/bash', 12:10:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:16 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:16 INFO - 'USER': 'cltbld', 12:10:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:16 INFO - 'XPC_FLAGS': '0x0', 12:10:16 INFO - 'XPC_SERVICE_NAME': '0', 12:10:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:16 INFO - Downloading/unpacking blobuploader==1.2.4 12:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:18 INFO - Downloading blobuploader-1.2.4.tar.gz 12:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:10:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:10:18 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 12:10:18 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 12:10:18 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 12:10:18 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 12:10:18 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 12:10:18 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 12:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:10:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:20 INFO - Downloading docopt-0.6.1.tar.gz 12:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:10:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:10:20 INFO - Running setup.py install for blobuploader 12:10:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:10:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:10:20 INFO - Running setup.py install for requests 12:10:20 INFO - Running setup.py install for docopt 12:10:20 INFO - Successfully installed blobuploader requests docopt 12:10:20 INFO - Cleaning up... 12:10:21 INFO - Return code: 0 12:10:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10: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')]} 12:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10: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')]} 12:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:21 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:21 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 12:10:21 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 12:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:21 INFO - 'HOME': '/Users/cltbld', 12:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:21 INFO - 'LOGNAME': 'cltbld', 12:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:21 INFO - 'MOZ_NO_REMOTE': '1', 12:10:21 INFO - 'NO_EM_RESTART': '1', 12:10:21 INFO - 'PAGER': '/bin/cat', 12:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:21 INFO - 'PWD': '/builds/slave/test', 12:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:21 INFO - 'SHELL': '/bin/bash', 12:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:21 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:21 INFO - 'USER': 'cltbld', 12:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:21 INFO - 'XPC_FLAGS': '0x0', 12:10:21 INFO - 'XPC_SERVICE_NAME': '0', 12:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8TeE0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GHbtNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-MFDws2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-HQQImx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ZMzSM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-gSsDLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8Or1TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XF78P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-rkLu8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ldliUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-gej0p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-u0LL0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-B5pw5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8rqgFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-YnACjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7aQ3Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:22 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6LxCf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:10:23 INFO - Running setup.py install for manifestparser 12:10:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:10:23 INFO - Running setup.py install for mozcrash 12:10:23 INFO - Running setup.py install for mozdebug 12:10:23 INFO - Running setup.py install for mozdevice 12:10:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:10:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:10:23 INFO - Running setup.py install for mozfile 12:10:23 INFO - Running setup.py install for mozhttpd 12:10:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:10:23 INFO - Running setup.py install for mozinfo 12:10:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Running setup.py install for mozInstall 12:10:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Running setup.py install for mozleak 12:10:24 INFO - Running setup.py install for mozlog 12:10:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Running setup.py install for moznetwork 12:10:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Running setup.py install for mozprocess 12:10:24 INFO - Running setup.py install for mozprofile 12:10:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:10:24 INFO - Running setup.py install for mozrunner 12:10:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:10:25 INFO - Running setup.py install for mozscreenshot 12:10:25 INFO - Running setup.py install for moztest 12:10:25 INFO - Running setup.py install for mozversion 12:10:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:10:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:10:25 INFO - Cleaning up... 12:10:25 INFO - Return code: 0 12:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10: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')]} 12:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10: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')]} 12:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:25 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:25 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 12:10:25 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 12:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:25 INFO - 'HOME': '/Users/cltbld', 12:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:25 INFO - 'LOGNAME': 'cltbld', 12:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:25 INFO - 'MOZ_NO_REMOTE': '1', 12:10:25 INFO - 'NO_EM_RESTART': '1', 12:10:25 INFO - 'PAGER': '/bin/cat', 12:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:25 INFO - 'PWD': '/builds/slave/test', 12:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:25 INFO - 'SHELL': '/bin/bash', 12:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:25 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:25 INFO - 'USER': 'cltbld', 12:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:25 INFO - 'XPC_FLAGS': '0x0', 12:10:25 INFO - 'XPC_SERVICE_NAME': '0', 12:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-JJeLDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:25 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)) 12:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-F0bc_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-X3ovlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-xdDD4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-s4AfMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-tHJs4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-DSUhR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XQu68C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-fSquAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-JVAMob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:26 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)) 12:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-KBlqKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Zk69js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-paJCNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-T4v3zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-SnWamG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-99n3Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:27 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)) 12:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:27 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-CgUwV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:27 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)) 12:10:27 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)) 12:10:27 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)) 12:10:27 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)) 12:10:27 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)) 12:10:27 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)) 12:10:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:30 INFO - Downloading blessings-1.6.tar.gz 12:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:10:30 INFO - Installing collected packages: blessings 12:10:30 INFO - Running setup.py install for blessings 12:10:30 INFO - Successfully installed blessings 12:10:30 INFO - Cleaning up... 12:10:30 INFO - Return code: 0 12:10:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:30 INFO - Reading from file tmpfile_stdout 12:10:30 INFO - Current package versions: 12:10:30 INFO - blessings == 1.6 12:10:30 INFO - blobuploader == 1.2.4 12:10:30 INFO - docopt == 0.6.1 12:10:30 INFO - manifestparser == 1.1 12:10:30 INFO - mozInstall == 1.12 12:10:30 INFO - mozcrash == 0.17 12:10:30 INFO - mozdebug == 0.1 12:10:30 INFO - mozdevice == 0.48 12:10:30 INFO - mozfile == 1.2 12:10:30 INFO - mozhttpd == 0.7 12:10:30 INFO - mozinfo == 0.9 12:10:30 INFO - mozleak == 0.1 12:10:30 INFO - mozlog == 3.1 12:10:30 INFO - moznetwork == 0.27 12:10:30 INFO - mozprocess == 0.22 12:10:30 INFO - mozprofile == 0.28 12:10:30 INFO - mozrunner == 6.11 12:10:30 INFO - mozscreenshot == 0.1 12:10:30 INFO - mozsystemmonitor == 0.0 12:10:30 INFO - moztest == 0.7 12:10:30 INFO - mozversion == 1.4 12:10:30 INFO - psutil == 3.1.1 12:10:30 INFO - requests == 1.2.3 12:10:30 INFO - wsgiref == 0.1.2 12:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 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 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:30 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 12:10:30 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 12:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:30 INFO - 'HOME': '/Users/cltbld', 12:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:30 INFO - 'LOGNAME': 'cltbld', 12:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:30 INFO - 'MOZ_NO_REMOTE': '1', 12:10:30 INFO - 'NO_EM_RESTART': '1', 12:10:30 INFO - 'PAGER': '/bin/cat', 12:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:30 INFO - 'PWD': '/builds/slave/test', 12:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:30 INFO - 'SHELL': '/bin/bash', 12:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:30 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:30 INFO - 'USER': 'cltbld', 12:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:30 INFO - 'XPC_FLAGS': '0x0', 12:10:30 INFO - 'XPC_SERVICE_NAME': '0', 12:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 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)) 12:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:10:30 INFO - Cleaning up... 12:10:30 INFO - Return code: 0 12:10:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:30 INFO - 'HOME': '/Users/cltbld', 12:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:30 INFO - 'LOGNAME': 'cltbld', 12:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:30 INFO - 'MOZ_NO_REMOTE': '1', 12:10:30 INFO - 'NO_EM_RESTART': '1', 12:10:30 INFO - 'PAGER': '/bin/cat', 12:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:30 INFO - 'PWD': '/builds/slave/test', 12:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:30 INFO - 'SHELL': '/bin/bash', 12:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:30 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:30 INFO - 'USER': 'cltbld', 12:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:30 INFO - 'XPC_FLAGS': '0x0', 12:10:30 INFO - 'XPC_SERVICE_NAME': '0', 12:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:31 INFO - Downloading/unpacking jsonschema 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:10:33 INFO - Downloading/unpacking functools32 (from jsonschema) 12:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:33 INFO - Downloading functools32-3.2.3-2.tar.gz 12:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:10:34 INFO - warning: no files found matching '*.txt' 12:10:34 INFO - no previously-included directories found matching 'build' 12:10:34 INFO - no previously-included directories found matching 'dist' 12:10:34 INFO - no previously-included directories found matching '.git*' 12:10:34 INFO - Installing collected packages: jsonschema, functools32 12:10:34 INFO - Running setup.py install for functools32 12:10:34 INFO - warning: no files found matching '*.txt' 12:10:34 INFO - no previously-included directories found matching 'build' 12:10:34 INFO - no previously-included directories found matching 'dist' 12:10:34 INFO - no previously-included directories found matching '.git*' 12:10:34 INFO - Successfully installed jsonschema functools32 12:10:34 INFO - Cleaning up... 12:10:34 INFO - Return code: 0 12:10:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86dbca87a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, '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.knzJIUveZU/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.kBUhozWHXD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 12:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:34 INFO - 'HOME': '/Users/cltbld', 12:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:34 INFO - 'LOGNAME': 'cltbld', 12:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:34 INFO - 'MOZ_NO_REMOTE': '1', 12:10:34 INFO - 'NO_EM_RESTART': '1', 12:10:34 INFO - 'PAGER': '/bin/cat', 12:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:34 INFO - 'PWD': '/builds/slave/test', 12:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:34 INFO - 'SHELL': '/bin/bash', 12:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:10:34 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:34 INFO - 'USER': 'cltbld', 12:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:34 INFO - 'XPC_FLAGS': '0x0', 12:10:34 INFO - 'XPC_SERVICE_NAME': '0', 12:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:34 INFO - Downloading/unpacking flake8 12:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:10:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:10:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:10:38 INFO - no previously-included directories found matching 'docs/_build' 12:10:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:10:38 INFO - Running setup.py install for pep8 12:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:10:38 INFO - no previously-included directories found matching 'docs/_build' 12:10:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:10:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:10:38 INFO - Cleaning up... 12:10:38 INFO - Return code: 0 12:10:38 INFO - Running post-action listener: _resource_record_post_action 12:10:38 INFO - Running post-action listener: _start_resource_monitoring 12:10:38 INFO - Starting resource monitoring. 12:10:38 INFO - ##### 12:10:38 INFO - ##### Running install step. 12:10:38 INFO - ##### 12:10:38 INFO - Running pre-action listener: _resource_record_pre_action 12:10:38 INFO - Running main action method: install 12:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:38 INFO - Reading from file tmpfile_stdout 12:10:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:10:38 INFO - Reading from file tmpfile_stdout 12:10:38 INFO - Output received: 12:10:38 INFO - Usage: mozinstall [options] installer 12:10:38 INFO - Options: 12:10:38 INFO - -h, --help show this help message and exit 12:10:38 INFO - -d DEST, --destination=DEST 12:10:38 INFO - Directory to install application into. [default: 12:10:38 INFO - "/builds/slave/test"] 12:10:38 INFO - --app=APP Application being installed. [default: firefox] 12:10:38 INFO - mkdir: /builds/slave/test/build/application 12:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:11:11 INFO - Reading from file tmpfile_stdout 12:11:11 INFO - Output received: 12:11:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:11:11 INFO - Running post-action listener: _resource_record_post_action 12:11:11 INFO - ##### 12:11:11 INFO - ##### Running run-tests step. 12:11:11 INFO - ##### 12:11:11 INFO - Running pre-action listener: _resource_record_pre_action 12:11:11 INFO - Running main action method: run_tests 12:11:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:11 INFO - 2016-04-29 12:11:11.983 screenresolution[1912:18765] starting screenresolution argv=screenresolution get 12:11:11 INFO - 2016-04-29 12:11:11.986 screenresolution[1912:18765] Display 0: 1600x1200x32@60 12:11:11 INFO - 2016-04-29 12:11:11.992 screenresolution[1913:18768] starting screenresolution argv=screenresolution list 12:11:11 INFO - Available Modes on Display 0 12:11:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:12 INFO - Intel Iris: 12:11:12 INFO - Chipset Model: Intel Iris 12:11:12 INFO - Type: GPU 12:11:12 INFO - Bus: Built-In 12:11:12 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:12 INFO - Vendor: Intel (0x8086) 12:11:12 INFO - Device ID: 0x0a2e 12:11:12 INFO - Revision ID: 0x0009 12:11:12 INFO - Displays: 12:11:12 INFO - Display: 12:11:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:12 INFO - Display Serial Number: 1600x1200 60 12:11:12 INFO - Main Display: Yes 12:11:12 INFO - Mirror: Off 12:11:12 INFO - Online: Yes 12:11:12 INFO - Rotation: Supported 12:11:12 INFO - Return code: 0 12:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:11:12 INFO - Python 2.7.3 12:11:12 INFO - Return code: 0 12:11:12 INFO - grabbing minidump binary from tooltool 12:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:12 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 0x10f93be00>, '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 0x10f7a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f936b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:11:12 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 12:11:12 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 12:11:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:11:12 INFO - Return code: 0 12:11:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:11:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:11:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:11:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:11:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:11:13 INFO - Return code: 0 12:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knzJIUveZU/Render', 12:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:11:13 INFO - 'HOME': '/Users/cltbld', 12:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:11:13 INFO - 'LOGNAME': 'cltbld', 12:11:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:13 INFO - 'MOZ_NO_REMOTE': '1', 12:11:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:13 INFO - 'NO_EM_RESTART': '1', 12:11:13 INFO - 'PAGER': '/bin/cat', 12:11:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:13 INFO - 'PWD': '/builds/slave/test', 12:11:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:11:13 INFO - 'SHELL': '/bin/bash', 12:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kBUhozWHXD/Listeners', 12:11:13 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 12:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:11:13 INFO - 'USER': 'cltbld', 12:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:13 INFO - 'XPC_FLAGS': '0x0', 12:11:13 INFO - 'XPC_SERVICE_NAME': '0', 12:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:11:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:11:13 INFO - mozversion application_buildid: 20160429101348 12:11:13 INFO - mozversion application_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 12:11:13 INFO - mozversion application_display_name: Nightly 12:11:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:11:13 INFO - mozversion application_name: Firefox 12:11:13 INFO - mozversion application_remotingname: firefox 12:11:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:11:13 INFO - mozversion application_vendor: Mozilla 12:11:13 INFO - mozversion application_version: 49.0a1 12:11:13 INFO - mozversion platform_buildid: 20160429101348 12:11:13 INFO - mozversion platform_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 12:11:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:11:13 INFO - mozversion platform_version: 49.0a1 12:11:13 INFO - using testdate: 1461957073 12:11:13 INFO - actual date: 1461957073 12:11:13 INFO - starting webserver on 'localhost:55217' 12:11:13 INFO - SUITE-START | Running 2 tests 12:11:13 INFO - TEST-START | dromaeo_css 12:11:13 INFO - operating with platform_type : mac_ 12:11:13 INFO - Initialising browser for dromaeo_css test... 12:11:13 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpqCA7RB/profile http://localhost:55217/getInfo.html) 12:11:16 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 12:11:16 INFO - PROCESS | 1931 | colorDepth:24 12:11:16 INFO - PROCESS | 1931 | Browser inner width/height: 1024/689 12:11:16 INFO - PROCESS | 1931 | __metrics 12:11:16 ERROR - PROCESS | 1931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:11:17 INFO - TEST-INFO | 1931: exit 0 12:11:17 INFO - Browser initialized. 12:11:17 INFO - Running cycle 1/1 for dromaeo_css test... 12:11:17 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpqCA7RB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:29 INFO - PROCESS | 1934 | RSS: Main: 249982976 12:11:29 INFO - PROCESS | 1934 | 12:12:18 INFO - PROCESS | 1934 | 1461957138645 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] 12:14:29 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55217/tests/dromaeo/cssquery-ext.html) 12:14:31 INFO - PROCESS | 1934 | RSS: Main: 261484544 12:14:31 INFO - PROCESS | 1934 | 12:17:33 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-ext.html (next: http://localhost:55217/tests/dromaeo/cssquery-jquery.html) 12:17:34 INFO - PROCESS | 1934 | RSS: Main: 273649664 12:17:34 INFO - PROCESS | 1934 | 12:20:35 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55217/tests/dromaeo/cssquery-mootools.html) 12:20:36 INFO - PROCESS | 1934 | RSS: Main: 275632128 12:20:36 INFO - PROCESS | 1934 | 12:23:38 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55217/tests/dromaeo/cssquery-prototype.html) 12:23:38 INFO - PROCESS | 1934 | RSS: Main: 277807104 12:23:38 INFO - PROCESS | 1934 | 12:26:41 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55217/tests/dromaeo/cssquery-yui.html) 12:26:42 INFO - PROCESS | 1934 | RSS: Main: 280182784 12:26:42 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:55217/tests/dromaeo/cssquery-yui.html (next: http://localhost:55217/tests/dromaeo/cssquery-dojo.html) 12:29:45 INFO - PROCESS | 1934 | RSS: Main: 281329664 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | __start_tp_report 12:29:45 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 12:29:45 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 12:29:45 INFO - PROCESS | 1934 | |i|pagename|runs| 12:29:45 INFO - PROCESS | 1934 | |0;dojo.html;2614.5947378156384;3248.8538015789295;3440.105572551136;3463.3592785334713;3502.8949131526065;4504.842330518432;5792.623479473837;5814.1860139580385;5817.621854579449;5864.208331875201;5651.519620832224;5727.140928860673;5744.368119506851;5811.82564523064;5842.853928651786;5132.307138536287;5148.871278218037;5297.999999999981;5308.787648494075;5341.599380046493;4336.327869180266;5335.893282134355;5355.196720491938;5420.295361602986;5432.565394768409;5131.717755523463;5196.480351964811;5205.895882082337;5289.418164001957;5297.337832770903;4710.95289047112;5245.423003469616;5262.657927234717;5292;5316.4683531646915;4967.130752118364;5182.97408512955;5258.342707161605;5279.234510995922;5292.894142117175;4633.86098417048;5535.723213839332;5613.775448982035;5674.205611214434;5751.338596061465;6162.784302549389;6226.159468471744;6249.5625306228585;6264.467520260783;6278.277998030194;6134.467201660849;6197.737333989184;6234.470070044006;6242.96878515609;6249.78125765596;5817.7091145442555;5873.559483038789;5879.588428809985;5901.1148327750325;5945.672987985702;6246.46905013079;6246.781362652286;6253;6262.185915830913;6296.5277604178955;6077.726502307407;6121.696863452088;6185.227011522968;6215.197592698158;6228.719707613078;5324;6170.290416602148;6246.625202487865;6248.375162483806;6254.530910181755;5107.7446127693465;5613.915791263134;6258.561900666909;6272.96496078142;6272.968635156795;5580.441955804468;5981.700914954322;6223.439890409885;6235.407636274546;6237.594556353823;4941.851744447672;4967.7019378837385;4971.1797553404;4977.352944117241;5074.670146440543;4084.5302790178916;4167.166566686675;4425.380446737459;4461.643068554507;4462.174497717932;5679.801206957819;5883.0881213411985;5884.970575147183;5890.67601281925;6004.789832355847;6158.199434073542;6160.229971253593;6203.7828675996125;6216.875662486725;6376.521760867953;5957.851053723605;5988.760449582055;6008.549358798107;6050.21347224858;6072;5362.410134885159;5398;5458.781648734006;5497.642653227527;5533;6314.905276420857;6340.596838161029;6356.872862542723;6375.458086062737;6391.265004524539;6154;6185.134081228722;6197;6201.720922558406;6206.503479721521;6180.721867515883;6218.81343559694;6279.215098112736;6302.306746257999;6328.398802113792;5775.989201889569;6086.300075491198;6089.086637004485;6139.29398119222;6157.507399407947;5383.488568585978;6159.876802464015;6218.129461875251;6225.657588832658;6256.5307601930945;5685.77256909719;6081.483073938588;6123.160610921377;6174.043023331391;6215.720292586754;6073.30157031947;6143.112737013596;6169.609658507177;6208.751649933952;6217.191765070512;6033.336333003454;6037.335893051849;6090.932534565862;6120.7551697931585;6122.357152499102;6076.0278355462915;6108.949222962717;6159.19930409044;6186.659733714689;6196.225471816023;6087.693919289811;6117.296510901303;6120.053739006349;6124.33130418754;6160.476359509313 12:29:45 INFO - PROCESS | 1934 | |1;ext.html;485.7595490232333;535.2773755430168;535.400351606201;589.9410058994101;600.8347704381297;29069;34210.46052927618;34509.82745086271;39321.606783932155;39412.80293598532;27440.313992150208;37164.628353716456;42592.72221833342;43329.35005974913;43431.348529772076;9428.811423771538;9631.759206019835;9632.036796320346;9690.07944245299;9691.224702023821;9613.375130616487;9713.660021899235;9747.415155090683;9747.951260243688;9754.561044752967;8463.95768021159;9642.373245739005;9723.659671911484;9773.560189791477;9789.461579613118;8754.518501482416;9671.129598336149;9682.515874206296;9742.610295588169;9758.756031099208;9576.138147566753;9689.27330450212;9701.369410988334;9720.07659272375;9742.853857192147;39083;39554.0111497212;39559;39560.80219598913;39569.60430395688;2738.548139556971;3028.182390754506;3133.9529907051415;3186.8725250989933;3359.7816141950693;27164.049258276063;27983.720162798316;28027.859860700566;28696.42607147866;29279.975200867866;2701.0681314946314;2705.0126703753185;2720.2519307190682;2834.9149525514267;2910.461564610554;383197;383771;387648;387782;388270;62516.68741656263;62930;67590.66204668945;67630.30924226933;67692;63207.36792632015;64552;64955.67522162359;65072;65114.34885651177;16602.418915337905;16722.331106755835;16827.663446731243;16845.41041063557;16898.98606083639;12601.18092323996;12911.289879056741;12957.935210323889;12975.351232438341;12981.026423018311;16940.491785246464;19841.404757857286;20082.497937551678;20204;20236.89881550583;7127.216006239413;8320.751887216966;8486.175472273368;8511.361647876434;8524.8721269181;931.4783721116197;940.47333493244;994.751312171957;1040.4173662748885;1065.2064212161988;25424.237272881845;26595;30468.84765576158;30779.38441231163;31638.36723265522;970.8009857979098;1115.6597237842536;1137.135776809614;1161.4599211366756;1256.6230130960857;13185.1585948327;14487;15633.3746650135;15764.842351576566;16043;645618;658763;660262;662743;670610;51289;53368.46631533713;62660.06009909855;63662.68168659127;63770.68114659397;1289.8065290206357;1381.4819442708983;1491.507802425197;1498.5654160293611;1504.6689728259985;29002.564961526015;29418.11745647634;30152.396952061274;30160.5475917857;30176;56598.71700641471;57062.42937570571;57160.85678286328;57266.85466290734;57403;613767;614006;616473;616955;617257.9137104466;42405.57594424016;43000.70997870069;43021.569784301755;43604.56395436005;44188.33717494176;47502.52497474981;47918.5208147928;48100.7594962037;48700.269495958295;49709.75145124251;37610.8119459401;39021.60978390293;39366;39938.00154996148;40190.1961960765;38181.42727859029;38718.80640596779;38939.6106038936;39674.40488392619;39991.40012899867;30983.91556295519;35697.28605427929;36302.27395452129;36511.45232821563;39771.40342894917;31417.52873706942;31650.525242120926;31738.04785856428;31828.52257216097;31881.36237275288;21339.202387546804;24355.14756983497;24363.342898134328;24466.532008079572;25239.873800630878 12:29:45 INFO - PROCESS | 1934 | |2;jquery.html;347.5655430711611;393.3136676499509;396.54595488166046;397.8150160175518;412.8740734076106;18694.065296735178;19798.90100549497;19961.301354452597;20965;21003.68494472582;19910.601787964268;20311.59376812463;20624.896875515602;21215.257465988692;21469.463263418424;5891.528677705774;5937.88124237515;6069.514438844882;6110.083487476892;6129.295131059941;6023.909641355383;6109.114178444123;6120.969395153018;6121.724522396481;6130.601510901799;5774.769009239625;6009.399060094;6087.269527656666;6089.02575587906;6096.786612468564;5872.148538461942;6027.608205466652;6047.244094488189;6052.334243233241;6074.96962515189;5203.765830537635;5237.764300606482;5262.631615786897;5278.868028299285;5305.0450918834595;12786.552470663482;13512.729745405037;13538.59384218475;13605.659858503517;25666.101686440885;2244;2261.7625149359246;2391.2587097999676;2574.905665092347;2775.417162395899;9396.530173491297;10334.121599664037;10372.377657340508;10773.491711160445;12761.298128602923;1782.8395444409937;1858.5632376391536;1864.123861784959;1877.7277294792316;1880.4264699266719;87109;96665.51667241618;114387;114419;125158.37420812837;11347.886521134684;11760.294382336917;11829.290242585472;11841.763164736656;11903.43509931141;15143.318550665246;15154;15199.392024319124;15202.695946081016;15211.391544338103;8629.266512346521;8729.21437070654;8745.912540874637;8759.036505984337;8822.691205807894;8589.098144694717;8596.011458682207;8620.870686939701;8662.090480499583;8666.78333041679;4631.421072365954;4673.322368256584;4720.740359280204;4740.5733483986605;4787.760611969387;1994.4515258303793;2017.4552870725115;2024.3623258673472;2035.6132334856627;2079.6048750737314;799.3645052183412;922.7185708359015;955.7658373698488;990.1138481059555;1081.210716177195;19468;20508.077136528893;20604.969751512665;20626.690599641017;20749;968.2737946540095;970.0929630795229;973.6884197057016;1028.9073983341534;1040.7866387390566;8848.690295839615;10801.621943231949;10838.78322433547;10868.510917008754;10887.891121088687;533583;565720;572436.1378193082;583868;594308;136371;138016;138098.92851607234;141665.87501187492;141918;864.5029108262648;1026.7227848480868;1032.8915463876335;1040.490159821682;1057.8889216632297;13883.583492495241;18095.72856407181;18215.180316885508;18548.721769173742;18716.719249211546;48449.757751212426;52359.73820130875;52510.21234681559;52988;53793;77496.61251693705;77657.61171194108;78785.60607196928;79141.60429197818;80547;5898.734556944862;8131.227533384319;8212.425130240827;8237.79405514867;8636.006859211271;10532.631357902437;11389.487473063899;12460.501579937063;12546.560870369492;12923.547675831302;10264.743381415525;10708.411037393018;10840.620578280037;10928.836067459153;11045.779084418427;10816.918308169435;10859;10951.50718217698;10993.526456547213;11054.502547385548;10712.839307410552;11162.665120046411;11516.942415288206;11520.423978801195;11524.82712759326;8135.30849877767;8201.589920503831;8269.95865020671;8306.418550701635;8417.915820841714;10319.793604128026;11025.338479690923;11131.220814542905;11181.552737890393;11312.981831635192 12:29:45 INFO - PROCESS | 1934 | |3;mootools.html;1607.9839201607983;1631.331154226767;1876.7654043244595;1948.3570421760821;1965.5234404650155;7846.607669616511;8376.246137847593;8502.447340922843;8890.999999999993;8925.018247992724;8416.326693864492;8433.78915527112;8581.227689507943;8595.699150529732;8610.182032706884;2426.3934016495878;2478.8884500197532;2480.702315722116;2484.950300993979;2487.5273697997322;2425.8180636452335;2478.491909158627;2481.4292712676097;2485.453200295941;2507.4358269389422;2465.285067330472;2467;2491.501699660066;2495.201535508638;2500.224930271622;2442.5481285962064;2453.276283496373;2465.7287698353166;2469.0370755405406;2473.9752602473923;2443.841150325241;2456.361346050022;2458.2379462366544;2468.1114798672465;2470.1231062972565;8621.784455388666;8720.345974051908;8729.650813967497;8754.912450875538;8846.203841654218;5280.709560974145;5498.367687715924;5509.917351239735;5517.779288828442;5522.91715624266;3574.6782789548806;3592.0423369263553;3634.4184930411006;3668.651478109602;3693.261347730465;876.430320291809;1034.8085604163255;1046.979195284599;1048.4128887822767;1051.7370657335666;11428.942855285753;11514.712132196762;11580.710482237928;11685.415729213506;11731.765364692743;4223.303154979455;4890.095332363524;4984.925226121611;5037.471065538066;5044.646874718808;10094.394336339843;10157.238207134495;10174.440405777605;10177.949110254402;10189.9810018999;4588;5406.2701535292235;5578.330600327987;5585.525230355384;5641.984442800253;3767.3030489359558;4785.784639691222;4955.4796746341835;4980.327655766498;5055.266986286968;3547.5742910850345;4043.7978101094827;4086.5096188456982;4141.627253547195;4179.2477354076555;1164.470166074451;1354.7222819322014;1381.9032667713163;1385.3211926156112;1391.1027387335112;836.3016880904513;909.3952521573079;919.852823548229;950.8763860698065;964.262339310428;5741.45456181662;5840.919429905481;5880.470757631833;5936.465718085393;5993.880122397528;383.0557675330269;462.0873774295806;466.1422981713663;471.4319245309394;473.56195519144654;3950.9604903950594;4034.3141665916864;4050.311447054008;4083.4895638045246;4089.2026054919006;10125.746856328651;10541.367517948947;10584.364938103738;10597.046265836112;10676.359418434919;10554.050135487843;10566.31318964265;10604;10616.30993985404;10632.94683526593;7582.203868593719;8083.797905052421;8106.189381061965;8128.75613731589;8167.509949402936;5247.2129180623215;5680.545556355564;5694.202811606296;5865.384134665798;5893.5874488785375;9303.674371396968;9740.707778766648;9767.560459779184;9805.55874985613;9848.113669769755;9485.952570237105;9869.605215791287;10135.442550659785;10153;10186;6860.588364698134;7283.672234749343;7285.453590980804;7451.44114191427;7586.582737949245;7321;8226.465279756796;8302.916970830214;8322.875156872773;8330.958345208235;7075;7312.707491700273;7361.484696071438;7509.136449308399;7523.172451030273;6037.003894357382;6866.416354609714;7224.89162662571;7348.1182258129365;7498.362639175732;5799.246098007232;6983.196932352845;7001.649917504003;7019.403350715246;7024;4089.7955102244173;4802.823308289352;4822.42130944289;4910.8772280693265;4974.204127339608;4632.02727427244;4949.876253093701;4996.50034996512;5024.799008039638;5058.367704036996 12:29:45 INFO - PROCESS | 1934 | |4;prototype.html;314.6554522797536;317.52688494143723;330.0922463226129;330.24374183120653;332.14969677625265;4509.819607215712;5025.411912864868;5358.847847712741;5503.339599248091;5556.833295001152;5115.565176959963;5213.452587478317;5369.919451208235;5515.283013208277;5515.834524964257;4239.109786944745;4252.447181866361;4256.4679415073115;4265.9786701066605;4270.530241673413;3831.731778775487;3927.410888366739;4138.565450627686;4216.367544868263;4274.209271284807;4124.958750412503;4152.937705934413;4155.646770024537;4159.147374788161;4161.83352665893;4180.874573762777;4187.874363769077;4188.183304255671;4199.958000419987;4210.221109094828;3086.768492363082;3145.7168854803176;3600.981995090008;3637.1270894985278;3659.908502287464;3699.72252081095;4339.609435150852;4380.34294855771;5266.315379000744;5298.860744939818;4032;4261.616454519108;4731;4754.904901901978;4792.945551978559;5773.191753154561;5773.509251713609;5783.768649254025;5809.3609702932645;5828.854278643025;3401.4217583010945;3728.45937339087;3761.962380376189;3784.924301513982;3832.3485007548506;5254.527092561688;5576.358718747315;6001.969990150022;6039.909401358983;6064.484518815906;3976.343903255988;4005.6595189409227;4015.8676232538664;4021.9798901005306;4062.7765472899273;3592.6227746086806;3812.980935095307;3928.783916884599;4094.815733292009;4097.282975479279;4527.754867411422;4528.773561321921;4697.054474241653;4723.834665786681;4728.432588089451;5132.923006154911;5559.388467268597;5822.359540450547;5843.678597677169;5893.2928048633585;1373.32020649779;1448.9710205796036;1488.8064551608438;1492.1793013842343;1497.1316636350891;960.7790208252142;970.2238209432426;980.6714750558642;982.1700662939804;989.6684610655367;5131.923021154686;5822.214001109796;5892.558058145656;5911.379305172981;5919.3192782829665;5603.579731520153;6382.617042977344;6495.512836537278;6510;6530.967345163243;4629.699069560468;5602.411746766612;5887.4406931341455;5902.8819423611285;5916.7337469813965;2518.8236823422553;3090.10386987771;3387.9491807622903;3394.998475449748;3415.3681568909333;5161.870953226199;6041.365656606081;6360.950443176824;6635.137432133888;6741.831454213684;5210.47895210476;5489.890202195934;5624.3813180550105;6184.319724830265;6224.906626400608;5467.6877549388655;5890.4698577128265;5904.350521442638;6280.2777680566405;6315.368463153648;5077.517635824591;5827.970860145672;6087.178230938766;6087.634741915322;6126.417990290915;5256.369235691742;5931.436513531207;5999.930024141839;6003.6998150093195;6038.305594856648;5470.781168753205;5912.142739302863;6117.929362361658;6262.55961128952;6277.435030847246;3503.474478828196;4039.7374170678813;4045.8988525287104;4057.776822274803;4061.9593804061583;4618.30725391194;4709.764511774329;4751.382320298478;5434.592405569519;5914.792982245773;5672.886542269214;5852.619579727304;5906.940930590811;5913.66942437948;5920.674362910081;4919.532644398776;5412.43039518551;5863.2670916135485;5863.384344643751;5868.2077919480325;4659.856466025531;5460.91808622863;5730.911126885879;5757.683327417032;5799.853105029923;4795.616350692006;5216.078995762386;5602.431319230622;5908.261467316585;5913.29040515141;4989.850304490871;5069;5406.648567843077;5747.453991870766;5797.159391898024 12:29:45 INFO - PROCESS | 1934 | |5;yui.html;594.955378346624;689.1729924091092;710.6553321639004;753.1978442958249;753.7437271327748;12998.960083193346;14058.805001574878;14222.502212422567;15400.768988465183;15446.768298475532;13239.602811915634;14132.364043618036;14229;14250.358733856976;14289.642758931031;711.7615598774416;888.2405543260517;902.512643172686;926.800737841364;929.7117893453051;779.7270955165675;923.4874644572293;927.2303987690235;934.9485778282192;937.2595649436971;977.0327375897881;980.2158273381267;983.395211944656;984.3749219245794;987.7431867714411;968.665810295454;976.8778902637171;978.3445091788519;978.4080631218081;979.0063085967678;714.3285311806885;723.489939592586;723.5875550935968;725.4124159430878;726.7855982485127;14784.186869722162;14803.0378025428;14816.518348165206;14893.404263829434;14927.179005154712;12474.18917770342;12646.683832904251;12744.235345879277;12846.421911014028;12933.48266069356;9920.40477571348;10071.1943044557;10121.544530496145;10447.84328235077;10474.790504189874;3463.688268055887;3479.895603131885;3588.74878758487;3598.0105470995422;3623.981880090609;60107.699461502416;82109;82488;82631.17368826295;83346.58326708389;9597.952010240044;9620.877694105477;9634.229261659051;9906.900930990598;9909.504524773733;18929.90535047316;22721.431964200696;22782.772172278397;22820.771792281863;22829.543409131726;6204.3795620437595;7299.817504562322;7369.668364923591;7459.5897225652025;7781.45529812919;3997.900052498711;4036.6770658347264;4061.268971585143;4061.7969101545395;4092.856750013735;3229.6447390786993;3599.262151258986;3629.201575653352;3637.3452778499595;3641.053326135224;550.3203543623622;597.7835105560164;624.4785604020602;635.4916067146264;643.427349658804;520.6875874475285;554.2019491931605;564.6188822544848;580.2630659062967;611.535233222745;7524.849503009909;7742.806429839299;7969.884216209735;8046.557439340892;8284.585770711561;470.5882352941176;573.9483446489836;590.9231799865989;596.3380647481292;613.2212090644945;3735.3649879520003;3927.666148377363;3994.360902255625;4013.0569316210667;4056.6146216109423;80173.59913200396;85919;91755.54122229347;94359;94629.52685236667;78144;80460.59769701114;80928;81824.77262841062;81840.18159818444;71368;72625.27374726291;72658;73021;73124.17189570196;7729.265719756614;7814.570198638902;7831.274348347368;7890.210978902293;7892.526448413114;40186.1962760749;40876.59123408847;40954.79522602368;41736.555506975004;41811;56320.718396407756;56334.309970700946;59658.508537286914;63067.369326307984;63744.04383934337;10200.59197632116;10288.639897603847;10390.532426040696;10491.79016419652;10896.019358257794;11126;11324.94337528307;11341.943290283496;11501.539938402704;11859.58491452795;10471.633492827714;10551.736206594589;10744.657140734565;10851.023407893328;11091.057260132979;10454.372737635462;10610.204234682584;10762.838557421488;10805.081568066802;10888.40113793749;10440.477976101012;10589.682309530726;10726;10952;11136.33182009082;8805;8846.601902914255;9097.77255568616;9138.268938485038;9198.540072996457;7328;7533.39732821362;8880.86678699833;8958.865617015881;8964.14840590143 12:29:45 INFO - PROCESS | 1934 | __end_tp_report 12:29:45 INFO - PROCESS | 1934 | __start_cc_report 12:29:45 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,420 12:29:45 INFO - PROCESS | 1934 | __end_cc_report 12:29:45 INFO - PROCESS | 1934 | __startTimestamp1461958185338__endTimestamp 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | ------- Summary: start ------- 12:29:45 INFO - PROCESS | 1934 | Number of tests: 6 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#0] dojo.html Cycles:165 Average:5730.83 Median:6037.34 stddev:679.26 (11.3%) stddev-sans-first:635.84 12:29:45 INFO - PROCESS | 1934 | Values: 2614.6 3248.9 3440.1 3463.4 3502.9 4504.8 5792.6 5814.2 5817.6 5864.2 5651.5 5727.1 5744.4 5811.8 5842.9 5132.3 5148.9 5298.0 5308.8 5341.6 4336.3 5335.9 5355.2 5420.3 5432.6 5131.7 5196.5 5205.9 5289.4 5297.3 4711.0 5245.4 5262.7 5292.0 5316.5 4967.1 5183.0 5258.3 5279.2 5292.9 4633.9 5535.7 5613.8 5674.2 5751.3 6162.8 6226.2 6249.6 6264.5 6278.3 6134.5 6197.7 6234.5 6243.0 6249.8 5817.7 5873.6 5879.6 5901.1 5945.7 6246.5 6246.8 6253.0 6262.2 6296.5 6077.7 6121.7 6185.2 6215.2 6228.7 5324.0 6170.3 6246.6 6248.4 6254.5 5107.7 5613.9 6258.6 6273.0 6273.0 5580.4 5981.7 6223.4 6235.4 6237.6 4941.9 4967.7 4971.2 4977.4 5074.7 4084.5 4167.2 4425.4 4461.6 4462.2 5679.8 5883.1 5885.0 5890.7 6004.8 6158.2 6160.2 6203.8 6216.9 6376.5 5957.9 5988.8 6008.5 6050.2 6072.0 5362.4 5398.0 5458.8 5497.6 5533.0 6314.9 6340.6 6356.9 6375.5 6391.3 6154.0 6185.1 6197.0 6201.7 6206.5 6180.7 6218.8 6279.2 6302.3 6328.4 5776.0 6086.3 6089.1 6139.3 6157.5 5383.5 6159.9 6218.1 6225.7 6256.5 5685.8 6081.5 6123.2 6174.0 6215.7 6073.3 6143.1 6169.6 6208.8 6217.2 6033.3 6037.3 6090.9 6120.8 6122.4 6076.0 6108.9 6159.2 6186.7 6196.2 6087.7 6117.3 6120.1 6124.3 6160.5 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#1] ext.html Cycles:180 Average:69446.53 Median:39559.90 stddev:151676.41 (383.4%) stddev-sans-first:152013.53 12:29:45 INFO - PROCESS | 1934 | Values: 485.8 535.3 535.4 589.9 600.8 29069.0 34210.5 34509.8 39321.6 39412.8 27440.3 37164.6 42592.7 43329.4 43431.3 9428.8 9631.8 9632.0 9690.1 9691.2 9613.4 9713.7 9747.4 9748.0 9754.6 8464.0 9642.4 9723.7 9773.6 9789.5 8754.5 9671.1 9682.5 9742.6 9758.8 9576.1 9689.3 9701.4 9720.1 9742.9 39083.0 39554.0 39559.0 39560.8 39569.6 2738.5 3028.2 3134.0 3186.9 3359.8 27164.0 27983.7 28027.9 28696.4 29280.0 2701.1 2705.0 2720.3 2834.9 2910.5 383197.0 383771.0 387648.0 387782.0 388270.0 62516.7 62930.0 67590.7 67630.3 67692.0 63207.4 64552.0 64955.7 65072.0 65114.3 16602.4 16722.3 16827.7 16845.4 16899.0 12601.2 12911.3 12957.9 12975.4 12981.0 16940.5 19841.4 20082.5 20204.0 20236.9 7127.2 8320.8 8486.2 8511.4 8524.9 931.5 940.5 994.8 1040.4 1065.2 25424.2 26595.0 30468.8 30779.4 31638.4 970.8 1115.7 1137.1 1161.5 1256.6 13185.2 14487.0 15633.4 15764.8 16043.0 645618.0 658763.0 660262.0 662743.0 670610.0 51289.0 53368.5 62660.1 63662.7 63770.7 1289.8 1381.5 1491.5 1498.6 1504.7 29002.6 29418.1 30152.4 30160.5 30176.0 56598.7 57062.4 57160.9 57266.9 57403.0 613767.0 614006.0 616473.0 616955.0 617257.9 42405.6 43000.7 43021.6 43604.6 44188.3 47502.5 47918.5 48100.8 48700.3 49709.8 37610.8 39021.6 39366.0 39938.0 40190.2 38181.4 38718.8 38939.6 39674.4 39991.4 30983.9 35697.3 36302.3 36511.5 39771.4 31417.5 31650.5 31738.0 31828.5 31881.4 21339.2 24355.1 24363.3 24466.5 25239.9 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#2] jquery.html Cycles:180 Average:33979.92 Median:21342.36 stddev:95621.77 (448.0%) stddev-sans-first:95856.67 12:29:45 INFO - PROCESS | 1934 | Values: 347.6 393.3 396.5 397.8 412.9 18694.1 19798.9 19961.3 20965.0 21003.7 19910.6 20311.6 20624.9 21215.3 21469.5 5891.5 5937.9 6069.5 6110.1 6129.3 6023.9 6109.1 6121.0 6121.7 6130.6 5774.8 6009.4 6087.3 6089.0 6096.8 5872.1 6027.6 6047.2 6052.3 6075.0 5203.8 5237.8 5262.6 5278.9 5305.0 12786.6 13512.7 13538.6 13605.7 25666.1 2244.0 2261.8 2391.3 2574.9 2775.4 9396.5 10334.1 10372.4 10773.5 12761.3 1782.8 1858.6 1864.1 1877.7 1880.4 87109.0 96665.5 114387.0 114419.0 125158.4 11347.9 11760.3 11829.3 11841.8 11903.4 15143.3 15154.0 15199.4 15202.7 15211.4 8629.3 8729.2 8745.9 8759.0 8822.7 8589.1 8596.0 8620.9 8662.1 8666.8 4631.4 4673.3 4720.7 4740.6 4787.8 1994.5 2017.5 2024.4 2035.6 2079.6 799.4 922.7 955.8 990.1 1081.2 19468.0 20508.1 20605.0 20626.7 20749.0 968.3 970.1 973.7 1028.9 1040.8 8848.7 10801.6 10838.8 10868.5 10887.9 533583.0 565720.0 572436.1 583868.0 594308.0 136371.0 138016.0 138098.9 141665.9 141918.0 864.5 1026.7 1032.9 1040.5 1057.9 13883.6 18095.7 18215.2 18548.7 18716.7 48449.8 52359.7 52510.2 52988.0 53793.0 77496.6 77657.6 78785.6 79141.6 80547.0 5898.7 8131.2 8212.4 8237.8 8636.0 10532.6 11389.5 12460.5 12546.6 12923.5 10264.7 10708.4 10840.6 10928.8 11045.8 10816.9 10859.0 10951.5 10993.5 11054.5 10712.8 11162.7 11516.9 11520.4 11524.8 8135.3 8201.6 8270.0 8306.4 8417.9 10319.8 11025.3 11131.2 11181.6 11313.0 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#3] mootools.html Cycles:180 Average:5664.59 Median:4900.49 stddev:3144.91 (64.2%) stddev-sans-first:3138.95 12:29:45 INFO - PROCESS | 1934 | Values: 1608.0 1631.3 1876.8 1948.4 1965.5 7846.6 8376.2 8502.4 8891.0 8925.0 8416.3 8433.8 8581.2 8595.7 8610.2 2426.4 2478.9 2480.7 2485.0 2487.5 2425.8 2478.5 2481.4 2485.5 2507.4 2465.3 2467.0 2491.5 2495.2 2500.2 2442.5 2453.3 2465.7 2469.0 2474.0 2443.8 2456.4 2458.2 2468.1 2470.1 8621.8 8720.3 8729.7 8754.9 8846.2 5280.7 5498.4 5509.9 5517.8 5522.9 3574.7 3592.0 3634.4 3668.7 3693.3 876.4 1034.8 1047.0 1048.4 1051.7 11428.9 11514.7 11580.7 11685.4 11731.8 4223.3 4890.1 4984.9 5037.5 5044.6 10094.4 10157.2 10174.4 10177.9 10190.0 4588.0 5406.3 5578.3 5585.5 5642.0 3767.3 4785.8 4955.5 4980.3 5055.3 3547.6 4043.8 4086.5 4141.6 4179.2 1164.5 1354.7 1381.9 1385.3 1391.1 836.3 909.4 919.9 950.9 964.3 5741.5 5840.9 5880.5 5936.5 5993.9 383.1 462.1 466.1 471.4 473.6 3951.0 4034.3 4050.3 4083.5 4089.2 10125.7 10541.4 10584.4 10597.0 10676.4 10554.1 10566.3 10604.0 10616.3 10632.9 7582.2 8083.8 8106.2 8128.8 8167.5 5247.2 5680.5 5694.2 5865.4 5893.6 9303.7 9740.7 9767.6 9805.6 9848.1 9486.0 9869.6 10135.4 10153.0 10186.0 6860.6 7283.7 7285.5 7451.4 7586.6 7321.0 8226.5 8302.9 8322.9 8331.0 7075.0 7312.7 7361.5 7509.1 7523.2 6037.0 6866.4 7224.9 7348.1 7498.4 5799.2 6983.2 7001.6 7019.4 7024.0 4089.8 4802.8 4822.4 4910.9 4974.2 4632.0 4949.9 4996.5 5024.8 5058.4 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#4] prototype.html Cycles:180 Average:4701.11 Median:5214.77 stddev:1460.69 (28.0%) stddev-sans-first:1427.20 12:29:45 INFO - PROCESS | 1934 | Values: 314.7 317.5 330.1 330.2 332.1 4509.8 5025.4 5358.8 5503.3 5556.8 5115.6 5213.5 5369.9 5515.3 5515.8 4239.1 4252.4 4256.5 4266.0 4270.5 3831.7 3927.4 4138.6 4216.4 4274.2 4125.0 4152.9 4155.6 4159.1 4161.8 4180.9 4187.9 4188.2 4200.0 4210.2 3086.8 3145.7 3601.0 3637.1 3659.9 3699.7 4339.6 4380.3 5266.3 5298.9 4032.0 4261.6 4731.0 4754.9 4792.9 5773.2 5773.5 5783.8 5809.4 5828.9 3401.4 3728.5 3762.0 3784.9 3832.3 5254.5 5576.4 6002.0 6039.9 6064.5 3976.3 4005.7 4015.9 4022.0 4062.8 3592.6 3813.0 3928.8 4094.8 4097.3 4527.8 4528.8 4697.1 4723.8 4728.4 5132.9 5559.4 5822.4 5843.7 5893.3 1373.3 1449.0 1488.8 1492.2 1497.1 960.8 970.2 980.7 982.2 989.7 5131.9 5822.2 5892.6 5911.4 5919.3 5603.6 6382.6 6495.5 6510.0 6531.0 4629.7 5602.4 5887.4 5902.9 5916.7 2518.8 3090.1 3387.9 3395.0 3415.4 5161.9 6041.4 6361.0 6635.1 6741.8 5210.5 5489.9 5624.4 6184.3 6224.9 5467.7 5890.5 5904.4 6280.3 6315.4 5077.5 5828.0 6087.2 6087.6 6126.4 5256.4 5931.4 5999.9 6003.7 6038.3 5470.8 5912.1 6117.9 6262.6 6277.4 3503.5 4039.7 4045.9 4057.8 4062.0 4618.3 4709.8 4751.4 5434.6 5914.8 5672.9 5852.6 5906.9 5913.7 5920.7 4919.5 5412.4 5863.3 5863.4 5868.2 4659.9 5460.9 5730.9 5757.7 5799.9 4795.6 5216.1 5602.4 5908.3 5913.3 4989.9 5069.0 5406.6 5747.5 5797.2 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - PROCESS | 1934 | [#5] yui.html Cycles:180 Average:17667.71 Median:30127.42 stddev:25051.65 (83.2%) stddev-sans-first:25089.13 12:29:45 INFO - PROCESS | 1934 | Values: 595.0 689.2 710.7 753.2 753.7 12999.0 14058.8 14222.5 15400.8 15446.8 13239.6 14132.4 14229.0 14250.4 14289.6 711.8 888.2 902.5 926.8 929.7 779.7 923.5 927.2 934.9 937.3 977.0 980.2 983.4 984.4 987.7 968.7 976.9 978.3 978.4 979.0 714.3 723.5 723.6 725.4 726.8 14784.2 14803.0 14816.5 14893.4 14927.2 12474.2 12646.7 12744.2 12846.4 12933.5 9920.4 10071.2 10121.5 10447.8 10474.8 3463.7 3479.9 3588.7 3598.0 3624.0 60107.7 82109.0 82488.0 82631.2 83346.6 9598.0 9620.9 9634.2 9906.9 9909.5 18929.9 22721.4 22782.8 22820.8 22829.5 6204.4 7299.8 7369.7 7459.6 7781.5 3997.9 4036.7 4061.3 4061.8 4092.9 3229.6 3599.3 3629.2 3637.3 3641.1 550.3 597.8 624.5 635.5 643.4 520.7 554.2 564.6 580.3 611.5 7524.8 7742.8 7969.9 8046.6 8284.6 470.6 573.9 590.9 596.3 613.2 3735.4 3927.7 3994.4 4013.1 4056.6 80173.6 85919.0 91755.5 94359.0 94629.5 78144.0 80460.6 80928.0 81824.8 81840.2 71368.0 72625.3 72658.0 73021.0 73124.2 7729.3 7814.6 7831.3 7890.2 7892.5 40186.2 40876.6 40954.8 41736.6 41811.0 56320.7 56334.3 59658.5 63067.4 63744.0 10200.6 10288.6 10390.5 10491.8 10896.0 11126.0 11324.9 11341.9 11501.5 11859.6 10471.6 10551.7 10744.7 10851.0 11091.1 10454.4 10610.2 10762.8 10805.1 10888.4 10440.5 10589.7 10726.0 10952.0 11136.3 8805.0 8846.6 9097.8 9138.3 9198.5 7328.0 7533.4 8880.9 8958.9 8964.1 12:29:45 INFO - PROCESS | 1934 | -------- Summary: end -------- 12:29:45 INFO - PROCESS | 1934 | 12:29:45 INFO - TEST-INFO | 1934: exit 0 12:29:45 INFO - TEST-OK | dromaeo_css | took 1112358ms 12:29:45 INFO - TEST-START | kraken 12:29:45 INFO - operating with platform_type : mac_ 12:29:45 INFO - Initialising browser for kraken test... 12:29:45 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpeQO6Hd/profile http://localhost:55217/getInfo.html) 12:29:48 INFO - PROCESS | 1940 | __metrics Screen width/height:1600/1200 12:29:48 INFO - PROCESS | 1940 | colorDepth:24 12:29:48 INFO - PROCESS | 1940 | Browser inner width/height: 1024/689 12:29:48 INFO - PROCESS | 1940 | __metrics 12:29:48 ERROR - PROCESS | 1940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:29:49 INFO - TEST-INFO | 1940: exit 0 12:29:49 INFO - Browser initialized. 12:29:49 INFO - Running cycle 1/1 for kraken test... 12:29:49 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpeQO6Hd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:01 INFO - PROCESS | 1943 | RSS: Main: 249638912 12:30:01 INFO - PROCESS | 1943 | 12:30:04 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55217/tests/kraken/driver.html?testName=audio-beat-detection) 12:30:04 INFO - PROCESS | 1943 | RSS: Main: 261820416 12:30:04 INFO - PROCESS | 1943 | 12:30:07 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55217/tests/kraken/driver.html?testName=audio-dft) 12:30:08 INFO - PROCESS | 1943 | RSS: Main: 266653696 12:30:08 INFO - PROCESS | 1943 | 12:30:11 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55217/tests/kraken/driver.html?testName=audio-fft) 12:30:12 INFO - PROCESS | 1943 | RSS: Main: 266899456 12:30:12 INFO - PROCESS | 1943 | 12:30:14 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55217/tests/kraken/driver.html?testName=audio-oscillator) 12:30:15 INFO - PROCESS | 1943 | RSS: Main: 267489280 12:30:15 INFO - PROCESS | 1943 | 12:30:17 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:30:17 INFO - PROCESS | 1943 | RSS: Main: 267997184 12:30:17 INFO - PROCESS | 1943 | 12:30:20 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55217/tests/kraken/driver.html?testName=imaging-darkroom) 12:30:21 INFO - PROCESS | 1943 | RSS: Main: 268378112 12:30:21 INFO - PROCESS | 1943 | 12:30:24 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55217/tests/kraken/driver.html?testName=imaging-desaturate) 12:30:24 INFO - PROCESS | 1943 | RSS: Main: 268496896 12:30:24 INFO - PROCESS | 1943 | 12:30:27 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55217/tests/kraken/driver.html?testName=json-parse-financial) 12:30:28 INFO - PROCESS | 1943 | RSS: Main: 268660736 12:30:28 INFO - PROCESS | 1943 | 12:30:29 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:30:30 INFO - PROCESS | 1943 | RSS: Main: 268034048 12:30:30 INFO - PROCESS | 1943 | 12:30:32 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:30:32 INFO - PROCESS | 1943 | RSS: Main: 267972608 12:30:32 INFO - PROCESS | 1943 | 12:30:34 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:30:35 INFO - PROCESS | 1943 | RSS: Main: 268218368 12:30:35 INFO - PROCESS | 1943 | 12:30:38 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:30:39 INFO - PROCESS | 1943 | RSS: Main: 268517376 12:30:39 INFO - PROCESS | 1943 | 12:30:42 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:30:42 INFO - PROCESS | 1943 | RSS: Main: 268562432 12:30:42 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:55217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55217/tests/kraken/driver.html?testName=ai-astar) 12:30:44 INFO - PROCESS | 1943 | RSS: Main: 270270464 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | __start_tp_report 12:30:44 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 12:30:44 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 12:30:44 INFO - PROCESS | 1943 | |i|pagename|runs| 12:30:44 INFO - PROCESS | 1943 | |0;ai-astar;116;110;116;116;117;130;115;122;166;166 12:30:44 INFO - PROCESS | 1943 | |1;audio-beat-detection;161;125;150;169;111;158;180;114;218;162 12:30:44 INFO - PROCESS | 1943 | |2;audio-dft;213;204;217;250;207;199;196;200;203;201 12:30:44 INFO - PROCESS | 1943 | |3;audio-fft;73;78;74;137;56;70;95;88;84;55 12:30:44 INFO - PROCESS | 1943 | |4;audio-oscillator;81;80;130;77;79;92;119;80;81;122 12:30:44 INFO - PROCESS | 1943 | |5;imaging-gaussian-blur;88;87;88;86;89;89;131;86;89;86 12:30:44 INFO - PROCESS | 1943 | |6;imaging-darkroom;95;109;95;131;151;122;96;96;94;95 12:30:44 INFO - PROCESS | 1943 | |7;imaging-desaturate;92;95;91;90;95;91;89;91;90;92 12:30:44 INFO - PROCESS | 1943 | |8;json-parse-financial;63;65;63;62;63;62;62;80;64;61 12:30:44 INFO - PROCESS | 1943 | |9;json-stringify-tinderbox;69;66;73;76;79;74;67;71;68;68 12:30:44 INFO - PROCESS | 1943 | |10;stanford-crypto-aes;86;84;85;83;86;84;83;86;85;83 12:30:44 INFO - PROCESS | 1943 | |11;stanford-crypto-ccm;139;138;139;137;137;138;159;155;196;149 12:30:44 INFO - PROCESS | 1943 | |12;stanford-crypto-pbkdf2;174;173;173;170;170;172;171;175;168;171 12:30:44 INFO - PROCESS | 1943 | |13;stanford-crypto-sha256-iterative;71;70;73;70;70;71;69;67;69;77 12:30:44 INFO - PROCESS | 1943 | __end_tp_report 12:30:44 INFO - PROCESS | 1943 | __start_cc_report 12:30:44 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,1079 12:30:44 INFO - PROCESS | 1943 | __end_cc_report 12:30:44 INFO - PROCESS | 1943 | __startTimestamp1461958244672__endTimestamp 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | ------- Summary: start ------- 12:30:44 INFO - PROCESS | 1943 | Number of tests: 14 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#0] ai-astar Cycles:10 Average:127.40 Median:119.50 stddev:21.00 (17.6%) stddev-sans-first:21.87 12:30:44 INFO - PROCESS | 1943 | Values: 116.0 110.0 116.0 116.0 117.0 130.0 115.0 122.0 166.0 166.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:161.50 stddev:32.36 (20.0%) stddev-sans-first:34.25 12:30:44 INFO - PROCESS | 1943 | Values: 161.0 125.0 150.0 169.0 111.0 158.0 180.0 114.0 218.0 162.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#2] audio-dft Cycles:10 Average:209.00 Median:205.50 stddev:15.78 (7.7%) stddev-sans-first:16.67 12:30:44 INFO - PROCESS | 1943 | Values: 213.0 204.0 217.0 250.0 207.0 199.0 196.0 200.0 203.0 201.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:23.41 (30.8%) stddev-sans-first:24.65 12:30:44 INFO - PROCESS | 1943 | Values: 73.0 78.0 74.0 137.0 56.0 70.0 95.0 88.0 84.0 55.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:80.00 stddev:20.96 (26.2%) stddev-sans-first:21.69 12:30:44 INFO - PROCESS | 1943 | Values: 81.0 80.0 130.0 77.0 79.0 92.0 119.0 80.0 81.0 122.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:13.80 (15.7%) stddev-sans-first:14.56 12:30:44 INFO - PROCESS | 1943 | Values: 88.0 87.0 88.0 86.0 89.0 89.0 131.0 86.0 89.0 86.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#6] imaging-darkroom Cycles:10 Average:108.40 Median:95.00 stddev:19.90 (20.9%) stddev-sans-first:20.51 12:30:44 INFO - PROCESS | 1943 | Values: 95.0 109.0 95.0 131.0 151.0 122.0 96.0 96.0 94.0 95.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:91.50 stddev:2.01 (2.2%) stddev-sans-first:2.13 12:30:44 INFO - PROCESS | 1943 | Values: 92.0 95.0 91.0 90.0 95.0 91.0 89.0 91.0 90.0 92.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:63.00 stddev:5.56 (8.8%) stddev-sans-first:5.87 12:30:44 INFO - PROCESS | 1943 | Values: 63.0 65.0 63.0 62.0 63.0 62.0 62.0 80.0 64.0 61.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:4.28 (5.9%) stddev-sans-first:4.47 12:30:44 INFO - PROCESS | 1943 | Values: 69.0 66.0 73.0 76.0 79.0 74.0 67.0 71.0 68.0 68.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 12:30:44 INFO - PROCESS | 1943 | Values: 86.0 84.0 85.0 83.0 86.0 84.0 83.0 86.0 85.0 83.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:144.00 stddev:18.48 (12.8%) stddev-sans-first:19.27 12:30:44 INFO - PROCESS | 1943 | Values: 139.0 138.0 139.0 137.0 137.0 138.0 159.0 155.0 196.0 149.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:2.11 (1.2%) stddev-sans-first:2.07 12:30:44 INFO - PROCESS | 1943 | Values: 174.0 173.0 173.0 170.0 170.0 172.0 171.0 175.0 168.0 171.0 12:30:44 INFO - PROCESS | 1943 | 12:30:44 INFO - PROCESS | 1943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:2.71 (3.8%) stddev-sans-first:2.87 12:30:44 INFO - PROCESS | 1943 | Values: 71.0 70.0 73.0 70.0 70.0 71.0 69.0 67.0 69.0 77.0 12:30:44 INFO - PROCESS | 1943 | -------- Summary: end -------- 12:30:44 INFO - PROCESS | 1943 | 12:30:45 INFO - TEST-INFO | 1943: exit 0 12:30:45 INFO - TEST-OK | kraken | took 59443ms 12:30:45 INFO - SUITE-END | took 1171s 12:30:45 INFO - Completed test suite (00:19:32) 12:30:45 INFO - javascript benchmark 12:30:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.5947378156384, 3248.8538015789295, 3440.105572551136, 3463.3592785334713, 3502.8949131526065, 4504.842330518432, 5792.623479473837, 5814.1860139580385, 5817.621854579449, 5864.208331875201, 5651.519620832224, 5727.140928860673, 5744.368119506851, 5811.82564523064, 5842.853928651786, 5132.307138536287, 5148.871278218037, 5297.999999999981, 5308.787648494075, 5341.599380046493, 4336.327869180266, 5335.893282134355, 5355.196720491938, 5420.295361602986, 5432.565394768409, 5131.717755523463, 5196.480351964811, 5205.895882082337, 5289.418164001957, 5297.337832770903, 4710.95289047112, 5245.423003469616, 5262.657927234717, 5292.0, 5316.4683531646915, 4967.130752118364, 5182.97408512955, 5258.342707161605, 5279.234510995922, 5292.894142117175, 4633.86098417048, 5535.723213839332, 5613.775448982035, 5674.205611214434, 5751.338596061465, 6162.784302549389, 6226.159468471744, 6249.5625306228585, 6264.467520260783, 6278.277998030194, 6134.467201660849, 6197.737333989184, 6234.470070044006, 6242.96878515609, 6249.78125765596, 5817.7091145442555, 5873.559483038789, 5879.588428809985, 5901.1148327750325, 5945.672987985702, 6246.46905013079, 6246.781362652286, 6253.0, 6262.185915830913, 6296.5277604178955, 6077.726502307407, 6121.696863452088, 6185.227011522968, 6215.197592698158, 6228.719707613078, 5324.0, 6170.290416602148, 6246.625202487865, 6248.375162483806, 6254.530910181755, 5107.7446127693465, 5613.915791263134, 6258.561900666909, 6272.96496078142, 6272.968635156795, 5580.441955804468, 5981.700914954322, 6223.439890409885, 6235.407636274546, 6237.594556353823, 4941.851744447672, 4967.7019378837385, 4971.1797553404, 4977.352944117241, 5074.670146440543, 4084.5302790178916, 4167.166566686675, 4425.380446737459, 4461.643068554507, 4462.174497717932, 5679.801206957819, 5883.0881213411985, 5884.970575147183, 5890.67601281925, 6004.789832355847, 6158.199434073542, 6160.229971253593, 6203.7828675996125, 6216.875662486725, 6376.521760867953, 5957.851053723605, 5988.760449582055, 6008.549358798107, 6050.21347224858, 6072.0, 5362.410134885159, 5398.0, 5458.781648734006, 5497.642653227527, 5533.0, 6314.905276420857, 6340.596838161029, 6356.872862542723, 6375.458086062737, 6391.265004524539, 6154.0, 6185.134081228722, 6197.0, 6201.720922558406, 6206.503479721521, 6180.721867515883, 6218.81343559694, 6279.215098112736, 6302.306746257999, 6328.398802113792, 5775.989201889569, 6086.300075491198, 6089.086637004485, 6139.29398119222, 6157.507399407947, 5383.488568585978, 6159.876802464015, 6218.129461875251, 6225.657588832658, 6256.5307601930945, 5685.77256909719, 6081.483073938588, 6123.160610921377, 6174.043023331391, 6215.720292586754, 6073.30157031947, 6143.112737013596, 6169.609658507177, 6208.751649933952, 6217.191765070512, 6033.336333003454, 6037.335893051849, 6090.932534565862, 6120.7551697931585, 6122.357152499102, 6076.0278355462915, 6108.949222962717, 6159.19930409044, 6186.659733714689, 6196.225471816023, 6087.693919289811, 6117.296510901303, 6120.053739006349, 6124.33130418754, 6160.476359509313], "value": 5686.864914095685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.7595490232333, 535.2773755430168, 535.400351606201, 589.9410058994101, 600.8347704381297, 29069.0, 34210.46052927618, 34509.82745086271, 39321.606783932155, 39412.80293598532, 27440.313992150208, 37164.628353716456, 42592.72221833342, 43329.35005974913, 43431.348529772076, 9428.811423771538, 9631.759206019835, 9632.036796320346, 9690.07944245299, 9691.224702023821, 9613.375130616487, 9713.660021899235, 9747.415155090683, 9747.951260243688, 9754.561044752967, 8463.95768021159, 9642.373245739005, 9723.659671911484, 9773.560189791477, 9789.461579613118, 8754.518501482416, 9671.129598336149, 9682.515874206296, 9742.610295588169, 9758.756031099208, 9576.138147566753, 9689.27330450212, 9701.369410988334, 9720.07659272375, 9742.853857192147, 39083.0, 39554.0111497212, 39559.0, 39560.80219598913, 39569.60430395688, 2738.548139556971, 3028.182390754506, 3133.9529907051415, 3186.8725250989933, 3359.7816141950693, 27164.049258276063, 27983.720162798316, 28027.859860700566, 28696.42607147866, 29279.975200867866, 2701.0681314946314, 2705.0126703753185, 2720.2519307190682, 2834.9149525514267, 2910.461564610554, 383197.0, 383771.0, 387648.0, 387782.0, 388270.0, 62516.68741656263, 62930.0, 67590.66204668945, 67630.30924226933, 67692.0, 63207.36792632015, 64552.0, 64955.67522162359, 65072.0, 65114.34885651177, 16602.418915337905, 16722.331106755835, 16827.663446731243, 16845.41041063557, 16898.98606083639, 12601.18092323996, 12911.289879056741, 12957.935210323889, 12975.351232438341, 12981.026423018311, 16940.491785246464, 19841.404757857286, 20082.497937551678, 20204.0, 20236.89881550583, 7127.216006239413, 8320.751887216966, 8486.175472273368, 8511.361647876434, 8524.8721269181, 931.4783721116197, 940.47333493244, 994.751312171957, 1040.4173662748885, 1065.2064212161988, 25424.237272881845, 26595.0, 30468.84765576158, 30779.38441231163, 31638.36723265522, 970.8009857979098, 1115.6597237842536, 1137.135776809614, 1161.4599211366756, 1256.6230130960857, 13185.1585948327, 14487.0, 15633.3746650135, 15764.842351576566, 16043.0, 645618.0, 658763.0, 660262.0, 662743.0, 670610.0, 51289.0, 53368.46631533713, 62660.06009909855, 63662.68168659127, 63770.68114659397, 1289.8065290206357, 1381.4819442708983, 1491.507802425197, 1498.5654160293611, 1504.6689728259985, 29002.564961526015, 29418.11745647634, 30152.396952061274, 30160.5475917857, 30176.0, 56598.71700641471, 57062.42937570571, 57160.85678286328, 57266.85466290734, 57403.0, 613767.0, 614006.0, 616473.0, 616955.0, 617257.9137104466, 42405.57594424016, 43000.70997870069, 43021.569784301755, 43604.56395436005, 44188.33717494176, 47502.52497474981, 47918.5208147928, 48100.7594962037, 48700.269495958295, 49709.75145124251, 37610.8119459401, 39021.60978390293, 39366.0, 39938.00154996148, 40190.1961960765, 38181.42727859029, 38718.80640596779, 38939.6106038936, 39674.40488392619, 39991.40012899867, 30983.91556295519, 35697.28605427929, 36302.27395452129, 36511.45232821563, 39771.40342894917, 31417.52873706942, 31650.525242120926, 31738.04785856428, 31828.52257216097, 31881.36237275288, 21339.202387546804, 24355.14756983497, 24363.342898134328, 24466.532008079572, 25239.873800630878], "value": 20104.494280180566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.5655430711611, 393.3136676499509, 396.54595488166046, 397.8150160175518, 412.8740734076106, 18694.065296735178, 19798.90100549497, 19961.301354452597, 20965.0, 21003.68494472582, 19910.601787964268, 20311.59376812463, 20624.896875515602, 21215.257465988692, 21469.463263418424, 5891.528677705774, 5937.88124237515, 6069.514438844882, 6110.083487476892, 6129.295131059941, 6023.909641355383, 6109.114178444123, 6120.969395153018, 6121.724522396481, 6130.601510901799, 5774.769009239625, 6009.399060094, 6087.269527656666, 6089.02575587906, 6096.786612468564, 5872.148538461942, 6027.608205466652, 6047.244094488189, 6052.334243233241, 6074.96962515189, 5203.765830537635, 5237.764300606482, 5262.631615786897, 5278.868028299285, 5305.0450918834595, 12786.552470663482, 13512.729745405037, 13538.59384218475, 13605.659858503517, 25666.101686440885, 2244.0, 2261.7625149359246, 2391.2587097999676, 2574.905665092347, 2775.417162395899, 9396.530173491297, 10334.121599664037, 10372.377657340508, 10773.491711160445, 12761.298128602923, 1782.8395444409937, 1858.5632376391536, 1864.123861784959, 1877.7277294792316, 1880.4264699266719, 87109.0, 96665.51667241618, 114387.0, 114419.0, 125158.37420812837, 11347.886521134684, 11760.294382336917, 11829.290242585472, 11841.763164736656, 11903.43509931141, 15143.318550665246, 15154.0, 15199.392024319124, 15202.695946081016, 15211.391544338103, 8629.266512346521, 8729.21437070654, 8745.912540874637, 8759.036505984337, 8822.691205807894, 8589.098144694717, 8596.011458682207, 8620.870686939701, 8662.090480499583, 8666.78333041679, 4631.421072365954, 4673.322368256584, 4720.740359280204, 4740.5733483986605, 4787.760611969387, 1994.4515258303793, 2017.4552870725115, 2024.3623258673472, 2035.6132334856627, 2079.6048750737314, 799.3645052183412, 922.7185708359015, 955.7658373698488, 990.1138481059555, 1081.210716177195, 19468.0, 20508.077136528893, 20604.969751512665, 20626.690599641017, 20749.0, 968.2737946540095, 970.0929630795229, 973.6884197057016, 1028.9073983341534, 1040.7866387390566, 8848.690295839615, 10801.621943231949, 10838.78322433547, 10868.510917008754, 10887.891121088687, 533583.0, 565720.0, 572436.1378193082, 583868.0, 594308.0, 136371.0, 138016.0, 138098.92851607234, 141665.87501187492, 141918.0, 864.5029108262648, 1026.7227848480868, 1032.8915463876335, 1040.490159821682, 1057.8889216632297, 13883.583492495241, 18095.72856407181, 18215.180316885508, 18548.721769173742, 18716.719249211546, 48449.757751212426, 52359.73820130875, 52510.21234681559, 52988.0, 53793.0, 77496.61251693705, 77657.61171194108, 78785.60607196928, 79141.60429197818, 80547.0, 5898.734556944862, 8131.227533384319, 8212.425130240827, 8237.79405514867, 8636.006859211271, 10532.631357902437, 11389.487473063899, 12460.501579937063, 12546.560870369492, 12923.547675831302, 10264.743381415525, 10708.411037393018, 10840.620578280037, 10928.836067459153, 11045.779084418427, 10816.918308169435, 10859.0, 10951.50718217698, 10993.526456547213, 11054.502547385548, 10712.839307410552, 11162.665120046411, 11516.942415288206, 11520.423978801195, 11524.82712759326, 8135.30849877767, 8201.589920503831, 8269.95865020671, 8306.418550701635, 8417.915820841714, 10319.793604128026, 11025.338479690923, 11131.220814542905, 11181.552737890393, 11312.981831635192], "value": 9500.007928737394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1607.9839201607983, 1631.331154226767, 1876.7654043244595, 1948.3570421760821, 1965.5234404650155, 7846.607669616511, 8376.246137847593, 8502.447340922843, 8890.999999999993, 8925.018247992724, 8416.326693864492, 8433.78915527112, 8581.227689507943, 8595.699150529732, 8610.182032706884, 2426.3934016495878, 2478.8884500197532, 2480.702315722116, 2484.950300993979, 2487.5273697997322, 2425.8180636452335, 2478.491909158627, 2481.4292712676097, 2485.453200295941, 2507.4358269389422, 2465.285067330472, 2467.0, 2491.501699660066, 2495.201535508638, 2500.224930271622, 2442.5481285962064, 2453.276283496373, 2465.7287698353166, 2469.0370755405406, 2473.9752602473923, 2443.841150325241, 2456.361346050022, 2458.2379462366544, 2468.1114798672465, 2470.1231062972565, 8621.784455388666, 8720.345974051908, 8729.650813967497, 8754.912450875538, 8846.203841654218, 5280.709560974145, 5498.367687715924, 5509.917351239735, 5517.779288828442, 5522.91715624266, 3574.6782789548806, 3592.0423369263553, 3634.4184930411006, 3668.651478109602, 3693.261347730465, 876.430320291809, 1034.8085604163255, 1046.979195284599, 1048.4128887822767, 1051.7370657335666, 11428.942855285753, 11514.712132196762, 11580.710482237928, 11685.415729213506, 11731.765364692743, 4223.303154979455, 4890.095332363524, 4984.925226121611, 5037.471065538066, 5044.646874718808, 10094.394336339843, 10157.238207134495, 10174.440405777605, 10177.949110254402, 10189.9810018999, 4588.0, 5406.2701535292235, 5578.330600327987, 5585.525230355384, 5641.984442800253, 3767.3030489359558, 4785.784639691222, 4955.4796746341835, 4980.327655766498, 5055.266986286968, 3547.5742910850345, 4043.7978101094827, 4086.5096188456982, 4141.627253547195, 4179.2477354076555, 1164.470166074451, 1354.7222819322014, 1381.9032667713163, 1385.3211926156112, 1391.1027387335112, 836.3016880904513, 909.3952521573079, 919.852823548229, 950.8763860698065, 964.262339310428, 5741.45456181662, 5840.919429905481, 5880.470757631833, 5936.465718085393, 5993.880122397528, 383.0557675330269, 462.0873774295806, 466.1422981713663, 471.4319245309394, 473.56195519144654, 3950.9604903950594, 4034.3141665916864, 4050.311447054008, 4083.4895638045246, 4089.2026054919006, 10125.746856328651, 10541.367517948947, 10584.364938103738, 10597.046265836112, 10676.359418434919, 10554.050135487843, 10566.31318964265, 10604.0, 10616.30993985404, 10632.94683526593, 7582.203868593719, 8083.797905052421, 8106.189381061965, 8128.75613731589, 8167.509949402936, 5247.2129180623215, 5680.545556355564, 5694.202811606296, 5865.384134665798, 5893.5874488785375, 9303.674371396968, 9740.707778766648, 9767.560459779184, 9805.55874985613, 9848.113669769755, 9485.952570237105, 9869.605215791287, 10135.442550659785, 10153.0, 10186.0, 6860.588364698134, 7283.672234749343, 7285.453590980804, 7451.44114191427, 7586.582737949245, 7321.0, 8226.465279756796, 8302.916970830214, 8322.875156872773, 8330.958345208235, 7075.0, 7312.707491700273, 7361.484696071438, 7509.136449308399, 7523.172451030273, 6037.003894357382, 6866.416354609714, 7224.89162662571, 7348.1182258129365, 7498.362639175732, 5799.246098007232, 6983.196932352845, 7001.649917504003, 7019.403350715246, 7024.0, 4089.7955102244173, 4802.823308289352, 4822.42130944289, 4910.8772280693265, 4974.204127339608, 4632.02727427244, 4949.876253093701, 4996.50034996512, 5024.799008039638, 5058.367704036996], "value": 4516.764850077065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6554522797536, 317.52688494143723, 330.0922463226129, 330.24374183120653, 332.14969677625265, 4509.819607215712, 5025.411912864868, 5358.847847712741, 5503.339599248091, 5556.833295001152, 5115.565176959963, 5213.452587478317, 5369.919451208235, 5515.283013208277, 5515.834524964257, 4239.109786944745, 4252.447181866361, 4256.4679415073115, 4265.9786701066605, 4270.530241673413, 3831.731778775487, 3927.410888366739, 4138.565450627686, 4216.367544868263, 4274.209271284807, 4124.958750412503, 4152.937705934413, 4155.646770024537, 4159.147374788161, 4161.83352665893, 4180.874573762777, 4187.874363769077, 4188.183304255671, 4199.958000419987, 4210.221109094828, 3086.768492363082, 3145.7168854803176, 3600.981995090008, 3637.1270894985278, 3659.908502287464, 3699.72252081095, 4339.609435150852, 4380.34294855771, 5266.315379000744, 5298.860744939818, 4032.0, 4261.616454519108, 4731.0, 4754.904901901978, 4792.945551978559, 5773.191753154561, 5773.509251713609, 5783.768649254025, 5809.3609702932645, 5828.854278643025, 3401.4217583010945, 3728.45937339087, 3761.962380376189, 3784.924301513982, 3832.3485007548506, 5254.527092561688, 5576.358718747315, 6001.969990150022, 6039.909401358983, 6064.484518815906, 3976.343903255988, 4005.6595189409227, 4015.8676232538664, 4021.9798901005306, 4062.7765472899273, 3592.6227746086806, 3812.980935095307, 3928.783916884599, 4094.815733292009, 4097.282975479279, 4527.754867411422, 4528.773561321921, 4697.054474241653, 4723.834665786681, 4728.432588089451, 5132.923006154911, 5559.388467268597, 5822.359540450547, 5843.678597677169, 5893.2928048633585, 1373.32020649779, 1448.9710205796036, 1488.8064551608438, 1492.1793013842343, 1497.1316636350891, 960.7790208252142, 970.2238209432426, 980.6714750558642, 982.1700662939804, 989.6684610655367, 5131.923021154686, 5822.214001109796, 5892.558058145656, 5911.379305172981, 5919.3192782829665, 5603.579731520153, 6382.617042977344, 6495.512836537278, 6510.0, 6530.967345163243, 4629.699069560468, 5602.411746766612, 5887.4406931341455, 5902.8819423611285, 5916.7337469813965, 2518.8236823422553, 3090.10386987771, 3387.9491807622903, 3394.998475449748, 3415.3681568909333, 5161.870953226199, 6041.365656606081, 6360.950443176824, 6635.137432133888, 6741.831454213684, 5210.47895210476, 5489.890202195934, 5624.3813180550105, 6184.319724830265, 6224.906626400608, 5467.6877549388655, 5890.4698577128265, 5904.350521442638, 6280.2777680566405, 6315.368463153648, 5077.517635824591, 5827.970860145672, 6087.178230938766, 6087.634741915322, 6126.417990290915, 5256.369235691742, 5931.436513531207, 5999.930024141839, 6003.6998150093195, 6038.305594856648, 5470.781168753205, 5912.142739302863, 6117.929362361658, 6262.55961128952, 6277.435030847246, 3503.474478828196, 4039.7374170678813, 4045.8988525287104, 4057.776822274803, 4061.9593804061583, 4618.30725391194, 4709.764511774329, 4751.382320298478, 5434.592405569519, 5914.792982245773, 5672.886542269214, 5852.619579727304, 5906.940930590811, 5913.66942437948, 5920.674362910081, 4919.532644398776, 5412.43039518551, 5863.2670916135485, 5863.384344643751, 5868.2077919480325, 4659.856466025531, 5460.91808622863, 5730.911126885879, 5757.683327417032, 5799.853105029923, 4795.616350692006, 5216.078995762386, 5602.431319230622, 5908.261467316585, 5913.29040515141, 4989.850304490871, 5069.0, 5406.648567843077, 5747.453991870766, 5797.159391898024], "value": 4250.159166456528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.955378346624, 689.1729924091092, 710.6553321639004, 753.1978442958249, 753.7437271327748, 12998.960083193346, 14058.805001574878, 14222.502212422567, 15400.768988465183, 15446.768298475532, 13239.602811915634, 14132.364043618036, 14229.0, 14250.358733856976, 14289.642758931031, 711.7615598774416, 888.2405543260517, 902.512643172686, 926.800737841364, 929.7117893453051, 779.7270955165675, 923.4874644572293, 927.2303987690235, 934.9485778282192, 937.2595649436971, 977.0327375897881, 980.2158273381267, 983.395211944656, 984.3749219245794, 987.7431867714411, 968.665810295454, 976.8778902637171, 978.3445091788519, 978.4080631218081, 979.0063085967678, 714.3285311806885, 723.489939592586, 723.5875550935968, 725.4124159430878, 726.7855982485127, 14784.186869722162, 14803.0378025428, 14816.518348165206, 14893.404263829434, 14927.179005154712, 12474.18917770342, 12646.683832904251, 12744.235345879277, 12846.421911014028, 12933.48266069356, 9920.40477571348, 10071.1943044557, 10121.544530496145, 10447.84328235077, 10474.790504189874, 3463.688268055887, 3479.895603131885, 3588.74878758487, 3598.0105470995422, 3623.981880090609, 60107.699461502416, 82109.0, 82488.0, 82631.17368826295, 83346.58326708389, 9597.952010240044, 9620.877694105477, 9634.229261659051, 9906.900930990598, 9909.504524773733, 18929.90535047316, 22721.431964200696, 22782.772172278397, 22820.771792281863, 22829.543409131726, 6204.3795620437595, 7299.817504562322, 7369.668364923591, 7459.5897225652025, 7781.45529812919, 3997.900052498711, 4036.6770658347264, 4061.268971585143, 4061.7969101545395, 4092.856750013735, 3229.6447390786993, 3599.262151258986, 3629.201575653352, 3637.3452778499595, 3641.053326135224, 550.3203543623622, 597.7835105560164, 624.4785604020602, 635.4916067146264, 643.427349658804, 520.6875874475285, 554.2019491931605, 564.6188822544848, 580.2630659062967, 611.535233222745, 7524.849503009909, 7742.806429839299, 7969.884216209735, 8046.557439340892, 8284.585770711561, 470.5882352941176, 573.9483446489836, 590.9231799865989, 596.3380647481292, 613.2212090644945, 3735.3649879520003, 3927.666148377363, 3994.360902255625, 4013.0569316210667, 4056.6146216109423, 80173.59913200396, 85919.0, 91755.54122229347, 94359.0, 94629.52685236667, 78144.0, 80460.59769701114, 80928.0, 81824.77262841062, 81840.18159818444, 71368.0, 72625.27374726291, 72658.0, 73021.0, 73124.17189570196, 7729.265719756614, 7814.570198638902, 7831.274348347368, 7890.210978902293, 7892.526448413114, 40186.1962760749, 40876.59123408847, 40954.79522602368, 41736.555506975004, 41811.0, 56320.718396407756, 56334.309970700946, 59658.508537286914, 63067.369326307984, 63744.04383934337, 10200.59197632116, 10288.639897603847, 10390.532426040696, 10491.79016419652, 10896.019358257794, 11126.0, 11324.94337528307, 11341.943290283496, 11501.539938402704, 11859.58491452795, 10471.633492827714, 10551.736206594589, 10744.657140734565, 10851.023407893328, 11091.057260132979, 10454.372737635462, 10610.204234682584, 10762.838557421488, 10805.081568066802, 10888.40113793749, 10440.477976101012, 10589.682309530726, 10726.0, 10952.0, 11136.33182009082, 8805.0, 8846.601902914255, 9097.77255568616, 9138.268938485038, 9198.540072996457, 7328.0, 7533.39732821362, 8880.86678699833, 8958.865617015881, 8964.14840590143], "value": 6728.199025303308, "unit": "score"}], "name": "dromaeo_css", "value": 7208.492232048038, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 116.0, 116.0, 117.0, 130.0, 115.0, 122.0, 166.0, 166.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 150.0, 169.0, 111.0, 158.0, 180.0, 114.0, 218.0, 162.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 204.0, 217.0, 250.0, 207.0, 199.0, 196.0, 200.0, 203.0, 201.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 74.0, 137.0, 56.0, 70.0, 95.0, 88.0, 84.0, 55.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 130.0, 77.0, 79.0, 92.0, 119.0, 80.0, 81.0, 122.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 89.0, 89.0, 131.0, 86.0, 89.0, 86.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 109.0, 95.0, 131.0, 151.0, 122.0, 96.0, 96.0, 94.0, 95.0], "value": 108.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 91.0, 90.0, 95.0, 91.0, 89.0, 91.0, 90.0, 92.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 62.0, 63.0, 62.0, 62.0, 80.0, 64.0, 61.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 73.0, 76.0, 79.0, 74.0, 67.0, 71.0, 68.0, 68.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 83.0, 86.0, 84.0, 83.0, 86.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 139.0, 137.0, 137.0, 138.0, 159.0, 155.0, 196.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 173.0, 170.0, 170.0, 172.0, 171.0, 175.0, 168.0, 171.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 73.0, 70.0, 70.0, 71.0, 69.0, 67.0, 69.0, 77.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1569.4, "alertThreshold": 2.0}]} 12:30:45 INFO - Return code: 0 12:30:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:30:45 ERROR - # TBPL SUCCESS # 12:30:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:30:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:30:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:30:45 INFO - 2016-04-29 12:30:45.989 screenresolution[1950:21453] starting screenresolution argv=screenresolution get 12:30:45 INFO - 2016-04-29 12:30:45.992 screenresolution[1950:21453] Display 0: 1600x1200x32@60 12:30:45 INFO - 2016-04-29 12:30:45.998 screenresolution[1951:21455] starting screenresolution argv=screenresolution list 12:30:46 INFO - Available Modes on Display 0 12:30:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:30:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:30:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:30:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:30:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:30:46 INFO - Intel Iris: 12:30:46 INFO - Chipset Model: Intel Iris 12:30:46 INFO - Type: GPU 12:30:46 INFO - Bus: Built-In 12:30:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:30:46 INFO - Vendor: Intel (0x8086) 12:30:46 INFO - Device ID: 0x0a2e 12:30:46 INFO - Revision ID: 0x0009 12:30:46 INFO - Displays: 12:30:46 INFO - Display: 12:30:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:30:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:30:46 INFO - Display Serial Number: 1600x1200 60 12:30:46 INFO - Main Display: Yes 12:30:46 INFO - Mirror: Off 12:30:46 INFO - Online: Yes 12:30:46 INFO - Rotation: Supported 12:30:46 INFO - Return code: 0 12:30:46 INFO - Running post-action listener: _resource_record_post_action 12:30:46 INFO - Running post-run listener: _resource_record_post_run 12:30:47 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 790528; Write bytes: 697716736; Read time: 12; Write time: 2192 12:30:47 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 391401984; Write bytes: 385271808; Read time: 28798; Write time: 681 12:30:47 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 790528; Write bytes: 297484800; Read time: 12; Write time: 1400 12:30:47 INFO - Running post-run listener: _upload_blobber_files 12:30:47 INFO - Blob upload gear active. 12:30:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:30: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 12:30: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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:30: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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:30:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:48 INFO - (blobuploader) - INFO - Done attempting. 12:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:49 INFO - (blobuploader) - INFO - Done attempting. 12:30:49 INFO - (blobuploader) - INFO - Iteration through files over. 12:30:49 INFO - Return code: 0 12:30:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:30:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:30:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9497e4d732664b85a830941321c8aab55f25b8c30d089bbfc7afa7b649889f0cc23c7777b995c0088428cd8136f4b4bbc46f8268318aee9b6a81108dadbfd8a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a4af49368ac95b56448683f54c49d5a29f97fd7642718b946c949b8c31672cdbf6d317d57f67c7c35e251366e00174a49bbec21f127e1ed7779dc99657e1bad"} 12:30:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:30:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:30:49 INFO - Contents: 12:30:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9497e4d732664b85a830941321c8aab55f25b8c30d089bbfc7afa7b649889f0cc23c7777b995c0088428cd8136f4b4bbc46f8268318aee9b6a81108dadbfd8a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a4af49368ac95b56448683f54c49d5a29f97fd7642718b946c949b8c31672cdbf6d317d57f67c7c35e251366e00174a49bbec21f127e1ed7779dc99657e1bad"} 12:30:49 INFO - Running post-run listener: copy_logs_to_upload_dir 12:30:49 INFO - Copying logs to upload dir... 12:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs 12:30:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.065024 ========= master_lag: 0.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-29 12:30:50.069383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 12:30:50.072543) ========= 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.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9497e4d732664b85a830941321c8aab55f25b8c30d089bbfc7afa7b649889f0cc23c7777b995c0088428cd8136f4b4bbc46f8268318aee9b6a81108dadbfd8a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a4af49368ac95b56448683f54c49d5a29f97fd7642718b946c949b8c31672cdbf6d317d57f67c7c35e251366e00174a49bbec21f127e1ed7779dc99657e1bad"} build_url:https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9497e4d732664b85a830941321c8aab55f25b8c30d089bbfc7afa7b649889f0cc23c7777b995c0088428cd8136f4b4bbc46f8268318aee9b6a81108dadbfd8a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a4af49368ac95b56448683f54c49d5a29f97fd7642718b946c949b8c31672cdbf6d317d57f67c7c35e251366e00174a49bbec21f127e1ed7779dc99657e1bad"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 12:30:50.112378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:30:50.112788) ========= 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.knzJIUveZU/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.kBUhozWHXD/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005002 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 12:30:50.161596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 12:30:50.161877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 12:30:50.162228) ========= ========= Total master_lag: 0.83 =========