builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1467241046.45 results: success (0) buildid: 20160629135046 builduid: e70f77e5232f46a5b5d6558898e1abca revision: 145e5f7874f84262bcfdcb10270c241842bf1b21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.450954) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.451343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.451611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.475702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.476351) ========= 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.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-06-29 15:57:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-06-29 15:57:26 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074511 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.574577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.574888) ========= 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.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.020773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:26.623860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 15:57:26.624245) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 145e5f7874f84262bcfdcb10270c241842bf1b21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 145e5f7874f84262bcfdcb10270c241842bf1b21 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-06-29 15:57:26,695 truncating revision to first 12 chars 2016-06-29 15:57:26,695 Setting DEBUG logging. 2016-06-29 15:57:26,695 attempt 1/10 2016-06-29 15:57:26,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/145e5f7874f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 15:57:27,485 unpacking tar archive at: larch-145e5f7874f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 15:57:27.701161) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:27.701477) ========= script_repo_revision: 145e5f7874f84262bcfdcb10270c241842bf1b21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:27.701863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:27.702138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:57:27.720595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-29 15:57:27.720988) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:57:27 INFO - MultiFileLogger online at 20160629 15:57:27 in /builds/slave/test 15:57:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 15:57:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:57:27 INFO - {'append_to_log': False, 15:57:27 INFO - 'base_work_dir': '/builds/slave/test', 15:57:27 INFO - 'blob_upload_branch': 'Larch', 15:57:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:57:27 INFO - 'branch': 'Larch', 15:57:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:57:27 INFO - 'config_files': ('talos/mac_config.py',), 15:57:27 INFO - 'default_actions': ('clobber', 15:57:27 INFO - 'read-buildbot-config', 15:57:27 INFO - 'download-and-extract', 15:57:27 INFO - 'populate-webroot', 15:57:27 INFO - 'create-virtualenv', 15:57:27 INFO - 'install', 15:57:27 INFO - 'run-tests'), 15:57:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:57:27 INFO - 'download_minidump_stackwalk': True, 15:57:27 INFO - 'download_symbols': 'ondemand', 15:57:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:57:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:57:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:57:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:57:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:57:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:57:27 INFO - 'installer_path': 'installer.exe', 15:57:27 INFO - 'log_level': 'info', 15:57:27 INFO - 'log_name': 'talos', 15:57:27 INFO - 'log_to_console': True, 15:57:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:57:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:57:27 INFO - 'opt_config_files': (), 15:57:27 INFO - 'pip_index': False, 15:57:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:57:27 INFO - 'cmd': ('bash', 15:57:27 INFO - '-c', 15:57:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:57:27 INFO - 'enabled': True, 15:57:27 INFO - 'halt_on_failure': False, 15:57:27 INFO - 'name': 'check_screen_resolution'},), 15:57:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:57:27 INFO - 'cmd': ('bash', 15:57:27 INFO - '-c', 15:57:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:57:27 INFO - 'enabled': True, 15:57:27 INFO - 'halt_on_failure': False, 15:57:27 INFO - 'name': 'check_screen_resolution'},), 15:57:27 INFO - 'run_cmd_checks_enabled': True, 15:57:27 INFO - 'sps_profile': False, 15:57:27 INFO - 'sps_profile_interval': 0, 15:57:27 INFO - 'suite': 'dromaeojs-e10s', 15:57:27 INFO - 'system_bits': '32', 15:57:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:57:27 INFO - 'title': 't-yosemite-r7-0140', 15:57:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:57:27 INFO - 'use_talos_json': True, 15:57:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:57:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:57:27 INFO - 'work_dir': 'build'} 15:57:27 INFO - ##### 15:57:27 INFO - ##### Running clobber step. 15:57:27 INFO - ##### 15:57:27 INFO - Running pre-action listener: _resource_record_pre_action 15:57:27 INFO - Running main action method: clobber 15:57:27 INFO - rmtree: /builds/slave/test/build 15:57:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:57:29 INFO - Running post-action listener: _resource_record_post_action 15:57:29 INFO - ##### 15:57:29 INFO - ##### Running read-buildbot-config step. 15:57:29 INFO - ##### 15:57:29 INFO - Running pre-action listener: _resource_record_pre_action 15:57:29 INFO - Running main action method: read_buildbot_config 15:57:29 INFO - Using buildbot properties: 15:57:29 INFO - { 15:57:29 INFO - "project": "", 15:57:29 INFO - "product": "firefox", 15:57:29 INFO - "script_repo_revision": "production", 15:57:29 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 15:57:29 INFO - "repository": "", 15:57:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 15:57:29 INFO - "buildid": "20160629135046", 15:57:29 INFO - "pgo_build": "False", 15:57:29 INFO - "basedir": "/builds/slave/test", 15:57:29 INFO - "buildnumber": 4, 15:57:29 INFO - "slavename": "t-yosemite-r7-0140", 15:57:29 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:57:29 INFO - "platform": "yosemite_r7", 15:57:29 INFO - "scheduler": "tests-larch-macosx64-talos", 15:57:29 INFO - "branch": "larch", 15:57:29 INFO - "repo_path": "projects/larch", 15:57:29 INFO - "revision": "145e5f7874f84262bcfdcb10270c241842bf1b21", 15:57:29 INFO - "stage_platform": "macosx64", 15:57:29 INFO - "builduid": "e70f77e5232f46a5b5d6558898e1abca", 15:57:29 INFO - "slavebuilddir": "test" 15:57:29 INFO - } 15:57:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg. 15:57:29 INFO - Running post-action listener: _resource_record_post_action 15:57:29 INFO - ##### 15:57:29 INFO - ##### Running download-and-extract step. 15:57:29 INFO - ##### 15:57:29 INFO - Running pre-action listener: _resource_record_pre_action 15:57:29 INFO - Running main action method: download_and_extract 15:57:29 INFO - mkdir: /builds/slave/test/build/tests 15:57:29 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')]} 15:57:29 INFO - https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:57:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 15:57:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 15:57:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 15:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json'}, attempt #1 15:57:31 INFO - Downloaded 1277 bytes. 15:57:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 15:57:31 INFO - Using the following test package requirements: 15:57:31 INFO - {u'common': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:57:31 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.cppunittest.tests.zip'], 15:57:31 INFO - u'gtest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.gtest.tests.zip'], 15:57:31 INFO - u'jittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'jsshell-mac.zip'], 15:57:31 INFO - u'mochitest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.mochitest.tests.zip'], 15:57:31 INFO - u'mozbase': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:57:31 INFO - u'reftest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.reftest.tests.zip'], 15:57:31 INFO - u'talos': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.talos.tests.zip'], 15:57:31 INFO - u'web-platform': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.web-platform.tests.zip'], 15:57:31 INFO - u'webapprt': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:57:31 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:57:31 INFO - u'firefox-47.0.2.en-US.mac.xpcshell.tests.zip']} 15:57:31 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip'] for test suite category: common 15:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:31 INFO - https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 15:57:32 INFO - Downloaded 17990238 bytes. 15:57:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:57:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:57:35 INFO - Return code: 0 15:57:35 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip', u'firefox-47.0.2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:57:35 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')]} 15:57:35 INFO - https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 15:57:36 INFO - Downloaded 17990238 bytes. 15:57:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:57:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:57:40 INFO - Return code: 0 15:57:40 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')]} 15:57:40 INFO - https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 15:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 15:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip 15:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip'}, attempt #1 15:57:53 INFO - Downloaded 10845194 bytes. 15:57:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:57:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:57:53 INFO - Return code: 0 15:57: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')]} 15:57:53 INFO - https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg matches https://queue.taskcluster.net 15:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg 15:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg'}, attempt #1 15:57:59 INFO - Downloaded 115401811 bytes. 15:57:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:57:59 INFO - mkdir: /builds/slave/test/properties 15:57:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:57:59 INFO - Writing to file /builds/slave/test/properties/build_url 15:57:59 INFO - Contents: 15:57:59 INFO - build_url:https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:58:01 INFO - Running post-action listener: _resource_record_post_action 15:58:01 INFO - Running post-action listener: set_extra_try_arguments 15:58:01 INFO - ##### 15:58:01 INFO - ##### Running populate-webroot step. 15:58:01 INFO - ##### 15:58:01 INFO - Running pre-action listener: _resource_record_pre_action 15:58:01 INFO - Running main action method: populate_webroot 15:58:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:01 INFO - '--tppagecycles', 15:58:01 INFO - '7'], 15:58:01 INFO - 'tests': ['tsvgm']}}, 15:58:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:58:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:58:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'tests': ['damp', 'tps']}, 15:58:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['damp', 'tps']}, 15:58:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:58:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:01 INFO - 'other': {'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'other_l64': {'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'other_nol64': {'tests': ['a11yr', 15:58:01 INFO - 'ts_paint', 15:58:01 INFO - 'tpaint', 15:58:01 INFO - 'sessionrestore', 15:58:01 INFO - 'sessionrestore_no_auto_restore', 15:58:01 INFO - 'tabpaint']}, 15:58:01 INFO - 'svgr': {'tests': ['tsvgx', 15:58:01 INFO - 'tsvgr_opacity', 15:58:01 INFO - 'tart', 15:58:01 INFO - 'tscrollx', 15:58:01 INFO - 'cart']}, 15:58:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['tsvgx', 15:58:01 INFO - 'tsvgr_opacity', 15:58:01 INFO - 'tart', 15:58:01 INFO - 'tscrollx', 15:58:01 INFO - 'cart']}, 15:58:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'tests': ['tp5o']}, 15:58:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'talos_options': ['--e10s'], 15:58:01 INFO - 'tests': ['tp5o']}, 15:58:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'talos_options': ['--xperf_path', 15:58:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:01 INFO - 'tests': ['tp5n']}, 15:58:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:01 INFO - 'talos_options': ['--e10s', 15:58:01 INFO - '--xperf_path', 15:58:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:01 INFO - 'tests': ['tp5n']}}, 15:58:01 INFO - 'talos.zip': {'path': '', 15:58:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:01 INFO - Running post-action listener: _resource_record_post_action 15:58:01 INFO - ##### 15:58:01 INFO - ##### Running create-virtualenv step. 15:58:01 INFO - ##### 15:58:01 INFO - Running pre-action listener: _resource_record_pre_action 15:58:01 INFO - Running main action method: create_virtualenv 15:58:01 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:01 INFO - Using real prefix '/tools/python27' 15:58:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:04 INFO - Installing pip.................done. 15:58:04 INFO - Return code: 0 15:58:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:04 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:04 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 15:58:04 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 15:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:04 INFO - 'HOME': '/Users/cltbld', 15:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:04 INFO - 'LOGNAME': 'cltbld', 15:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:04 INFO - 'MOZ_NO_REMOTE': '1', 15:58:04 INFO - 'NO_EM_RESTART': '1', 15:58:04 INFO - 'PAGER': '/bin/cat', 15:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:04 INFO - 'PWD': '/builds/slave/test', 15:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:04 INFO - 'SHELL': '/bin/bash', 15:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:04 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:04 INFO - 'USER': 'cltbld', 15:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:04 INFO - 'XPC_FLAGS': '0x0', 15:58:04 INFO - 'XPC_SERVICE_NAME': '0', 15:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:58:05 INFO - Cleaning up... 15:58:05 INFO - Return code: 0 15:58:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:05 INFO - 'HOME': '/Users/cltbld', 15:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:05 INFO - 'LOGNAME': 'cltbld', 15:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:05 INFO - 'MOZ_NO_REMOTE': '1', 15:58:05 INFO - 'NO_EM_RESTART': '1', 15:58:05 INFO - 'PAGER': '/bin/cat', 15:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:05 INFO - 'PWD': '/builds/slave/test', 15:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:05 INFO - 'SHELL': '/bin/bash', 15:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:05 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:05 INFO - 'USER': 'cltbld', 15:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:05 INFO - 'XPC_FLAGS': '0x0', 15:58:05 INFO - 'XPC_SERVICE_NAME': '0', 15:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:05 INFO - Downloading/unpacking psutil>=0.7.1 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:08 INFO - Installing collected packages: psutil 15:58:08 INFO - Running setup.py install for psutil 15:58:08 INFO - building 'psutil._psutil_osx' extension 15:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:58:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:58:09 INFO - building 'psutil._psutil_posix' extension 15:58:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:58:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:58:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:58:09 INFO - ^ 15:58:09 INFO - 1 warning generated. 15:58:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:58:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:09 INFO - Successfully installed psutil 15:58:09 INFO - Cleaning up... 15:58:09 INFO - Return code: 0 15:58:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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', '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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:58: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 mozsystemmonitor==0.0.0 15:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:09 INFO - 'HOME': '/Users/cltbld', 15:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:09 INFO - 'LOGNAME': 'cltbld', 15:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:09 INFO - 'MOZ_NO_REMOTE': '1', 15:58:09 INFO - 'NO_EM_RESTART': '1', 15:58:09 INFO - 'PAGER': '/bin/cat', 15:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:09 INFO - 'PWD': '/builds/slave/test', 15:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:09 INFO - 'SHELL': '/bin/bash', 15:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:09 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:09 INFO - 'USER': 'cltbld', 15:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:09 INFO - 'XPC_FLAGS': '0x0', 15:58:09 INFO - 'XPC_SERVICE_NAME': '0', 15:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:58:12 INFO - Installing collected packages: mozsystemmonitor 15:58:12 INFO - Running setup.py install for mozsystemmonitor 15:58:12 INFO - Successfully installed mozsystemmonitor 15:58:12 INFO - Cleaning up... 15:58:12 INFO - Return code: 0 15:58:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:12 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:12 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 15:58:12 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 15:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:12 INFO - 'HOME': '/Users/cltbld', 15:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:12 INFO - 'LOGNAME': 'cltbld', 15:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:12 INFO - 'MOZ_NO_REMOTE': '1', 15:58:12 INFO - 'NO_EM_RESTART': '1', 15:58:12 INFO - 'PAGER': '/bin/cat', 15:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:12 INFO - 'PWD': '/builds/slave/test', 15:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:12 INFO - 'SHELL': '/bin/bash', 15:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:12 INFO - 'USER': 'cltbld', 15:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:12 INFO - 'XPC_FLAGS': '0x0', 15:58:12 INFO - 'XPC_SERVICE_NAME': '0', 15:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:12 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 15:58:12 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 15:58:12 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 15:58:12 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 15:58:12 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 15:58:12 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 15:58:15 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:15 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 15:58:16 INFO - Downloading docopt-0.6.1.tar.gz 15:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:16 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:16 INFO - Running setup.py install for blobuploader 15:58:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:16 INFO - Running setup.py install for requests 15:58:17 INFO - Running setup.py install for docopt 15:58:17 INFO - Successfully installed blobuploader requests docopt 15:58:17 INFO - Cleaning up... 15:58:17 INFO - Return code: 0 15:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:17 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')]} 15:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:17 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')]} 15:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:17 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:17 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 15:58:17 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 15:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:17 INFO - 'HOME': '/Users/cltbld', 15:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:17 INFO - 'LOGNAME': 'cltbld', 15:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:17 INFO - 'MOZ_NO_REMOTE': '1', 15:58:17 INFO - 'NO_EM_RESTART': '1', 15:58:17 INFO - 'PAGER': '/bin/cat', 15:58:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:17 INFO - 'PWD': '/builds/slave/test', 15:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:17 INFO - 'SHELL': '/bin/bash', 15:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:17 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:17 INFO - 'USER': 'cltbld', 15:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:17 INFO - 'XPC_FLAGS': '0x0', 15:58:17 INFO - 'XPC_SERVICE_NAME': '0', 15:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-B4KEn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8Sp74g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2ug0Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:17 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ECKoI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-KrDcSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-AHPHMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-k6gpkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Y6MqKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-GsFEG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-K6KAX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Lg4TUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-TmvkoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yZ2GX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:18 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-I4lAxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:19 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6DMJFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:19 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rMfd8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:19 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-WgYA8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:58:19 INFO - Running setup.py install for manifestparser 15:58:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozcrash 15:58:19 INFO - Running setup.py install for mozdebug 15:58:19 INFO - Running setup.py install for mozdevice 15:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:58:19 INFO - Running setup.py install for mozfile 15:58:20 INFO - Running setup.py install for mozhttpd 15:58:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Running setup.py install for mozinfo 15:58:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Running setup.py install for mozInstall 15:58:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Running setup.py install for mozleak 15:58:20 INFO - Running setup.py install for mozlog 15:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:58:20 INFO - Running setup.py install for moznetwork 15:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Running setup.py install for mozprocess 15:58:21 INFO - Running setup.py install for mozprofile 15:58:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Running setup.py install for mozrunner 15:58:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Running setup.py install for mozscreenshot 15:58:21 INFO - Running setup.py install for moztest 15:58:21 INFO - Running setup.py install for mozversion 15:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:58:21 INFO - Cleaning up... 15:58:21 INFO - Return code: 0 15:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:22 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:22 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 15:58:22 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 15:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:22 INFO - 'HOME': '/Users/cltbld', 15:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:22 INFO - 'LOGNAME': 'cltbld', 15:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:22 INFO - 'MOZ_NO_REMOTE': '1', 15:58:22 INFO - 'NO_EM_RESTART': '1', 15:58:22 INFO - 'PAGER': '/bin/cat', 15:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:22 INFO - 'PWD': '/builds/slave/test', 15:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:22 INFO - 'SHELL': '/bin/bash', 15:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:22 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:22 INFO - 'USER': 'cltbld', 15:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:22 INFO - 'XPC_FLAGS': '0x0', 15:58:22 INFO - 'XPC_SERVICE_NAME': '0', 15:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:22 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-qjxQWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:22 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)) 15:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:22 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rcPsBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:22 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)) 15:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:22 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rQNZWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xqfnOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-pJlcXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-p9tPF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FGyFJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-aw5hkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-iJY9MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MrFdGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9X0xWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-picUJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:23 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)) 15:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:23 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xF77_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:24 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-YQD6pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:24 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-hDq5GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:24 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9u1_D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:24 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)) 15:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:24 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-iY4KYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:24 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)) 15:58:24 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)) 15:58:24 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)) 15:58:24 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)) 15:58:24 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)) 15:58:24 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)) 15:58:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:58:24 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 15:58:24 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 15:58:24 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 15:58:24 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 15:58:24 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 15:58:24 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 15:58:27 INFO - Downloading blessings-1.6.tar.gz 15:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:58:27 INFO - Installing collected packages: blessings 15:58:27 INFO - Running setup.py install for blessings 15:58:27 INFO - Successfully installed blessings 15:58:27 INFO - Cleaning up... 15:58:27 INFO - Return code: 0 15:58:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:27 INFO - Reading from file tmpfile_stdout 15:58:27 INFO - Current package versions: 15:58:27 INFO - blessings == 1.6 15:58:27 INFO - blobuploader == 1.2.4 15:58:27 INFO - docopt == 0.6.1 15:58:27 INFO - manifestparser == 1.1 15:58:27 INFO - mozInstall == 1.12 15:58:27 INFO - mozcrash == 0.17 15:58:27 INFO - mozdebug == 0.1 15:58:27 INFO - mozdevice == 0.48 15:58:27 INFO - mozfile == 1.2 15:58:27 INFO - mozhttpd == 0.7 15:58:27 INFO - mozinfo == 0.9 15:58:27 INFO - mozleak == 0.1 15:58:27 INFO - mozlog == 3.1 15:58:27 INFO - moznetwork == 0.27 15:58:27 INFO - mozprocess == 0.22 15:58:27 INFO - mozprofile == 0.28 15:58:27 INFO - mozrunner == 6.11 15:58:27 INFO - mozscreenshot == 0.1 15:58:27 INFO - mozsystemmonitor == 0.0 15:58:27 INFO - moztest == 0.7 15:58:27 INFO - mozversion == 1.4 15:58:27 INFO - psutil == 3.1.1 15:58:27 INFO - requests == 1.2.3 15:58:27 INFO - wsgiref == 0.1.2 15:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:27 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:27 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 15:58:27 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 15:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:27 INFO - 'HOME': '/Users/cltbld', 15:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:27 INFO - 'LOGNAME': 'cltbld', 15:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:27 INFO - 'MOZ_NO_REMOTE': '1', 15:58:27 INFO - 'NO_EM_RESTART': '1', 15:58:27 INFO - 'PAGER': '/bin/cat', 15:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:27 INFO - 'PWD': '/builds/slave/test', 15:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:27 INFO - 'SHELL': '/bin/bash', 15:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:27 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:27 INFO - 'USER': 'cltbld', 15:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:27 INFO - 'XPC_FLAGS': '0x0', 15:58:27 INFO - 'XPC_SERVICE_NAME': '0', 15:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:58:28 INFO - Cleaning up... 15:58:28 INFO - Return code: 0 15:58:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:28 INFO - 'HOME': '/Users/cltbld', 15:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:28 INFO - 'LOGNAME': 'cltbld', 15:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:28 INFO - 'MOZ_NO_REMOTE': '1', 15:58:28 INFO - 'NO_EM_RESTART': '1', 15:58:28 INFO - 'PAGER': '/bin/cat', 15:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:28 INFO - 'PWD': '/builds/slave/test', 15:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:28 INFO - 'SHELL': '/bin/bash', 15:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:28 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:28 INFO - 'USER': 'cltbld', 15:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:28 INFO - 'XPC_FLAGS': '0x0', 15:58:28 INFO - 'XPC_SERVICE_NAME': '0', 15:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:28 INFO - Downloading/unpacking jsonschema 15:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:31 INFO - Downloading/unpacking functools32 (from jsonschema) 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:31 INFO - warning: no files found matching '*.txt' 15:58:31 INFO - no previously-included directories found matching 'build' 15:58:31 INFO - no previously-included directories found matching 'dist' 15:58:31 INFO - no previously-included directories found matching '.git*' 15:58:31 INFO - Installing collected packages: jsonschema, functools32 15:58:31 INFO - Running setup.py install for functools32 15:58:32 INFO - warning: no files found matching '*.txt' 15:58:32 INFO - no previously-included directories found matching 'build' 15:58:32 INFO - no previously-included directories found matching 'dist' 15:58:32 INFO - no previously-included directories found matching '.git*' 15:58:32 INFO - Successfully installed jsonschema functools32 15:58:32 INFO - Cleaning up... 15:58:32 INFO - Return code: 0 15:58:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:58:32 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')]} 15:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:32 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')]} 15:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:32 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 0x10d81da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82aadd3360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, '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.vNbPKvugRE/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.4sUZdMGJBS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 15:58:32 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 15:58:32 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 15:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:58:32 INFO - 'HOME': '/Users/cltbld', 15:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:58:32 INFO - 'LOGNAME': 'cltbld', 15:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:32 INFO - 'MOZ_NO_REMOTE': '1', 15:58:32 INFO - 'NO_EM_RESTART': '1', 15:58:32 INFO - 'PAGER': '/bin/cat', 15:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:32 INFO - 'PWD': '/builds/slave/test', 15:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:58:32 INFO - 'SHELL': '/bin/bash', 15:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:58:32 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:58:32 INFO - 'USER': 'cltbld', 15:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:32 INFO - 'XPC_FLAGS': '0x0', 15:58:32 INFO - 'XPC_SERVICE_NAME': '0', 15:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:32 INFO - Downloading/unpacking flake8 15:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:58:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:58:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:58:36 INFO - no previously-included directories found matching 'docs/_build' 15:58:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:58:36 INFO - Running setup.py install for pep8 15:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:58:36 INFO - no previously-included directories found matching 'docs/_build' 15:58:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:58:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:58:36 INFO - Cleaning up... 15:58:36 INFO - Return code: 0 15:58:36 INFO - Running post-action listener: _resource_record_post_action 15:58:36 INFO - Running post-action listener: _start_resource_monitoring 15:58:36 INFO - Starting resource monitoring. 15:58:36 INFO - ##### 15:58:36 INFO - ##### Running install step. 15:58:36 INFO - ##### 15:58:36 INFO - Running pre-action listener: _resource_record_pre_action 15:58:36 INFO - Running main action method: install 15:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:58:36 INFO - Reading from file tmpfile_stdout 15:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:58:36 INFO - Reading from file tmpfile_stdout 15:58:36 INFO - Output received: 15:58:36 INFO - Usage: mozinstall [options] installer 15:58:36 INFO - Options: 15:58:36 INFO - -h, --help show this help message and exit 15:58:36 INFO - -d DEST, --destination=DEST 15:58:36 INFO - Directory to install application into. [default: 15:58:36 INFO - "/builds/slave/test"] 15:58:36 INFO - --app=APP Application being installed. [default: firefox] 15:58:36 INFO - mkdir: /builds/slave/test/build/application 15:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:59:08 INFO - Reading from file tmpfile_stdout 15:59:08 INFO - Output received: 15:59:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:59:08 INFO - Running post-action listener: _resource_record_post_action 15:59:08 INFO - ##### 15:59:08 INFO - ##### Running run-tests step. 15:59:08 INFO - ##### 15:59:08 INFO - Running pre-action listener: _resource_record_pre_action 15:59:08 INFO - Running main action method: run_tests 15:59:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:59:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:59:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:59:08 INFO - 2016-06-29 15:59:08.880 screenresolution[1993:10682] starting screenresolution argv=screenresolution get 15:59:08 INFO - 2016-06-29 15:59:08.883 screenresolution[1993:10682] Display 0: 1600x1200x32@60 15:59:08 INFO - 2016-06-29 15:59:08.889 screenresolution[1994:10684] starting screenresolution argv=screenresolution list 15:59:08 INFO - Available Modes on Display 0 15:59:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:59:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:59:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:59:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:59:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:59:09 INFO - Intel Iris: 15:59:09 INFO - Chipset Model: Intel Iris 15:59:09 INFO - Type: GPU 15:59:09 INFO - Bus: Built-In 15:59:09 INFO - VRAM (Dynamic, Max): 1536 MB 15:59:09 INFO - Vendor: Intel (0x8086) 15:59:09 INFO - Device ID: 0x0a2e 15:59:09 INFO - Revision ID: 0x0009 15:59:09 INFO - Displays: 15:59:09 INFO - Display: 15:59:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:59:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:59:09 INFO - Display Serial Number: 1600x1200 60 15:59:09 INFO - Main Display: Yes 15:59:09 INFO - Mirror: Off 15:59:09 INFO - Online: Yes 15:59:09 INFO - Rotation: Supported 15:59:09 INFO - Return code: 0 15:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:09 INFO - Python 2.7.3 15:59:09 INFO - Return code: 0 15:59:09 INFO - grabbing minidump binary from tooltool 15:59: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')]} 15:59:09 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 0x10d6c1d30>, '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 0x10d4e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:09 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 15:59:09 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 15:59:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:09 INFO - Return code: 0 15:59:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:59:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:59:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:59:10 INFO - Return code: 0 15:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --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 15:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vNbPKvugRE/Render', 15:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:10 INFO - 'HOME': '/Users/cltbld', 15:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PAGER': '/bin/cat', 15:59:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4sUZdMGJBS/Listeners', 15:59:10 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 15:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - 'XPC_FLAGS': '0x0', 15:59:10 INFO - 'XPC_SERVICE_NAME': '0', 15:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 15:59:10 INFO - mozversion application_buildid: 20160629135046 15:59:10 INFO - mozversion application_changeset: 145e5f7874f84262bcfdcb10270c241842bf1b21 15:59:10 INFO - mozversion application_display_name: Nightly 15:59:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:10 INFO - mozversion application_name: Firefox 15:59:10 INFO - mozversion application_remotingname: firefox 15:59:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 15:59:10 INFO - mozversion application_vendor: Mozilla 15:59:10 INFO - mozversion application_version: 47.0.2 15:59:10 INFO - mozversion platform_buildid: 20160629135046 15:59:10 INFO - mozversion platform_changeset: 145e5f7874f84262bcfdcb10270c241842bf1b21 15:59:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 15:59:10 INFO - mozversion platform_version: 47.0.2 15:59:10 INFO - using testdate: 1467241150 15:59:10 INFO - actual date: 1467241150 15:59:10 INFO - starting webserver on 'localhost:49406' 15:59:10 INFO - SUITE-START | Running 2 tests 15:59:10 INFO - TEST-START | dromaeo_css 15:59:10 INFO - operating with platform_type : mac_ 15:59:10 INFO - Initialising browser for dromaeo_css test... 15:59:10 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpkxBlK0/profile http://localhost:49406/getInfo.html) 15:59:13 INFO - PROCESS | 2012 | __metrics Screen width/height:1600/1200 15:59:13 INFO - PROCESS | 2012 | colorDepth:24 15:59:13 INFO - PROCESS | 2012 | Browser inner width/height: 1024/689 15:59:13 INFO - PROCESS | 2012 | __metrics 15:59:13 ERROR - PROCESS | 2012 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 15:59:13 INFO - TEST-INFO | 2012: exit 0 15:59:13 INFO - Browser initialized. 15:59:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:13 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpkxBlK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:25 INFO - PROCESS | 2015 | RSS: Main: 195727360 15:59:25 INFO - PROCESS | 2015 | 16:00:15 INFO - PROCESS | 2015 | 1467241215367 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] 16:02:26 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49406/tests/dromaeo/cssquery-ext.html) 16:02:28 INFO - PROCESS | 2015 | RSS: Main: 205467648 16:02:28 INFO - PROCESS | 2015 | 16:05:30 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-ext.html (next: http://localhost:49406/tests/dromaeo/cssquery-jquery.html) 16:05:30 INFO - PROCESS | 2015 | RSS: Main: 217649152 16:05:30 INFO - PROCESS | 2015 | 16:08:32 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49406/tests/dromaeo/cssquery-mootools.html) 16:08:32 INFO - PROCESS | 2015 | RSS: Main: 219459584 16:08:32 INFO - PROCESS | 2015 | 16:11:34 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49406/tests/dromaeo/cssquery-prototype.html) 16:11:35 INFO - PROCESS | 2015 | RSS: Main: 223002624 16:11:35 INFO - PROCESS | 2015 | 16:14:37 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49406/tests/dromaeo/cssquery-yui.html) 16:14:38 INFO - PROCESS | 2015 | RSS: Main: 222355456 16:14:38 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49406/tests/dromaeo/cssquery-yui.html (next: http://localhost:49406/tests/dromaeo/cssquery-dojo.html) 16:17:40 INFO - PROCESS | 2015 | RSS: Main: 226406400 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | __start_tp_report 16:17:40 INFO - PROCESS | 2015 | _x_x_mozilla_page_load 16:17:40 INFO - PROCESS | 2015 | _x_x_mozilla_page_load_details 16:17:40 INFO - PROCESS | 2015 | |i|pagename|runs| 16:17:40 INFO - PROCESS | 2015 | |0;dojo.html;2870.856457177141;3538.9115272118192;3569.3753593121196;3590.9640903590966;3616.0959760059986;5154.664946778456;5500.789826238231;5801.158831969362;5802.477777000069;5826.300843898733;5224.973875130629;5362.659335166209;5822.9417705822925;5875.089361149029;5895;5203.843884683456;5266.210068489738;5326.147816349385;5331.920021199685;5341.278927344817;4427.203103441379;4704.753240391299;5160.303359046537;5364.436734142898;5364.570834333244;5198.350206224222;5286.841394758163;5312.415634280245;5319.042572336978;5331.733413329337;5239.449857764956;5263.210518422229;5296.25852380667;5320.866978325535;5361.169018802092;5113.539781419653;5173.3533308336455;5215.035218484592;5231.424543300234;5233;4901.191303434929;5596.552275817925;5631.943680563183;5674.4892959633835;5730.312362516483;6204.47261982732;6323.968380158116;6324.968375158095;6337.397947195009;6341.4292713656;6211.378862113797;6266.185395898549;6300.117983482316;6301.684915754194;6337.87324253517;5907;5941.732622031976;5948.762049517971;5955.40445955401;5974.97012514939;6236.064590311489;6282.340354262828;6293.244810622663;6330.778422755274;6351.364863513611;6194.907076393858;6236.126942228092;6242.28213755424;6253.5622506425025;6255.937440625627;6265.310815810257;6267.968660156761;6281.434670879643;6306.621602703853;6312.400321969406;5047.621428392812;5121.436641969381;6171.166892469549;6296.338884417162;6306.65313407767;5644.096944488944;6159.199304090529;6286.402791734778;6292.4966002719675;6324;4572.51988541205;4942.481039490874;4942.505749425029;4969.304297398367;4989.077020751172;4308.418363520947;4363.018320877841;4411.228035093845;4452.332150177499;4484.439445069366;5835.416458354215;5881.3530511643685;5882.382349853204;5910.674912879833;5927.051671732502;6187.443130118311;6229.221347331583;6252.437280644764;6268.717907694165;6270.655113968775;5665.405132461115;5766.740496677659;5841.795537156264;5847.386024467455;5877.764889404461;5363.19552067193;5369.677819330853;5373.7850485980125;5378.650387724785;5394.136938089965;6345.873082538231;6347.301796802348;6351.269603995507;6365.427111559797;6367.267764207083;6215.65813880241;6231.906521402273;6278.968605157128;6314.747410103728;6317.989121740499;6353.36466353361;6396.26442959047;6397.96801015992;6411.006294024433;6418.4865210783955;4578.885527861697;6225.315215326401;6285.308616052322;6319.3364696706185;6328.525360598066;5168.3797944246935;5967.46292833647;6241.282252541016;6279.372062793684;6310;6113.113598528277;6222.066689996355;6222.439980401786;6231.906521402273;6254.343293954252;4993.525615066563;5988.6706231157705;6224.813255602339;6231.9688401557705;6262.09199666055;5418.834950485664;5694.886102277848;5911.911321330097;5927.436893495111;6141.907871382022;6208.068789681584;6217.689115544295;6220.533459990428;6223.159873417031;6224.190855188796;5961.344252132349;6091.969540152271;6117.755289788359;6131.478824299806;6156.384361563808 16:17:40 INFO - PROCESS | 2015 | |1;ext.html;490.9910134673245;493.7210476081014;528.862944668962;609.8260847867855;660.6531570925264;32289.838550807242;40118;40118.799406003;40404.59595404045;40468.392974105336;41699.54051608194;42222;42240.57759422405;42265.94335141623;42330.576694233125;9536.475493847836;9788.559514821814;9795.559199835989;9797.510124493783;9820.950895245514;9630.614775408976;9700.611975520971;9750.171235444996;9758;9765.560549775277;9656.71029869105;9673.854892176623;9724.902750972506;9752.853707194397;9769.364991275579;7961.243681850215;9272.072792720708;9653.951730241373;9667.371620844622;9711.562979665896;9614.615415383376;9757.756056098584;9766.218702503853;9774.755631109208;9775.853362199572;40569.18861622751;40595.797021015;40727.389089163684;40917.18165636671;41140.38289425661;2853.9714602853915;2940.647122345311;3240.483743061077;3373.780704254216;3429.554157959449;27344.042958496557;27426.725732742816;27968.860155699294;28023.159305220877;28811.42377152466;2783.109404990404;2799.4820958122814;2804.3970546332434;2819.8731057102273;2853.6575610926616;434214;435778;437857;438122.428163581;439184;47767;69281;69716.30283697098;69775.60448791097;69831;47697.76151119222;47935.5206447938;48011.75994120007;48111;48226.517734822206;16943.745843812354;17126.486205413858;17242.568935776457;17255.65488690219;17286.740698889527;13206.207627542379;13592.456301748018;13630.04589678713;13655.590332290047;13657;13256.734865302833;14235.003549751418;15346.846531534766;15446.5366039019;15596.376144954302;5618.595351162209;5928.407159284124;6691.665416729144;6705.396514313735;6714.731410743516;989.8069876374038;992.5533509920565;1038.5689938675366;1092.2245205903898;1093.9115579997954;30582.317972511726;30689.38621227563;30695.9256426024;30845.845770771004;30878.845605772276;1033.2818691009677;1132.9037031852386;1136.7385501334575;1243.2913239453426;1263.4377701922556;11393.829092563617;14053.929730351487;15000;15241.314140863687;15274.465393711167;456021;490213.09786902386;507370;511140;511654;62768.372316277164;62771;63056.73886522336;63660;63735.68132159402;1521.3306145296035;1528.6560523882038;1531.532882470857;1552.5497605694222;1558.9844101559065;22119.889400552893;30166;30854.382912341178;30892.22769430782;31274.843625782636;54958.72520637531;55148.17277740917;55272.17091743708;55474.445255546925;55474.72262638661;479351;480139;482118;702665;710431;42131.57868421276;44004.77997609991;44237.33643995407;44860.551394485636;45479.090418192114;45073.422430214785;45749.77125114486;46376.536234638574;46668.53331466642;47489;38714;39763.00592485095;39886;40830.77507674775;42496.78751606222;39181.02047448837;39853.80073099616;39856.346526542184;40429.39355909605;40899.1820163601;39627.405588916765;39682.603173969044;40091.79954100211;40650.796746017266;40686.796566018165;29421.26446838846;36949.70676026326;37159.071023224635;37271;37466.81266593649;26151.869240653676;26325.473490530465;26466.470670586867;26529;26703.065392711163 16:17:40 INFO - PROCESS | 2015 | |2;jquery.html;336.35419993612265;369.7060836634875;377.43384922616065;383.1436738888582;384.6941681363316;17878.106094695246;20299.49251268717;20912.686309705347;21861.562768744654;22087.668684969718;15971.722262219024;19352.935588542623;21349.466263343424;21647.025883835227;21655.6751648725;4805.447373552051;5265.8946821063555;5882.911756323659;6143.846403839917;6146.969265153668;4458.643308535326;6038.63768173911;6641.800745977628;6669.966650166767;6687.531872768908;6396.648184349859;6590.538662293641;6600.966995165018;6635.933640663604;6637.037629543714;6002.54980876436;6366.108744775735;6687.832804179934;6690.364415380531;6719.328067193291;5738.483536481736;5764.5676574257095;5791.391903850077;5818.156367326714;5820.417958204188;20425.4893627659;26146.215613531625;26311.868440657676;26773.661316934074;26785.196444106707;2189.9562008759895;2287.7712228777154;2399.400149962509;2677.772389346908;2961.466935951528;14765;15074.0201886877;15077.396904123822;15189.772153417707;15308.081515109017;1744;1750.8074111847686;1780.946571602854;1800.3518733256017;1824.6624374490762;96992.54511182338;100753.4962325191;106922.46538767334;107377;108022.45988770084;9020.458772473672;11228.045616122721;11439.428028598537;11690.941545292219;11819.763604727857;14156.433742650179;14197.78703319451;14294.85705142956;14304;14372.928135359256;8899.932008159063;8919.955400222958;9034.954825225832;9079.228265597367;9087.863682044775;7877.921220787834;9154.771130721785;9189.494577798152;9326.300527460467;9327.113924177193;3793.6585707286476;4250.086231460251;4512.4133862597655;4527.864164075083;4564.360989461478;1645.8354164583686;1649.3402638944517;1868.1499917537487;1939.379398592437;1987.960240795205;903.5933829776627;942.4109931292942;970.815545046439;971.174501673586;1075.2204651627508;20180.29368972079;20982;21151.576968460853;21166.153353865982;21477.46306342354;954.2461455450117;1025.4513835098187;1044.8746150461993;1078.7518870659792;1079.9157526625206;11140.554377824796;11244.55021799119;11271.323720576791;11289.20975531705;11870.406479675981;413442;550692;557369;558241.2527624178;632426;127864.36067819787;128313;129111;130689.34655326852;133535;1031.9484025798681;1057.39728354837;1060.7030031591166;1061.9044286014296;1091.1979694924225;18189.45431637053;18865.622687546445;18964.620707585495;18968.905155474135;19230.903845480683;34369;38471.615283846804;53261.668458288856;56027.71986140043;57141.714291428274;76776.61611691906;77311.61344193244;78264;81133;81773;8198.221168988937;8218.58907054633;8275;8280.792980175303;8601.526916019679;7527.209642987407;12057.939710301393;12381.947534459312;12509.874901251234;13314.600561983156;10269.178465722574;11311.547538098714;11630.70923226926;11854.110941679237;12027.579034733742;5283.471652834686;8578.313734901318;11624.88375116238;11735.295882247092;11891.345975971404;7212.963935180501;11613.6515904523;12079.275243485068;12137.453814578188;12213.961813245973;8324.791880202802;8387.748367548984;8397.790055248668;8443.029051658892;8530.616122274389;10520.368777873353;11994.520219191134;12156.939215303866;12393.566225182076;12414.193077449936 16:17:40 INFO - PROCESS | 2015 | |3;mootools.html;1647.6292834112323;1662.1107707376552;1990.9104090315943;2050.2721533855492;2099.9265025724085;8373.706920257791;9011.774705632362;9139.360244782867;9278.489683067428;9325.114114159143;9033.638654453815;9102.27181825454;9103;9164.954175229115;9172.678956236534;2543.885525151373;2545.6126411105947;2552.0940066276485;2571.4985577812336;2571.6528268683674;2507.761762632547;2541.0344069253656;2572.408346080393;2573.2280315905246;2574.2405990232833;1874.8781329213625;2470.1231062972656;2505.711843138035;2552.1960582416477;2579.7033341165725;2119.8728076315315;2441.4618790162262;2558.9360265993314;2567.255495906185;2572.4340645058055;2054.7739748627637;2245.6743772152945;2279.0086312454137;2561;2587.3143616941525;9258.72223833286;9296;9297.349185557014;9342.112499312554;9349.158575728148;4624.838130665445;5693.800716974886;5694.402087780806;5757.913631295534;5791.507721843648;3664.615215402371;3741.981290093532;3763.8870833875026;3777.376732839078;3797.3354662933875;1063.489525027983;1063.6224140430113;1064.11678307005;1064.8615679961556;1070.49151652965;12215.633530993995;12406.25562466255;12410;12540.184887982343;12558.120931534797;5063.088644044107;5083.110455670243;5084.13569693153;5159.25190847325;5200.323957885526;10391.324563903323;10394.844077338847;10464.947675261727;10590.152787776959;10599.84100238497;5614.1859430382365;5696.572757043238;5745.425457454221;5750.683712395775;5767.394423585463;4174.582541745801;4680.134175177535;5161.071007218661;5171.948280517222;5210.739463026834;4110.588941105865;4111.321631930758;4123.505179378494;4135.276326642826;4136.400221967798;1356.9958230909253;1380.2339701465783;1388.7083712420304;1390.1103293891917;1395.8953078519153;1384.7853582694497;1410.7108042851396;1429.8713115819626;1441.7909403136487;1473.2044695864327;8270.338372930151;8287.709930152416;8337;8450.915490845013;8493.702720404755;525.7029778175319;533.7864854058407;536.6431323170126;545.7653209120117;550.6118186678382;6277.654728989858;6311.305756366796;6321.1782468278825;6337.144485494491;6349.396807303298;11131.165162612837;11301.321920684784;11389.829152562717;11398.08815294791;11408.429578521042;10793.352398855937;11135.610253641084;11310.09519238459;11314.717132071599;11329.773404531863;8743.994440639408;8760.299176065899;8836.983746869193;8837.160469755363;8839.248663863644;7900.525968441912;8257.133001035045;8264.338852891635;8274.089850116603;8288.792780180544;8963.282937365126;8992.325575581988;9839.704808855746;9995.900040999497;10083.899161008296;9914.801703966024;10030.548625312025;10055.899441005497;10130.290879638354;10150;7685.807854803675;7713.730019449293;7768.223177682186;7843.333316668147;7857;8409.53747543891;8445.451045682012;8459.661613535389;8495.95752021236;8527.019392769911;7528.849423011399;7666.348360389429;7679.040119985002;7691.846163076595;7927.207279272026;7438.553686778594;7482.326590606872;7488.288612581796;7582.924170758221;7588.772336829904;7878.72424465141;7963.84072318562;8012.31895288907;8015.7595272141925;8046.718364857202;7116.25279345682;7239.312265334996;7240.203577606564;7286.307800758919;7310.415166786751;7407.92592074094;7415.555066696015;7443.962780186064;7460.545193687179;7463.402927765657 16:17:40 INFO - PROCESS | 2015 | |4;prototype.html;342.4914002705981;343.6614934289724;344.81035430513214;346.10186565861613;351.1362049358578;5536.640118392302;6829.1804983402;6856.211535673393;6966.37302642762;6983.685734141963;6845.863082738342;6890.862182756355;6895.655217239143;6895.724171033153;6910.516263861532;4060.5736397678115;4865.026994601077;4949.183384741514;5059.873503162432;5140.511651393121;5046.965372098711;5074.31496747938;5075.873103172432;5082.364704411949;5086.364204474441;5015.22264049073;5017.071841709278;5026.648134630577;5028.170351891933;5040.891003979119;5002.399712034543;5011.571702064913;5019.598432125439;5020.221865610836;5030.874228144289;3644.398674218751;4328.567143285646;4353.608175264241;4371.628411585019;4374.650027997753;6271.247450305992;6551.21385433751;6577.440917522016;6599.373059559334;6621.569597976164;5808.564357673149;5899.5280377570125;5913.05391137416;5916.230889984317;5919.852003699899;7314.926850731478;7327.120745510573;7347.522411043318;7353.852922941564;7354.852902941911;4698;4724.173269677793;4728.692634978715;4730.314104454869;4747.905041899177;7394.149672787645;7613.581253031081;7668.348190403823;7692.0384951881015;7694.153643099255;4614.515475875052;4657.767111644404;4775.761211939389;4776.164171270014;4784.760761961888;4187.790610469525;4718.655183272751;4859.1496488114435;4871.220604703301;4873.415190177201;4486.439195100613;4686.7656617169005;5789.3052833659385;5812.070068788974;5824.504917082096;6212.285587157445;6336.827686877942;6479.773207937794;7331.120265568166;7351.485396022227;1263.437770192274;1683.7137686593308;1695.1608953568063;1700.447354609732;1708.7607734917121;1035.0839507036328;1057.8254587992894;1077.5905156040653;1089.2593036735095;1093.3002878157986;6612.834679132964;6628.403443690091;6635.5023373247195;6667.86664266712;6673.165854268216;7490.438217133627;7491.850162996819;7510.324070833542;7524.322810947041;7545;5429.484199001088;6636.104125942936;6652.567583107082;6653.966730166415;6676.9666151668935;3186.964236623107;3798.9240215196096;3915.8629447969756;3956.940645890314;4000.459937908345;7770.300672939463;7879.606019698992;7957.403194760416;7968.163342848918;7991.0810256821205;7883.5664038478435;7899.644515996794;7903.209679032051;7911.802204944923;7932.484388514728;7939.126696063428;7940.602969851484;7955.880661790194;7964.283214510722;7971.441999060126;7347.55914645123;7630.465867389229;7651.770446886379;7690.154083050972;7703.345215656508;7471.215522370073;7512.924870751441;7525.736599219001;7529.736459223901;7531.962340188264;6791;7435.921791340334;7859.84280314402;7985.600719964094;8031.437799353989;4238.321868501025;4800.759962001816;4804.6876952997945;4805.927911081407;4809.927851082167;7293.744718934812;7571.886421703569;7613;7625.351845093229;7682.270184332479;7351.316769379245;7361.8159546011775;7363.77908662741;7378.372838308589;7390.187079421367;7334.486585938933;7367.373773229336;7367.77896663101;7380.188179300165;7402;6936.028955946273;7150.6424678764815;7182.748603798842;7207.171175314906;7217.7112915484895;6000.309964354155;7359.1169059713175;7371.299726525972;7381.151167615578;7403.185649578434;7197.028401165985;7198.064251647253;7211.6033618151505;7228.4578656599915;7239.312265334785 16:17:40 INFO - PROCESS | 2015 | |5;yui.html;690.64086674929;701.0500771454679;721.7004942948674;774.2257742257746;778.5173192620573;15132.319045642946;15306.770398444032;15330.540083797503;15357.232138393078;15471.303791329388;14215.857841421608;14220.217888016155;16144.1434235063;16349.836501635009;16393.180340982934;790.3519114326255;958.8945216026249;984.5471083301654;987.8666380038675;988.165000574517;924.8982611912684;955.044955044955;976.0434773921561;981.4503877828404;982.6216906491017;988.5847943863558;1027.9383237005804;1031.2729525684374;1040.063942451792;1042.8227201375746;834.7245409015011;884.7611144990816;1009.0766948242386;1026.5124066068595;1029.9639512617023;744.4825846037006;763.5876626621617;771.5062360089547;772.2393442459173;780.2548566119399;15346.079235245921;15385.538433847003;15537.766933496006;15977;16125.596860078474;10555.525001374957;10916.181286403473;12669.809952850715;12882.935585322108;12907.612771616867;10101.747456313578;10197.439140847251;10223.897761022368;10230.539625716861;10415.323004004715;3473.7915725056323;3516.331896939573;3517.683408493248;3562.5368702068563;3588.5873124590485;78341;78391.60804195999;79498.80751788728;79744.60127699382;81093.37813243762;9137.223336016514;9170.495622740813;9403.6708715196;9570.090841370058;9691.70924872255;20819.791802082087;20854.270100546408;21117.68323475149;21539.461513461974;21686.674699879513;7281;7292.671829767673;7324.26757324274;7354.191038985708;7448.217937116633;4016.3975403689096;4058.6753059755147;4088.4071809587444;4092.6725861930972;4145;3700.5929347771726;3715.1826598148364;3749.437584362313;3751.3435148848844;3771.3023090727756;571.5227784799656;670.7384120193128;671.4292851076643;683.7128406069363;687.0484379134834;606.7815586388897;617.1822335405606;623.6676416637729;629.6348118091496;630.7697690343083;6594.802155935234;7976.601169941596;8138.837223255502;8314.459560128573;8327;548.8501589170761;561.6826493031424;600.4865839707074;610.3286384976491;639.6609697379671;3533.4699795030438;3807.961920380816;3835.53973523179;3901.258760835432;3956.5054368203973;89334.10665893387;90229.64655530172;91222.54388728147;91363;91870.54064729634;75081.62132704041;77570.61214694004;83099;84164.57917710372;85949;58504;72156.9176462343;73034.26965730381;74232.25767742253;74635;6647.235567909559;7825;7886.566238856918;7929.286364227247;8012.639431225725;41549;53028.73485632547;53282.40152795422;53493.7325313371;54336.45663543472;57328.56678583069;68676.6566167186;72304.63847680727;72780.63609681917;73211.63394182995;7945.562994035384;9714;10005.499725013575;10007.09936105754;10121.848172277569;10827.621033263798;10869.945650271698;11033.393163376091;11152.553897843994;11721.179517433698;10013.849792252977;10104.292699511258;10196.082352588302;10330.690079297634;10870.565177393131;9554.474503902353;10344.844827327746;10759.946200268949;10815.242932994615;11031.172662050218;10068.496575171359;10084.848727269244;10089.192864570963;10330.431826249629;10339.896601034194;7068.540544864567;8702.390832641655;8887.555622218992;9027;9128.908710912805;8177.836443271221;8671.872656554608;9538.332316738039;9748.452705526377;9855.950720246354 16:17:40 INFO - PROCESS | 2015 | __end_tp_report 16:17:40 INFO - PROCESS | 2015 | __start_cc_report 16:17:40 INFO - PROCESS | 2015 | _x_x_mozilla_cycle_collect,336 16:17:40 INFO - PROCESS | 2015 | __end_cc_report 16:17:40 INFO - PROCESS | 2015 | __startTimestamp1467242260692__endTimestamp 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | ------- Summary: start ------- 16:17:40 INFO - PROCESS | 2015 | Number of tests: 6 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#0] dojo.html Cycles:165 Average:5739.27 Median:5948.76 stddev:678.97 (11.4%) stddev-sans-first:642.68 16:17:40 INFO - PROCESS | 2015 | Values: 2870.9 3538.9 3569.4 3591.0 3616.1 5154.7 5500.8 5801.2 5802.5 5826.3 5225.0 5362.7 5822.9 5875.1 5895.0 5203.8 5266.2 5326.1 5331.9 5341.3 4427.2 4704.8 5160.3 5364.4 5364.6 5198.4 5286.8 5312.4 5319.0 5331.7 5239.4 5263.2 5296.3 5320.9 5361.2 5113.5 5173.4 5215.0 5231.4 5233.0 4901.2 5596.6 5631.9 5674.5 5730.3 6204.5 6324.0 6325.0 6337.4 6341.4 6211.4 6266.2 6300.1 6301.7 6337.9 5907.0 5941.7 5948.8 5955.4 5975.0 6236.1 6282.3 6293.2 6330.8 6351.4 6194.9 6236.1 6242.3 6253.6 6255.9 6265.3 6268.0 6281.4 6306.6 6312.4 5047.6 5121.4 6171.2 6296.3 6306.7 5644.1 6159.2 6286.4 6292.5 6324.0 4572.5 4942.5 4942.5 4969.3 4989.1 4308.4 4363.0 4411.2 4452.3 4484.4 5835.4 5881.4 5882.4 5910.7 5927.1 6187.4 6229.2 6252.4 6268.7 6270.7 5665.4 5766.7 5841.8 5847.4 5877.8 5363.2 5369.7 5373.8 5378.7 5394.1 6345.9 6347.3 6351.3 6365.4 6367.3 6215.7 6231.9 6279.0 6314.7 6318.0 6353.4 6396.3 6398.0 6411.0 6418.5 4578.9 6225.3 6285.3 6319.3 6328.5 5168.4 5967.5 6241.3 6279.4 6310.0 6113.1 6222.1 6222.4 6231.9 6254.3 4993.5 5988.7 6224.8 6232.0 6262.1 5418.8 5694.9 5911.9 5927.4 6141.9 6208.1 6217.7 6220.5 6223.2 6224.2 5961.3 6092.0 6117.8 6131.5 6156.4 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#1] ext.html Cycles:180 Average:65050.82 Median:41028.78 stddev:135388.22 (330.0%) stddev-sans-first:135681.25 16:17:40 INFO - PROCESS | 2015 | Values: 491.0 493.7 528.9 609.8 660.7 32289.8 40118.0 40118.8 40404.6 40468.4 41699.5 42222.0 42240.6 42265.9 42330.6 9536.5 9788.6 9795.6 9797.5 9821.0 9630.6 9700.6 9750.2 9758.0 9765.6 9656.7 9673.9 9724.9 9752.9 9769.4 7961.2 9272.1 9654.0 9667.4 9711.6 9614.6 9757.8 9766.2 9774.8 9775.9 40569.2 40595.8 40727.4 40917.2 41140.4 2854.0 2940.6 3240.5 3373.8 3429.6 27344.0 27426.7 27968.9 28023.2 28811.4 2783.1 2799.5 2804.4 2819.9 2853.7 434214.0 435778.0 437857.0 438122.4 439184.0 47767.0 69281.0 69716.3 69775.6 69831.0 47697.8 47935.5 48011.8 48111.0 48226.5 16943.7 17126.5 17242.6 17255.7 17286.7 13206.2 13592.5 13630.0 13655.6 13657.0 13256.7 14235.0 15346.8 15446.5 15596.4 5618.6 5928.4 6691.7 6705.4 6714.7 989.8 992.6 1038.6 1092.2 1093.9 30582.3 30689.4 30695.9 30845.8 30878.8 1033.3 1132.9 1136.7 1243.3 1263.4 11393.8 14053.9 15000.0 15241.3 15274.5 456021.0 490213.1 507370.0 511140.0 511654.0 62768.4 62771.0 63056.7 63660.0 63735.7 1521.3 1528.7 1531.5 1552.5 1559.0 22119.9 30166.0 30854.4 30892.2 31274.8 54958.7 55148.2 55272.2 55474.4 55474.7 479351.0 480139.0 482118.0 702665.0 710431.0 42131.6 44004.8 44237.3 44860.6 45479.1 45073.4 45749.8 46376.5 46668.5 47489.0 38714.0 39763.0 39886.0 40830.8 42496.8 39181.0 39853.8 39856.3 40429.4 40899.2 39627.4 39682.6 40091.8 40650.8 40686.8 29421.3 36949.7 37159.1 37271.0 37466.8 26151.9 26325.5 26466.5 26529.0 26703.1 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#2] jquery.html Cycles:180 Average:33212.90 Median:12187.72 stddev:91549.57 (751.2%) stddev-sans-first:91773.11 16:17:40 INFO - PROCESS | 2015 | Values: 336.4 369.7 377.4 383.1 384.7 17878.1 20299.5 20912.7 21861.6 22087.7 15971.7 19352.9 21349.5 21647.0 21655.7 4805.4 5265.9 5882.9 6143.8 6147.0 4458.6 6038.6 6641.8 6670.0 6687.5 6396.6 6590.5 6601.0 6635.9 6637.0 6002.5 6366.1 6687.8 6690.4 6719.3 5738.5 5764.6 5791.4 5818.2 5820.4 20425.5 26146.2 26311.9 26773.7 26785.2 2190.0 2287.8 2399.4 2677.8 2961.5 14765.0 15074.0 15077.4 15189.8 15308.1 1744.0 1750.8 1780.9 1800.4 1824.7 96992.5 100753.5 106922.5 107377.0 108022.5 9020.5 11228.0 11439.4 11690.9 11819.8 14156.4 14197.8 14294.9 14304.0 14372.9 8899.9 8920.0 9035.0 9079.2 9087.9 7877.9 9154.8 9189.5 9326.3 9327.1 3793.7 4250.1 4512.4 4527.9 4564.4 1645.8 1649.3 1868.1 1939.4 1988.0 903.6 942.4 970.8 971.2 1075.2 20180.3 20982.0 21151.6 21166.2 21477.5 954.2 1025.5 1044.9 1078.8 1079.9 11140.6 11244.6 11271.3 11289.2 11870.4 413442.0 550692.0 557369.0 558241.3 632426.0 127864.4 128313.0 129111.0 130689.3 133535.0 1031.9 1057.4 1060.7 1061.9 1091.2 18189.5 18865.6 18964.6 18968.9 19230.9 34369.0 38471.6 53261.7 56027.7 57141.7 76776.6 77311.6 78264.0 81133.0 81773.0 8198.2 8218.6 8275.0 8280.8 8601.5 7527.2 12057.9 12381.9 12509.9 13314.6 10269.2 11311.5 11630.7 11854.1 12027.6 5283.5 8578.3 11624.9 11735.3 11891.3 7213.0 11613.7 12079.3 12137.5 12214.0 8324.8 8387.7 8397.8 8443.0 8530.6 10520.4 11994.5 12156.9 12393.6 12414.2 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#3] mootools.html Cycles:180 Average:6278.01 Median:2868.22 stddev:3347.52 (116.7%) stddev-sans-first:3338.82 16:17:40 INFO - PROCESS | 2015 | Values: 1647.6 1662.1 1990.9 2050.3 2099.9 8373.7 9011.8 9139.4 9278.5 9325.1 9033.6 9102.3 9103.0 9165.0 9172.7 2543.9 2545.6 2552.1 2571.5 2571.7 2507.8 2541.0 2572.4 2573.2 2574.2 1874.9 2470.1 2505.7 2552.2 2579.7 2119.9 2441.5 2558.9 2567.3 2572.4 2054.8 2245.7 2279.0 2561.0 2587.3 9258.7 9296.0 9297.3 9342.1 9349.2 4624.8 5693.8 5694.4 5757.9 5791.5 3664.6 3742.0 3763.9 3777.4 3797.3 1063.5 1063.6 1064.1 1064.9 1070.5 12215.6 12406.3 12410.0 12540.2 12558.1 5063.1 5083.1 5084.1 5159.3 5200.3 10391.3 10394.8 10464.9 10590.2 10599.8 5614.2 5696.6 5745.4 5750.7 5767.4 4174.6 4680.1 5161.1 5171.9 5210.7 4110.6 4111.3 4123.5 4135.3 4136.4 1357.0 1380.2 1388.7 1390.1 1395.9 1384.8 1410.7 1429.9 1441.8 1473.2 8270.3 8287.7 8337.0 8450.9 8493.7 525.7 533.8 536.6 545.8 550.6 6277.7 6311.3 6321.2 6337.1 6349.4 11131.2 11301.3 11389.8 11398.1 11408.4 10793.4 11135.6 11310.1 11314.7 11329.8 8744.0 8760.3 8837.0 8837.2 8839.2 7900.5 8257.1 8264.3 8274.1 8288.8 8963.3 8992.3 9839.7 9995.9 10083.9 9914.8 10030.5 10055.9 10130.3 10150.0 7685.8 7713.7 7768.2 7843.3 7857.0 8409.5 8445.5 8459.7 8496.0 8527.0 7528.8 7666.3 7679.0 7691.8 7927.2 7438.6 7482.3 7488.3 7582.9 7588.8 7878.7 7963.8 8012.3 8015.8 8046.7 7116.3 7239.3 7240.2 7286.3 7310.4 7407.9 7415.6 7444.0 7460.5 7463.4 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#4] prototype.html Cycles:180 Average:5932.50 Median:6653.27 stddev:1942.85 (29.2%) stddev-sans-first:1902.46 16:17:40 INFO - PROCESS | 2015 | Values: 342.5 343.7 344.8 346.1 351.1 5536.6 6829.2 6856.2 6966.4 6983.7 6845.9 6890.9 6895.7 6895.7 6910.5 4060.6 4865.0 4949.2 5059.9 5140.5 5047.0 5074.3 5075.9 5082.4 5086.4 5015.2 5017.1 5026.6 5028.2 5040.9 5002.4 5011.6 5019.6 5020.2 5030.9 3644.4 4328.6 4353.6 4371.6 4374.7 6271.2 6551.2 6577.4 6599.4 6621.6 5808.6 5899.5 5913.1 5916.2 5919.9 7314.9 7327.1 7347.5 7353.9 7354.9 4698.0 4724.2 4728.7 4730.3 4747.9 7394.1 7613.6 7668.3 7692.0 7694.2 4614.5 4657.8 4775.8 4776.2 4784.8 4187.8 4718.7 4859.1 4871.2 4873.4 4486.4 4686.8 5789.3 5812.1 5824.5 6212.3 6336.8 6479.8 7331.1 7351.5 1263.4 1683.7 1695.2 1700.4 1708.8 1035.1 1057.8 1077.6 1089.3 1093.3 6612.8 6628.4 6635.5 6667.9 6673.2 7490.4 7491.9 7510.3 7524.3 7545.0 5429.5 6636.1 6652.6 6654.0 6677.0 3187.0 3798.9 3915.9 3956.9 4000.5 7770.3 7879.6 7957.4 7968.2 7991.1 7883.6 7899.6 7903.2 7911.8 7932.5 7939.1 7940.6 7955.9 7964.3 7971.4 7347.6 7630.5 7651.8 7690.2 7703.3 7471.2 7512.9 7525.7 7529.7 7532.0 6791.0 7435.9 7859.8 7985.6 8031.4 4238.3 4800.8 4804.7 4805.9 4809.9 7293.7 7571.9 7613.0 7625.4 7682.3 7351.3 7361.8 7363.8 7378.4 7390.2 7334.5 7367.4 7367.8 7380.2 7402.0 6936.0 7150.6 7182.7 7207.2 7217.7 6000.3 7359.1 7371.3 7381.2 7403.2 7197.0 7198.1 7211.6 7228.5 7239.3 16:17:40 INFO - PROCESS | 2015 | 16:17:40 INFO - PROCESS | 2015 | [#5] yui.html Cycles:180 Average:18219.26 Median:608.56 stddev:25933.46 (4261.5%) stddev-sans-first:25972.81 16:17:40 INFO - PROCESS | 2015 | Values: 690.6 701.1 721.7 774.2 778.5 15132.3 15306.8 15330.5 15357.2 15471.3 14215.9 14220.2 16144.1 16349.8 16393.2 790.4 958.9 984.5 987.9 988.2 924.9 955.0 976.0 981.5 982.6 988.6 1027.9 1031.3 1040.1 1042.8 834.7 884.8 1009.1 1026.5 1030.0 744.5 763.6 771.5 772.2 780.3 15346.1 15385.5 15537.8 15977.0 16125.6 10555.5 10916.2 12669.8 12882.9 12907.6 10101.7 10197.4 10223.9 10230.5 10415.3 3473.8 3516.3 3517.7 3562.5 3588.6 78341.0 78391.6 79498.8 79744.6 81093.4 9137.2 9170.5 9403.7 9570.1 9691.7 20819.8 20854.3 21117.7 21539.5 21686.7 7281.0 7292.7 7324.3 7354.2 7448.2 4016.4 4058.7 4088.4 4092.7 4145.0 3700.6 3715.2 3749.4 3751.3 3771.3 571.5 670.7 671.4 683.7 687.0 606.8 617.2 623.7 629.6 630.8 6594.8 7976.6 8138.8 8314.5 8327.0 548.9 561.7 600.5 610.3 639.7 3533.5 3808.0 3835.5 3901.3 3956.5 89334.1 90229.6 91222.5 91363.0 91870.5 75081.6 77570.6 83099.0 84164.6 85949.0 58504.0 72156.9 73034.3 74232.3 74635.0 6647.2 7825.0 7886.6 7929.3 8012.6 41549.0 53028.7 53282.4 53493.7 54336.5 57328.6 68676.7 72304.6 72780.6 73211.6 7945.6 9714.0 10005.5 10007.1 10121.8 10827.6 10869.9 11033.4 11152.6 11721.2 10013.8 10104.3 10196.1 10330.7 10870.6 9554.5 10344.8 10759.9 10815.2 11031.2 10068.5 10084.8 10089.2 10330.4 10339.9 7068.5 8702.4 8887.6 9027.0 9128.9 8177.8 8671.9 9538.3 9748.5 9856.0 16:17:40 INFO - PROCESS | 2015 | -------- Summary: end -------- 16:17:40 INFO - PROCESS | 2015 | 16:17:41 INFO - TEST-INFO | 2015: exit 0 16:17:41 INFO - TEST-OK | dromaeo_css | took 1110468ms 16:17:41 INFO - TEST-START | kraken 16:17:41 INFO - operating with platform_type : mac_ 16:17:41 INFO - Initialising browser for kraken test... 16:17:41 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpcQY7HH/profile http://localhost:49406/getInfo.html) 16:17:43 INFO - PROCESS | 2021 | __metrics Screen width/height:1600/1200 16:17:43 INFO - PROCESS | 2021 | colorDepth:24 16:17:43 INFO - PROCESS | 2021 | Browser inner width/height: 1024/689 16:17:43 INFO - PROCESS | 2021 | __metrics 16:17:43 ERROR - PROCESS | 2021 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:17:44 INFO - TEST-INFO | 2021: exit 0 16:17:44 INFO - Browser initialized. 16:17:44 INFO - Running cycle 1/1 for kraken test... 16:17:44 INFO - TEST-INFO | started process 2024 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpcQY7HH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:55 INFO - PROCESS | 2024 | RSS: Main: 195592192 16:17:55 INFO - PROCESS | 2024 | 16:17:58 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-beat-detection) 16:17:59 INFO - PROCESS | 2024 | RSS: Main: 207560704 16:17:59 INFO - PROCESS | 2024 | 16:18:02 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-dft) 16:18:02 INFO - PROCESS | 2024 | RSS: Main: 216571904 16:18:02 INFO - PROCESS | 2024 | 16:18:05 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-fft) 16:18:06 INFO - PROCESS | 2024 | RSS: Main: 220106752 16:18:06 INFO - PROCESS | 2024 | 16:18:08 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49406/tests/kraken/driver.html?testName=audio-oscillator) 16:18:09 INFO - PROCESS | 2024 | RSS: Main: 221425664 16:18:09 INFO - PROCESS | 2024 | 16:18:11 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:11 INFO - PROCESS | 2024 | RSS: Main: 221786112 16:18:11 INFO - PROCESS | 2024 | 16:18:14 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:15 INFO - PROCESS | 2024 | RSS: Main: 222384128 16:18:15 INFO - PROCESS | 2024 | 16:18:18 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49406/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:18 INFO - PROCESS | 2024 | RSS: Main: 222298112 16:18:18 INFO - PROCESS | 2024 | 16:18:21 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49406/tests/kraken/driver.html?testName=json-parse-financial) 16:18:22 INFO - PROCESS | 2024 | RSS: Main: 222449664 16:18:22 INFO - PROCESS | 2024 | 16:18:23 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:24 INFO - PROCESS | 2024 | RSS: Main: 222044160 16:18:24 INFO - PROCESS | 2024 | 16:18:25 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:26 INFO - PROCESS | 2024 | RSS: Main: 222023680 16:18:26 INFO - PROCESS | 2024 | 16:18:28 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:29 INFO - PROCESS | 2024 | RSS: Main: 222240768 16:18:29 INFO - PROCESS | 2024 | 16:18:31 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:32 INFO - PROCESS | 2024 | RSS: Main: 222679040 16:18:32 INFO - PROCESS | 2024 | 16:18:34 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:35 INFO - PROCESS | 2024 | RSS: Main: 222384128 16:18:35 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | Cycle 1(1): loaded http://localhost:49406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49406/tests/kraken/driver.html?testName=ai-astar) 16:18:37 INFO - PROCESS | 2024 | RSS: Main: 224079872 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | __start_tp_report 16:18:37 INFO - PROCESS | 2024 | _x_x_mozilla_page_load 16:18:37 INFO - PROCESS | 2024 | _x_x_mozilla_page_load_details 16:18:37 INFO - PROCESS | 2024 | |i|pagename|runs| 16:18:37 INFO - PROCESS | 2024 | |0;ai-astar;115;109;116;128;172;176;115;115;130;170 16:18:37 INFO - PROCESS | 2024 | |1;audio-beat-detection;177;152;146;168;128;175;176;113;180;153 16:18:37 INFO - PROCESS | 2024 | |2;audio-dft;196;199;199;201;217;194;196;195;191;191 16:18:37 INFO - PROCESS | 2024 | |3;audio-fft;70;76;72;113;61;54;59;60;125;55 16:18:37 INFO - PROCESS | 2024 | |4;audio-oscillator;87;78;126;81;81;84;161;98;82;120 16:18:37 INFO - PROCESS | 2024 | |5;imaging-gaussian-blur;88;86;87;86;89;85;93;126;88;88 16:18:37 INFO - PROCESS | 2024 | |6;imaging-darkroom;118;154;152;96;93;103;96;103;122;111 16:18:37 INFO - PROCESS | 2024 | |7;imaging-desaturate;94;93;102;89;93;95;92;92;91;92 16:18:37 INFO - PROCESS | 2024 | |8;json-parse-financial;54;60;60;58;60;60;60;61;59;56 16:18:37 INFO - PROCESS | 2024 | |9;json-stringify-tinderbox;67;70;70;70;66;66;65;66;66;66 16:18:37 INFO - PROCESS | 2024 | |10;stanford-crypto-aes;80;80;84;80;83;89;108;86;81;86 16:18:37 INFO - PROCESS | 2024 | |11;stanford-crypto-ccm;118;121;134;130;118;138;135;118;119;118 16:18:37 INFO - PROCESS | 2024 | |12;stanford-crypto-pbkdf2;148;144;137;138;131;137;135;151;135;137 16:18:37 INFO - PROCESS | 2024 | |13;stanford-crypto-sha256-iterative;67;65;69;90;101;93;95;69;65;66 16:18:37 INFO - PROCESS | 2024 | __end_tp_report 16:18:37 INFO - PROCESS | 2024 | __start_cc_report 16:18:37 INFO - PROCESS | 2024 | _x_x_mozilla_cycle_collect,904 16:18:37 INFO - PROCESS | 2024 | __end_cc_report 16:18:37 INFO - PROCESS | 2024 | __startTimestamp1467242317507__endTimestamp 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | ------- Summary: start ------- 16:18:37 INFO - PROCESS | 2024 | Number of tests: 14 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#0] ai-astar Cycles:10 Average:134.60 Median:129.00 stddev:27.05 (21.0%) stddev-sans-first:27.74 16:18:37 INFO - PROCESS | 2024 | Values: 115.0 109.0 116.0 128.0 172.0 176.0 115.0 115.0 130.0 170.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:171.50 stddev:22.79 (13.3%) stddev-sans-first:22.97 16:18:37 INFO - PROCESS | 2024 | Values: 177.0 152.0 146.0 168.0 128.0 175.0 176.0 113.0 180.0 153.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#2] audio-dft Cycles:10 Average:197.90 Median:197.50 stddev:7.48 (3.8%) stddev-sans-first:7.90 16:18:37 INFO - PROCESS | 2024 | Values: 196.0 199.0 199.0 201.0 217.0 194.0 196.0 195.0 191.0 191.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#3] audio-fft Cycles:10 Average:74.50 Median:60.50 stddev:24.71 (40.8%) stddev-sans-first:26.15 16:18:37 INFO - PROCESS | 2024 | Values: 70.0 76.0 72.0 113.0 61.0 54.0 59.0 60.0 125.0 55.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:81.50 stddev:27.40 (33.6%) stddev-sans-first:28.67 16:18:37 INFO - PROCESS | 2024 | Values: 87.0 78.0 126.0 81.0 81.0 84.0 161.0 98.0 82.0 120.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.00 stddev:12.29 (14.0%) stddev-sans-first:12.96 16:18:37 INFO - PROCESS | 2024 | Values: 88.0 86.0 87.0 86.0 89.0 85.0 93.0 126.0 88.0 88.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#6] imaging-darkroom Cycles:10 Average:114.80 Median:153.00 stddev:22.26 (14.5%) stddev-sans-first:23.57 16:18:37 INFO - PROCESS | 2024 | Values: 118.0 154.0 152.0 96.0 93.0 103.0 96.0 103.0 122.0 111.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:92.50 stddev:3.47 (3.7%) stddev-sans-first:3.67 16:18:37 INFO - PROCESS | 2024 | Values: 94.0 93.0 102.0 89.0 93.0 95.0 92.0 92.0 91.0 92.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:60.00 stddev:2.20 (3.7%) stddev-sans-first:1.50 16:18:37 INFO - PROCESS | 2024 | Values: 54.0 60.0 60.0 58.0 60.0 60.0 60.0 61.0 59.0 56.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:66.50 stddev:1.99 (3.0%) stddev-sans-first:2.11 16:18:37 INFO - PROCESS | 2024 | Values: 67.0 70.0 70.0 70.0 66.0 66.0 65.0 66.0 66.0 66.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.50 stddev:8.42 (10.1%) stddev-sans-first:8.67 16:18:37 INFO - PROCESS | 2024 | Values: 80.0 80.0 84.0 80.0 83.0 89.0 108.0 86.0 81.0 86.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.50 stddev:8.32 (6.6%) stddev-sans-first:8.44 16:18:37 INFO - PROCESS | 2024 | Values: 118.0 121.0 134.0 130.0 118.0 138.0 135.0 118.0 119.0 118.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.30 Median:137.50 stddev:6.31 (4.6%) stddev-sans-first:5.85 16:18:37 INFO - PROCESS | 2024 | Values: 148.0 144.0 137.0 138.0 131.0 137.0 135.0 151.0 135.0 137.0 16:18:37 INFO - PROCESS | 2024 | 16:18:37 INFO - PROCESS | 2024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:69.00 stddev:14.73 (21.3%) stddev-sans-first:15.07 16:18:37 INFO - PROCESS | 2024 | Values: 67.0 65.0 69.0 90.0 101.0 93.0 95.0 69.0 65.0 66.0 16:18:37 INFO - PROCESS | 2024 | -------- Summary: end -------- 16:18:37 INFO - PROCESS | 2024 | 16:18:38 INFO - TEST-INFO | 2024: exit 0 16:18:38 INFO - TEST-OK | kraken | took 57096ms 16:18:38 INFO - SUITE-END | took 1167s 16:18:38 INFO - Completed test suite (00:19:28) 16:18:38 INFO - javascript benchmark 16:18:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2870.856457177141, 3538.9115272118192, 3569.3753593121196, 3590.9640903590966, 3616.0959760059986, 5154.664946778456, 5500.789826238231, 5801.158831969362, 5802.477777000069, 5826.300843898733, 5224.973875130629, 5362.659335166209, 5822.9417705822925, 5875.089361149029, 5895.0, 5203.843884683456, 5266.210068489738, 5326.147816349385, 5331.920021199685, 5341.278927344817, 4427.203103441379, 4704.753240391299, 5160.303359046537, 5364.436734142898, 5364.570834333244, 5198.350206224222, 5286.841394758163, 5312.415634280245, 5319.042572336978, 5331.733413329337, 5239.449857764956, 5263.210518422229, 5296.25852380667, 5320.866978325535, 5361.169018802092, 5113.539781419653, 5173.3533308336455, 5215.035218484592, 5231.424543300234, 5233.0, 4901.191303434929, 5596.552275817925, 5631.943680563183, 5674.4892959633835, 5730.312362516483, 6204.47261982732, 6323.968380158116, 6324.968375158095, 6337.397947195009, 6341.4292713656, 6211.378862113797, 6266.185395898549, 6300.117983482316, 6301.684915754194, 6337.87324253517, 5907.0, 5941.732622031976, 5948.762049517971, 5955.40445955401, 5974.97012514939, 6236.064590311489, 6282.340354262828, 6293.244810622663, 6330.778422755274, 6351.364863513611, 6194.907076393858, 6236.126942228092, 6242.28213755424, 6253.5622506425025, 6255.937440625627, 6265.310815810257, 6267.968660156761, 6281.434670879643, 6306.621602703853, 6312.400321969406, 5047.621428392812, 5121.436641969381, 6171.166892469549, 6296.338884417162, 6306.65313407767, 5644.096944488944, 6159.199304090529, 6286.402791734778, 6292.4966002719675, 6324.0, 4572.51988541205, 4942.481039490874, 4942.505749425029, 4969.304297398367, 4989.077020751172, 4308.418363520947, 4363.018320877841, 4411.228035093845, 4452.332150177499, 4484.439445069366, 5835.416458354215, 5881.3530511643685, 5882.382349853204, 5910.674912879833, 5927.051671732502, 6187.443130118311, 6229.221347331583, 6252.437280644764, 6268.717907694165, 6270.655113968775, 5665.405132461115, 5766.740496677659, 5841.795537156264, 5847.386024467455, 5877.764889404461, 5363.19552067193, 5369.677819330853, 5373.7850485980125, 5378.650387724785, 5394.136938089965, 6345.873082538231, 6347.301796802348, 6351.269603995507, 6365.427111559797, 6367.267764207083, 6215.65813880241, 6231.906521402273, 6278.968605157128, 6314.747410103728, 6317.989121740499, 6353.36466353361, 6396.26442959047, 6397.96801015992, 6411.006294024433, 6418.4865210783955, 4578.885527861697, 6225.315215326401, 6285.308616052322, 6319.3364696706185, 6328.525360598066, 5168.3797944246935, 5967.46292833647, 6241.282252541016, 6279.372062793684, 6310.0, 6113.113598528277, 6222.066689996355, 6222.439980401786, 6231.906521402273, 6254.343293954252, 4993.525615066563, 5988.6706231157705, 6224.813255602339, 6231.9688401557705, 6262.09199666055, 5418.834950485664, 5694.886102277848, 5911.911321330097, 5927.436893495111, 6141.907871382022, 6208.068789681584, 6217.689115544295, 6220.533459990428, 6223.159873417031, 6224.190855188796, 5961.344252132349, 6091.969540152271, 6117.755289788359, 6131.478824299806, 6156.384361563808], "unit": "score", "name": "dojo.html", "value": 5698.203052592046}, {"lowerIsBetter": false, "replicates": [490.9910134673245, 493.7210476081014, 528.862944668962, 609.8260847867855, 660.6531570925264, 32289.838550807242, 40118.0, 40118.799406003, 40404.59595404045, 40468.392974105336, 41699.54051608194, 42222.0, 42240.57759422405, 42265.94335141623, 42330.576694233125, 9536.475493847836, 9788.559514821814, 9795.559199835989, 9797.510124493783, 9820.950895245514, 9630.614775408976, 9700.611975520971, 9750.171235444996, 9758.0, 9765.560549775277, 9656.71029869105, 9673.854892176623, 9724.902750972506, 9752.853707194397, 9769.364991275579, 7961.243681850215, 9272.072792720708, 9653.951730241373, 9667.371620844622, 9711.562979665896, 9614.615415383376, 9757.756056098584, 9766.218702503853, 9774.755631109208, 9775.853362199572, 40569.18861622751, 40595.797021015, 40727.389089163684, 40917.18165636671, 41140.38289425661, 2853.9714602853915, 2940.647122345311, 3240.483743061077, 3373.780704254216, 3429.554157959449, 27344.042958496557, 27426.725732742816, 27968.860155699294, 28023.159305220877, 28811.42377152466, 2783.109404990404, 2799.4820958122814, 2804.3970546332434, 2819.8731057102273, 2853.6575610926616, 434214.0, 435778.0, 437857.0, 438122.428163581, 439184.0, 47767.0, 69281.0, 69716.30283697098, 69775.60448791097, 69831.0, 47697.76151119222, 47935.5206447938, 48011.75994120007, 48111.0, 48226.517734822206, 16943.745843812354, 17126.486205413858, 17242.568935776457, 17255.65488690219, 17286.740698889527, 13206.207627542379, 13592.456301748018, 13630.04589678713, 13655.590332290047, 13657.0, 13256.734865302833, 14235.003549751418, 15346.846531534766, 15446.5366039019, 15596.376144954302, 5618.595351162209, 5928.407159284124, 6691.665416729144, 6705.396514313735, 6714.731410743516, 989.8069876374038, 992.5533509920565, 1038.5689938675366, 1092.2245205903898, 1093.9115579997954, 30582.317972511726, 30689.38621227563, 30695.9256426024, 30845.845770771004, 30878.845605772276, 1033.2818691009677, 1132.9037031852386, 1136.7385501334575, 1243.2913239453426, 1263.4377701922556, 11393.829092563617, 14053.929730351487, 15000.0, 15241.314140863687, 15274.465393711167, 456021.0, 490213.09786902386, 507370.0, 511140.0, 511654.0, 62768.372316277164, 62771.0, 63056.73886522336, 63660.0, 63735.68132159402, 1521.3306145296035, 1528.6560523882038, 1531.532882470857, 1552.5497605694222, 1558.9844101559065, 22119.889400552893, 30166.0, 30854.382912341178, 30892.22769430782, 31274.843625782636, 54958.72520637531, 55148.17277740917, 55272.17091743708, 55474.445255546925, 55474.72262638661, 479351.0, 480139.0, 482118.0, 702665.0, 710431.0, 42131.57868421276, 44004.77997609991, 44237.33643995407, 44860.551394485636, 45479.090418192114, 45073.422430214785, 45749.77125114486, 46376.536234638574, 46668.53331466642, 47489.0, 38714.0, 39763.00592485095, 39886.0, 40830.77507674775, 42496.78751606222, 39181.02047448837, 39853.80073099616, 39856.346526542184, 40429.39355909605, 40899.1820163601, 39627.405588916765, 39682.603173969044, 40091.79954100211, 40650.796746017266, 40686.796566018165, 29421.26446838846, 36949.70676026326, 37159.071023224635, 37271.0, 37466.81266593649, 26151.869240653676, 26325.473490530465, 26466.470670586867, 26529.0, 26703.065392711163], "unit": "score", "name": "ext.html", "value": 19982.22678326295}, {"lowerIsBetter": false, "replicates": [336.35419993612265, 369.7060836634875, 377.43384922616065, 383.1436738888582, 384.6941681363316, 17878.106094695246, 20299.49251268717, 20912.686309705347, 21861.562768744654, 22087.668684969718, 15971.722262219024, 19352.935588542623, 21349.466263343424, 21647.025883835227, 21655.6751648725, 4805.447373552051, 5265.8946821063555, 5882.911756323659, 6143.846403839917, 6146.969265153668, 4458.643308535326, 6038.63768173911, 6641.800745977628, 6669.966650166767, 6687.531872768908, 6396.648184349859, 6590.538662293641, 6600.966995165018, 6635.933640663604, 6637.037629543714, 6002.54980876436, 6366.108744775735, 6687.832804179934, 6690.364415380531, 6719.328067193291, 5738.483536481736, 5764.5676574257095, 5791.391903850077, 5818.156367326714, 5820.417958204188, 20425.4893627659, 26146.215613531625, 26311.868440657676, 26773.661316934074, 26785.196444106707, 2189.9562008759895, 2287.7712228777154, 2399.400149962509, 2677.772389346908, 2961.466935951528, 14765.0, 15074.0201886877, 15077.396904123822, 15189.772153417707, 15308.081515109017, 1744.0, 1750.8074111847686, 1780.946571602854, 1800.3518733256017, 1824.6624374490762, 96992.54511182338, 100753.4962325191, 106922.46538767334, 107377.0, 108022.45988770084, 9020.458772473672, 11228.045616122721, 11439.428028598537, 11690.941545292219, 11819.763604727857, 14156.433742650179, 14197.78703319451, 14294.85705142956, 14304.0, 14372.928135359256, 8899.932008159063, 8919.955400222958, 9034.954825225832, 9079.228265597367, 9087.863682044775, 7877.921220787834, 9154.771130721785, 9189.494577798152, 9326.300527460467, 9327.113924177193, 3793.6585707286476, 4250.086231460251, 4512.4133862597655, 4527.864164075083, 4564.360989461478, 1645.8354164583686, 1649.3402638944517, 1868.1499917537487, 1939.379398592437, 1987.960240795205, 903.5933829776627, 942.4109931292942, 970.815545046439, 971.174501673586, 1075.2204651627508, 20180.29368972079, 20982.0, 21151.576968460853, 21166.153353865982, 21477.46306342354, 954.2461455450117, 1025.4513835098187, 1044.8746150461993, 1078.7518870659792, 1079.9157526625206, 11140.554377824796, 11244.55021799119, 11271.323720576791, 11289.20975531705, 11870.406479675981, 413442.0, 550692.0, 557369.0, 558241.2527624178, 632426.0, 127864.36067819787, 128313.0, 129111.0, 130689.34655326852, 133535.0, 1031.9484025798681, 1057.39728354837, 1060.7030031591166, 1061.9044286014296, 1091.1979694924225, 18189.45431637053, 18865.622687546445, 18964.620707585495, 18968.905155474135, 19230.903845480683, 34369.0, 38471.615283846804, 53261.668458288856, 56027.71986140043, 57141.714291428274, 76776.61611691906, 77311.61344193244, 78264.0, 81133.0, 81773.0, 8198.221168988937, 8218.58907054633, 8275.0, 8280.792980175303, 8601.526916019679, 7527.209642987407, 12057.939710301393, 12381.947534459312, 12509.874901251234, 13314.600561983156, 10269.178465722574, 11311.547538098714, 11630.70923226926, 11854.110941679237, 12027.579034733742, 5283.471652834686, 8578.313734901318, 11624.88375116238, 11735.295882247092, 11891.345975971404, 7212.963935180501, 11613.6515904523, 12079.275243485068, 12137.453814578188, 12213.961813245973, 8324.791880202802, 8387.748367548984, 8397.790055248668, 8443.029051658892, 8530.616122274389, 10520.368777873353, 11994.520219191134, 12156.939215303866, 12393.566225182076, 12414.193077449936], "unit": "score", "name": "jquery.html", "value": 9715.30201349231}, {"lowerIsBetter": false, "replicates": [1647.6292834112323, 1662.1107707376552, 1990.9104090315943, 2050.2721533855492, 2099.9265025724085, 8373.706920257791, 9011.774705632362, 9139.360244782867, 9278.489683067428, 9325.114114159143, 9033.638654453815, 9102.27181825454, 9103.0, 9164.954175229115, 9172.678956236534, 2543.885525151373, 2545.6126411105947, 2552.0940066276485, 2571.4985577812336, 2571.6528268683674, 2507.761762632547, 2541.0344069253656, 2572.408346080393, 2573.2280315905246, 2574.2405990232833, 1874.8781329213625, 2470.1231062972656, 2505.711843138035, 2552.1960582416477, 2579.7033341165725, 2119.8728076315315, 2441.4618790162262, 2558.9360265993314, 2567.255495906185, 2572.4340645058055, 2054.7739748627637, 2245.6743772152945, 2279.0086312454137, 2561.0, 2587.3143616941525, 9258.72223833286, 9296.0, 9297.349185557014, 9342.112499312554, 9349.158575728148, 4624.838130665445, 5693.800716974886, 5694.402087780806, 5757.913631295534, 5791.507721843648, 3664.615215402371, 3741.981290093532, 3763.8870833875026, 3777.376732839078, 3797.3354662933875, 1063.489525027983, 1063.6224140430113, 1064.11678307005, 1064.8615679961556, 1070.49151652965, 12215.633530993995, 12406.25562466255, 12410.0, 12540.184887982343, 12558.120931534797, 5063.088644044107, 5083.110455670243, 5084.13569693153, 5159.25190847325, 5200.323957885526, 10391.324563903323, 10394.844077338847, 10464.947675261727, 10590.152787776959, 10599.84100238497, 5614.1859430382365, 5696.572757043238, 5745.425457454221, 5750.683712395775, 5767.394423585463, 4174.582541745801, 4680.134175177535, 5161.071007218661, 5171.948280517222, 5210.739463026834, 4110.588941105865, 4111.321631930758, 4123.505179378494, 4135.276326642826, 4136.400221967798, 1356.9958230909253, 1380.2339701465783, 1388.7083712420304, 1390.1103293891917, 1395.8953078519153, 1384.7853582694497, 1410.7108042851396, 1429.8713115819626, 1441.7909403136487, 1473.2044695864327, 8270.338372930151, 8287.709930152416, 8337.0, 8450.915490845013, 8493.702720404755, 525.7029778175319, 533.7864854058407, 536.6431323170126, 545.7653209120117, 550.6118186678382, 6277.654728989858, 6311.305756366796, 6321.1782468278825, 6337.144485494491, 6349.396807303298, 11131.165162612837, 11301.321920684784, 11389.829152562717, 11398.08815294791, 11408.429578521042, 10793.352398855937, 11135.610253641084, 11310.09519238459, 11314.717132071599, 11329.773404531863, 8743.994440639408, 8760.299176065899, 8836.983746869193, 8837.160469755363, 8839.248663863644, 7900.525968441912, 8257.133001035045, 8264.338852891635, 8274.089850116603, 8288.792780180544, 8963.282937365126, 8992.325575581988, 9839.704808855746, 9995.900040999497, 10083.899161008296, 9914.801703966024, 10030.548625312025, 10055.899441005497, 10130.290879638354, 10150.0, 7685.807854803675, 7713.730019449293, 7768.223177682186, 7843.333316668147, 7857.0, 8409.53747543891, 8445.451045682012, 8459.661613535389, 8495.95752021236, 8527.019392769911, 7528.849423011399, 7666.348360389429, 7679.040119985002, 7691.846163076595, 7927.207279272026, 7438.553686778594, 7482.326590606872, 7488.288612581796, 7582.924170758221, 7588.772336829904, 7878.72424465141, 7963.84072318562, 8012.31895288907, 8015.7595272141925, 8046.718364857202, 7116.25279345682, 7239.312265334996, 7240.203577606564, 7286.307800758919, 7310.415166786751, 7407.92592074094, 7415.555066696015, 7443.962780186064, 7460.545193687179, 7463.402927765657], "unit": "score", "name": "mootools.html", "value": 5028.581645948743}, {"lowerIsBetter": false, "replicates": [342.4914002705981, 343.6614934289724, 344.81035430513214, 346.10186565861613, 351.1362049358578, 5536.640118392302, 6829.1804983402, 6856.211535673393, 6966.37302642762, 6983.685734141963, 6845.863082738342, 6890.862182756355, 6895.655217239143, 6895.724171033153, 6910.516263861532, 4060.5736397678115, 4865.026994601077, 4949.183384741514, 5059.873503162432, 5140.511651393121, 5046.965372098711, 5074.31496747938, 5075.873103172432, 5082.364704411949, 5086.364204474441, 5015.22264049073, 5017.071841709278, 5026.648134630577, 5028.170351891933, 5040.891003979119, 5002.399712034543, 5011.571702064913, 5019.598432125439, 5020.221865610836, 5030.874228144289, 3644.398674218751, 4328.567143285646, 4353.608175264241, 4371.628411585019, 4374.650027997753, 6271.247450305992, 6551.21385433751, 6577.440917522016, 6599.373059559334, 6621.569597976164, 5808.564357673149, 5899.5280377570125, 5913.05391137416, 5916.230889984317, 5919.852003699899, 7314.926850731478, 7327.120745510573, 7347.522411043318, 7353.852922941564, 7354.852902941911, 4698.0, 4724.173269677793, 4728.692634978715, 4730.314104454869, 4747.905041899177, 7394.149672787645, 7613.581253031081, 7668.348190403823, 7692.0384951881015, 7694.153643099255, 4614.515475875052, 4657.767111644404, 4775.761211939389, 4776.164171270014, 4784.760761961888, 4187.790610469525, 4718.655183272751, 4859.1496488114435, 4871.220604703301, 4873.415190177201, 4486.439195100613, 4686.7656617169005, 5789.3052833659385, 5812.070068788974, 5824.504917082096, 6212.285587157445, 6336.827686877942, 6479.773207937794, 7331.120265568166, 7351.485396022227, 1263.437770192274, 1683.7137686593308, 1695.1608953568063, 1700.447354609732, 1708.7607734917121, 1035.0839507036328, 1057.8254587992894, 1077.5905156040653, 1089.2593036735095, 1093.3002878157986, 6612.834679132964, 6628.403443690091, 6635.5023373247195, 6667.86664266712, 6673.165854268216, 7490.438217133627, 7491.850162996819, 7510.324070833542, 7524.322810947041, 7545.0, 5429.484199001088, 6636.104125942936, 6652.567583107082, 6653.966730166415, 6676.9666151668935, 3186.964236623107, 3798.9240215196096, 3915.8629447969756, 3956.940645890314, 4000.459937908345, 7770.300672939463, 7879.606019698992, 7957.403194760416, 7968.163342848918, 7991.0810256821205, 7883.5664038478435, 7899.644515996794, 7903.209679032051, 7911.802204944923, 7932.484388514728, 7939.126696063428, 7940.602969851484, 7955.880661790194, 7964.283214510722, 7971.441999060126, 7347.55914645123, 7630.465867389229, 7651.770446886379, 7690.154083050972, 7703.345215656508, 7471.215522370073, 7512.924870751441, 7525.736599219001, 7529.736459223901, 7531.962340188264, 6791.0, 7435.921791340334, 7859.84280314402, 7985.600719964094, 8031.437799353989, 4238.321868501025, 4800.759962001816, 4804.6876952997945, 4805.927911081407, 4809.927851082167, 7293.744718934812, 7571.886421703569, 7613.0, 7625.351845093229, 7682.270184332479, 7351.316769379245, 7361.8159546011775, 7363.77908662741, 7378.372838308589, 7390.187079421367, 7334.486585938933, 7367.373773229336, 7367.77896663101, 7380.188179300165, 7402.0, 6936.028955946273, 7150.6424678764815, 7182.748603798842, 7207.171175314906, 7217.7112915484895, 6000.309964354155, 7359.1169059713175, 7371.299726525972, 7381.151167615578, 7403.185649578434, 7197.028401165985, 7198.064251647253, 7211.6033618151505, 7228.4578656599915, 7239.312265334785], "unit": "score", "name": "prototype.html", "value": 5282.942859892967}, {"lowerIsBetter": false, "replicates": [690.64086674929, 701.0500771454679, 721.7004942948674, 774.2257742257746, 778.5173192620573, 15132.319045642946, 15306.770398444032, 15330.540083797503, 15357.232138393078, 15471.303791329388, 14215.857841421608, 14220.217888016155, 16144.1434235063, 16349.836501635009, 16393.180340982934, 790.3519114326255, 958.8945216026249, 984.5471083301654, 987.8666380038675, 988.165000574517, 924.8982611912684, 955.044955044955, 976.0434773921561, 981.4503877828404, 982.6216906491017, 988.5847943863558, 1027.9383237005804, 1031.2729525684374, 1040.063942451792, 1042.8227201375746, 834.7245409015011, 884.7611144990816, 1009.0766948242386, 1026.5124066068595, 1029.9639512617023, 744.4825846037006, 763.5876626621617, 771.5062360089547, 772.2393442459173, 780.2548566119399, 15346.079235245921, 15385.538433847003, 15537.766933496006, 15977.0, 16125.596860078474, 10555.525001374957, 10916.181286403473, 12669.809952850715, 12882.935585322108, 12907.612771616867, 10101.747456313578, 10197.439140847251, 10223.897761022368, 10230.539625716861, 10415.323004004715, 3473.7915725056323, 3516.331896939573, 3517.683408493248, 3562.5368702068563, 3588.5873124590485, 78341.0, 78391.60804195999, 79498.80751788728, 79744.60127699382, 81093.37813243762, 9137.223336016514, 9170.495622740813, 9403.6708715196, 9570.090841370058, 9691.70924872255, 20819.791802082087, 20854.270100546408, 21117.68323475149, 21539.461513461974, 21686.674699879513, 7281.0, 7292.671829767673, 7324.26757324274, 7354.191038985708, 7448.217937116633, 4016.3975403689096, 4058.6753059755147, 4088.4071809587444, 4092.6725861930972, 4145.0, 3700.5929347771726, 3715.1826598148364, 3749.437584362313, 3751.3435148848844, 3771.3023090727756, 571.5227784799656, 670.7384120193128, 671.4292851076643, 683.7128406069363, 687.0484379134834, 606.7815586388897, 617.1822335405606, 623.6676416637729, 629.6348118091496, 630.7697690343083, 6594.802155935234, 7976.601169941596, 8138.837223255502, 8314.459560128573, 8327.0, 548.8501589170761, 561.6826493031424, 600.4865839707074, 610.3286384976491, 639.6609697379671, 3533.4699795030438, 3807.961920380816, 3835.53973523179, 3901.258760835432, 3956.5054368203973, 89334.10665893387, 90229.64655530172, 91222.54388728147, 91363.0, 91870.54064729634, 75081.62132704041, 77570.61214694004, 83099.0, 84164.57917710372, 85949.0, 58504.0, 72156.9176462343, 73034.26965730381, 74232.25767742253, 74635.0, 6647.235567909559, 7825.0, 7886.566238856918, 7929.286364227247, 8012.639431225725, 41549.0, 53028.73485632547, 53282.40152795422, 53493.7325313371, 54336.45663543472, 57328.56678583069, 68676.6566167186, 72304.63847680727, 72780.63609681917, 73211.63394182995, 7945.562994035384, 9714.0, 10005.499725013575, 10007.09936105754, 10121.848172277569, 10827.621033263798, 10869.945650271698, 11033.393163376091, 11152.553897843994, 11721.179517433698, 10013.849792252977, 10104.292699511258, 10196.082352588302, 10330.690079297634, 10870.565177393131, 9554.474503902353, 10344.844827327746, 10759.946200268949, 10815.242932994615, 11031.172662050218, 10068.496575171359, 10084.848727269244, 10089.192864570963, 10330.431826249629, 10339.896601034194, 7068.540544864567, 8702.390832641655, 8887.555622218992, 9027.0, 9128.908710912805, 8177.836443271221, 8671.872656554608, 9538.332316738039, 9748.452705526377, 9855.950720246354], "unit": "score", "name": "yui.html", "value": 6869.933419902339}], "name": "dromaeo_css", "value": 7659.334686140755}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 116.0, 128.0, 172.0, 176.0, 115.0, 115.0, 130.0, 170.0], "unit": "score", "name": "ai-astar", "value": 134.6}, {"lowerIsBetter": true, "replicates": [177.0, 152.0, 146.0, 168.0, 128.0, 175.0, 176.0, 113.0, 180.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 156.8}, {"lowerIsBetter": true, "replicates": [196.0, 199.0, 199.0, 201.0, 217.0, 194.0, 196.0, 195.0, 191.0, 191.0], "unit": "score", "name": "audio-dft", "value": 197.9}, {"lowerIsBetter": true, "replicates": [70.0, 76.0, 72.0, 113.0, 61.0, 54.0, 59.0, 60.0, 125.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [87.0, 78.0, 126.0, 81.0, 81.0, 84.0, 161.0, 98.0, 82.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 99.8}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 87.0, 86.0, 89.0, 85.0, 93.0, 126.0, 88.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.6}, {"lowerIsBetter": true, "replicates": [118.0, 154.0, 152.0, 96.0, 93.0, 103.0, 96.0, 103.0, 122.0, 111.0], "unit": "score", "name": "imaging-darkroom", "value": 114.8}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 102.0, 89.0, 93.0, 95.0, 92.0, 92.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 93.3}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 60.0, 58.0, 60.0, 60.0, 60.0, 61.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 70.0, 70.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 84.0, 80.0, 83.0, 89.0, 108.0, 86.0, 81.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 134.0, 130.0, 118.0, 138.0, 135.0, 118.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [148.0, 144.0, 137.0, 138.0, 131.0, 137.0, 135.0, 151.0, 135.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.3}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 69.0, 90.0, 101.0, 93.0, 95.0, 69.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.0}], "name": "kraken", "value": 1517.1999999999998}]} 16:18:38 INFO - Return code: 0 16:18:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:18:38 ERROR - # TBPL SUCCESS # 16:18:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:18:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:18:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:18:38 INFO - 2016-06-29 16:18:38.831 screenresolution[2029:13335] starting screenresolution argv=screenresolution get 16:18:38 INFO - 2016-06-29 16:18:38.834 screenresolution[2029:13335] Display 0: 1600x1200x32@60 16:18:38 INFO - 2016-06-29 16:18:38.840 screenresolution[2030:13338] starting screenresolution argv=screenresolution list 16:18:38 INFO - Available Modes on Display 0 16:18:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:18:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:18:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:18:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:18:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:18:39 INFO - Intel Iris: 16:18:39 INFO - Chipset Model: Intel Iris 16:18:39 INFO - Type: GPU 16:18:39 INFO - Bus: Built-In 16:18:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:18:39 INFO - Vendor: Intel (0x8086) 16:18:39 INFO - Device ID: 0x0a2e 16:18:39 INFO - Revision ID: 0x0009 16:18:39 INFO - Displays: 16:18:39 INFO - Display: 16:18:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:18:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:18:39 INFO - Display Serial Number: 1600x1200 60 16:18:39 INFO - Main Display: Yes 16:18:39 INFO - Mirror: Off 16:18:39 INFO - Online: Yes 16:18:39 INFO - Rotation: Supported 16:18:39 INFO - Return code: 0 16:18:39 INFO - Running post-action listener: _resource_record_post_action 16:18:39 INFO - Running post-run listener: _resource_record_post_run 16:18:40 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 303104; Write bytes: 664582656; Read time: 7; Write time: 2251 16:18:40 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358017536; Write bytes: 353966080; Read time: 28014; Write time: 693 16:18:40 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 278528; Write bytes: 299450880; Read time: 6; Write time: 1523 16:18:40 INFO - Running post-run listener: _upload_blobber_files 16:18:40 INFO - Blob upload gear active. 16:18:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:18:40 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 16:18:40 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:18:40 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:18:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:41 INFO - (blobuploader) - INFO - Done attempting. 16:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:42 INFO - (blobuploader) - INFO - Done attempting. 16:18:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:18:42 INFO - Return code: 0 16:18:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:18:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:18:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2c33ad7cfe3f6a44be1d57976e0356aa78445d781ae372e1bb1fb7505e1bfe91ba630c20b09718445e6112f8a1ed4308f435e1dafbe23feda087c93fa2bdce8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/352ef0d297cdf7e7d0cc058f77be471dc423a6a260476ad876aa881ed0f18e136d1cc5cc373ed463fcf9c4ef0a5f096ad547463890cd618d16f7c613fd1f678d"} 16:18:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:18:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:18:42 INFO - Contents: 16:18:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2c33ad7cfe3f6a44be1d57976e0356aa78445d781ae372e1bb1fb7505e1bfe91ba630c20b09718445e6112f8a1ed4308f435e1dafbe23feda087c93fa2bdce8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/352ef0d297cdf7e7d0cc058f77be471dc423a6a260476ad876aa881ed0f18e136d1cc5cc373ed463fcf9c4ef0a5f096ad547463890cd618d16f7c613fd1f678d"} 16:18:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:18:42 INFO - Copying logs to upload dir... 16:18:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:18:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.458633 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-06-29 16:18:42.227747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:42.231429) ========= 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.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/Larch/sha512/2c33ad7cfe3f6a44be1d57976e0356aa78445d781ae372e1bb1fb7505e1bfe91ba630c20b09718445e6112f8a1ed4308f435e1dafbe23feda087c93fa2bdce8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/352ef0d297cdf7e7d0cc058f77be471dc423a6a260476ad876aa881ed0f18e136d1cc5cc373ed463fcf9c4ef0a5f096ad547463890cd618d16f7c613fd1f678d"} build_url:https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/NYuVeuFmRsiX_Na53MWiSw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2c33ad7cfe3f6a44be1d57976e0356aa78445d781ae372e1bb1fb7505e1bfe91ba630c20b09718445e6112f8a1ed4308f435e1dafbe23feda087c93fa2bdce8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/352ef0d297cdf7e7d0cc058f77be471dc423a6a260476ad876aa881ed0f18e136d1cc5cc373ed463fcf9c4ef0a5f096ad547463890cd618d16f7c613fd1f678d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:42.268016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:42.268337) ========= 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.vNbPKvugRE/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.4sUZdMGJBS/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005238 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:18:42.319112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:18:42.319740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:18:42.320484) ========= ========= Total master_lag: 0.19 =========