builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0021 starttime: 1467327558.74 results: success (0) buildid: 20160630132027 builduid: 1325bdc5482144bda9ee6efe5b013cfb revision: 889eeaa0392862a345767a4427caf3bb08e46aaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.740206) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.740741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.741109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.766788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.767433) ========= 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.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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-30 15:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.79M=0.001s 2016-06-30 15:59:18 (7.79 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.877495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.877845) ========= 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.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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.020769 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:18.927208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 15:59:18.927568) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 889eeaa0392862a345767a4427caf3bb08e46aaa --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 889eeaa0392862a345767a4427caf3bb08e46aaa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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-30 15:59:18,999 truncating revision to first 12 chars 2016-06-30 15:59:19,000 Setting DEBUG logging. 2016-06-30 15:59:19,000 attempt 1/10 2016-06-30 15:59:19,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/889eeaa03928?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 15:59:21,015 unpacking tar archive at: larch-889eeaa03928/testing/mozharness/ program finished with exit code 0 elapsedTime=2.303818 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 15:59:21.386895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:21.387241) ========= script_repo_revision: 889eeaa0392862a345767a4427caf3bb08e46aaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:21.387631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:21.387899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:59:21.537232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-30 15:59:21.537540) ========= /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.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:21 INFO - MultiFileLogger online at 20160630 15:59:21 in /builds/slave/test 15:59:21 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:59:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:59:21 INFO - {'append_to_log': False, 15:59:21 INFO - 'base_work_dir': '/builds/slave/test', 15:59:21 INFO - 'blob_upload_branch': 'Larch', 15:59:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:59:21 INFO - 'branch': 'Larch', 15:59:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:21 INFO - 'config_files': ('talos/mac_config.py',), 15:59:21 INFO - 'default_actions': ('clobber', 15:59:21 INFO - 'read-buildbot-config', 15:59:21 INFO - 'download-and-extract', 15:59:21 INFO - 'populate-webroot', 15:59:21 INFO - 'create-virtualenv', 15:59:21 INFO - 'install', 15:59:21 INFO - 'run-tests'), 15:59:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:21 INFO - 'download_minidump_stackwalk': True, 15:59:21 INFO - 'download_symbols': 'ondemand', 15:59:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:21 INFO - 'installer_path': 'installer.exe', 15:59:21 INFO - 'log_level': 'info', 15:59:21 INFO - 'log_name': 'talos', 15:59:21 INFO - 'log_to_console': True, 15:59:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:59:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:59:21 INFO - 'opt_config_files': (), 15:59:21 INFO - 'pip_index': False, 15:59:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:21 INFO - 'cmd': ('bash', 15:59:21 INFO - '-c', 15:59:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:21 INFO - 'enabled': True, 15:59:21 INFO - 'halt_on_failure': False, 15:59:21 INFO - 'name': 'check_screen_resolution'},), 15:59:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:21 INFO - 'cmd': ('bash', 15:59:21 INFO - '-c', 15:59:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:21 INFO - 'enabled': True, 15:59:21 INFO - 'halt_on_failure': False, 15:59:21 INFO - 'name': 'check_screen_resolution'},), 15:59:21 INFO - 'run_cmd_checks_enabled': True, 15:59:21 INFO - 'sps_profile': False, 15:59:21 INFO - 'sps_profile_interval': 0, 15:59:21 INFO - 'suite': 'dromaeojs-e10s', 15:59:21 INFO - 'system_bits': '32', 15:59:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:21 INFO - 'title': 't-yosemite-r7-0021', 15:59:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:21 INFO - 'use_talos_json': True, 15:59:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:59:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:21 INFO - 'work_dir': 'build'} 15:59:21 INFO - ##### 15:59:21 INFO - ##### Running clobber step. 15:59:21 INFO - ##### 15:59:21 INFO - Running pre-action listener: _resource_record_pre_action 15:59:21 INFO - Running main action method: clobber 15:59:21 INFO - rmtree: /builds/slave/test/build 15:59:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:59:22 INFO - Running post-action listener: _resource_record_post_action 15:59:22 INFO - ##### 15:59:22 INFO - ##### Running read-buildbot-config step. 15:59:22 INFO - ##### 15:59:22 INFO - Running pre-action listener: _resource_record_pre_action 15:59:22 INFO - Running main action method: read_buildbot_config 15:59:22 INFO - Using buildbot properties: 15:59:22 INFO - { 15:59:22 INFO - "project": "", 15:59:22 INFO - "product": "firefox", 15:59:22 INFO - "script_repo_revision": "production", 15:59:22 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 15:59:22 INFO - "repository": "", 15:59:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 15:59:22 INFO - "buildid": "20160630132027", 15:59:22 INFO - "pgo_build": "False", 15:59:22 INFO - "basedir": "/builds/slave/test", 15:59:22 INFO - "buildnumber": 2, 15:59:22 INFO - "slavename": "t-yosemite-r7-0021", 15:59:22 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:59:22 INFO - "platform": "yosemite_r7", 15:59:22 INFO - "scheduler": "tests-larch-macosx64-talos", 15:59:22 INFO - "branch": "larch", 15:59:22 INFO - "repo_path": "projects/larch", 15:59:22 INFO - "revision": "889eeaa0392862a345767a4427caf3bb08e46aaa", 15:59:22 INFO - "stage_platform": "macosx64", 15:59:22 INFO - "builduid": "1325bdc5482144bda9ee6efe5b013cfb", 15:59:22 INFO - "slavebuilddir": "test" 15:59:22 INFO - } 15:59:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg. 15:59:22 INFO - Running post-action listener: _resource_record_post_action 15:59:22 INFO - ##### 15:59:22 INFO - ##### Running download-and-extract step. 15:59:22 INFO - ##### 15:59:22 INFO - Running pre-action listener: _resource_record_pre_action 15:59:22 INFO - Running main action method: download_and_extract 15:59:22 INFO - mkdir: /builds/slave/test/build/tests 15:59: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:59:22 INFO - https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:59:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 15:59:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 15:59:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:24 INFO - Downloaded 1277 bytes. 15:59:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 15:59:24 INFO - Using the following test package requirements: 15:59:24 INFO - {u'common': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:59:24 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.cppunittest.tests.zip'], 15:59:24 INFO - u'gtest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.gtest.tests.zip'], 15:59:24 INFO - u'jittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'jsshell-mac.zip'], 15:59:24 INFO - u'mochitest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.mochitest.tests.zip'], 15:59:24 INFO - u'mozbase': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:59:24 INFO - u'reftest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.reftest.tests.zip'], 15:59:24 INFO - u'talos': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.talos.tests.zip'], 15:59:24 INFO - u'web-platform': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.web-platform.tests.zip'], 15:59:24 INFO - u'webapprt': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 15:59:24 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 15:59:24 INFO - u'firefox-47.0.2.en-US.mac.xpcshell.tests.zip']} 15:59:24 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip'] for test suite category: common 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:24 INFO - https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:25 INFO - Downloaded 17990253 bytes. 15:59:25 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:59:25 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:59:28 INFO - Return code: 0 15:59:28 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:59: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:59:28 INFO - https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 15:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:29 INFO - Downloaded 17990253 bytes. 15:59:29 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:59:29 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:59:33 INFO - Return code: 0 15:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:33 INFO - https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 15:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 15:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:34 INFO - Downloaded 10845194 bytes. 15:59:34 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:59:34 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:59:34 INFO - Return code: 0 15:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:34 INFO - https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg matches https://queue.taskcluster.net 15:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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:59:38 INFO - Downloaded 115400642 bytes. 15:59:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:59:38 INFO - mkdir: /builds/slave/test/properties 15:59:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:38 INFO - Contents: 15:59:38 INFO - build_url:https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 15:59:39 INFO - Running post-action listener: _resource_record_post_action 15:59:39 INFO - Running post-action listener: set_extra_try_arguments 15:59:39 INFO - ##### 15:59:39 INFO - ##### Running populate-webroot step. 15:59:39 INFO - ##### 15:59:39 INFO - Running pre-action listener: _resource_record_pre_action 15:59:39 INFO - Running main action method: populate_webroot 15:59:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:39 INFO - '--tppagecycles', 15:59:39 INFO - '7'], 15:59:39 INFO - 'tests': ['tsvgm']}}, 15:59:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:59:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'tests': ['damp', 'tps']}, 15:59:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['damp', 'tps']}, 15:59:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:39 INFO - 'other': {'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'other_l64': {'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:39 INFO - 'ts_paint', 15:59:39 INFO - 'tpaint', 15:59:39 INFO - 'sessionrestore', 15:59:39 INFO - 'sessionrestore_no_auto_restore', 15:59:39 INFO - 'tabpaint']}, 15:59:39 INFO - 'svgr': {'tests': ['tsvgx', 15:59:39 INFO - 'tsvgr_opacity', 15:59:39 INFO - 'tart', 15:59:39 INFO - 'tscrollx', 15:59:39 INFO - 'cart']}, 15:59:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['tsvgx', 15:59:39 INFO - 'tsvgr_opacity', 15:59:39 INFO - 'tart', 15:59:39 INFO - 'tscrollx', 15:59:39 INFO - 'cart']}, 15:59:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'tests': ['tp5o']}, 15:59:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'talos_options': ['--e10s'], 15:59:39 INFO - 'tests': ['tp5o']}, 15:59:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'talos_options': ['--xperf_path', 15:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:39 INFO - 'tests': ['tp5n']}, 15:59:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:39 INFO - 'talos_options': ['--e10s', 15:59:39 INFO - '--xperf_path', 15:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:39 INFO - 'tests': ['tp5n']}}, 15:59:39 INFO - 'talos.zip': {'path': '', 15:59:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:39 INFO - Running post-action listener: _resource_record_post_action 15:59:39 INFO - ##### 15:59:39 INFO - ##### Running create-virtualenv step. 15:59:39 INFO - ##### 15:59:39 INFO - Running pre-action listener: _resource_record_pre_action 15:59:39 INFO - Running main action method: create_virtualenv 15:59:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:39 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:59:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:39 INFO - Using real prefix '/tools/python27' 15:59:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:43 INFO - Installing pip.................done. 15:59:43 INFO - Return code: 0 15:59:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 15:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:43 INFO - 'HOME': '/Users/cltbld', 15:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:43 INFO - 'LOGNAME': 'cltbld', 15:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:43 INFO - 'MOZ_NO_REMOTE': '1', 15:59:43 INFO - 'NO_EM_RESTART': '1', 15:59:43 INFO - 'PAGER': '/bin/cat', 15:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:43 INFO - 'PWD': '/builds/slave/test', 15:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:43 INFO - 'SHELL': '/bin/bash', 15:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 15:59:43 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 15:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:43 INFO - 'USER': 'cltbld', 15:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:43 INFO - 'XPC_FLAGS': '0x0', 15:59:43 INFO - 'XPC_SERVICE_NAME': '0', 15:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:43 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:59:43 INFO - Cleaning up... 15:59:43 INFO - Return code: 0 15:59:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 15:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:43 INFO - 'HOME': '/Users/cltbld', 15:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:43 INFO - 'LOGNAME': 'cltbld', 15:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:43 INFO - 'MOZ_NO_REMOTE': '1', 15:59:43 INFO - 'NO_EM_RESTART': '1', 15:59:43 INFO - 'PAGER': '/bin/cat', 15:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:43 INFO - 'PWD': '/builds/slave/test', 15:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:43 INFO - 'SHELL': '/bin/bash', 15:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 15:59:43 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 15:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:43 INFO - 'USER': 'cltbld', 15:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:43 INFO - 'XPC_FLAGS': '0x0', 15:59:43 INFO - 'XPC_SERVICE_NAME': '0', 15:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:44 INFO - Downloading/unpacking psutil>=0.7.1 15:59:44 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:59:44 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:59:44 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:59:44 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:59:44 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:59:44 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:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:47 INFO - Installing collected packages: psutil 15:59:47 INFO - Running setup.py install for psutil 15:59:47 INFO - building 'psutil._psutil_osx' extension 15:59:47 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:59:47 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:59:47 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:59:47 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:59:47 INFO - building 'psutil._psutil_posix' extension 15:59:47 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:59:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:59:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:59:47 INFO - ^ 15:59:47 INFO - 1 warning generated. 15:59:47 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:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:47 INFO - Successfully installed psutil 15:59:47 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 15:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:47 INFO - 'HOME': '/Users/cltbld', 15:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:47 INFO - 'LOGNAME': 'cltbld', 15:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:47 INFO - 'MOZ_NO_REMOTE': '1', 15:59:47 INFO - 'NO_EM_RESTART': '1', 15:59:47 INFO - 'PAGER': '/bin/cat', 15:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:47 INFO - 'PWD': '/builds/slave/test', 15:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:47 INFO - 'SHELL': '/bin/bash', 15:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 15:59:47 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 15:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:47 INFO - 'USER': 'cltbld', 15:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:47 INFO - 'XPC_FLAGS': '0x0', 15:59:47 INFO - 'XPC_SERVICE_NAME': '0', 15:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:48 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:59:48 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:59:48 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:59:48 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:59:48 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:59:48 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:59:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:50 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:59:50 INFO - Installing collected packages: mozsystemmonitor 15:59:50 INFO - Running setup.py install for mozsystemmonitor 15:59:50 INFO - Successfully installed mozsystemmonitor 15:59:50 INFO - Cleaning up... 15:59:50 INFO - Return code: 0 15:59:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:50 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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:50 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:59:50 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:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 15:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:50 INFO - 'HOME': '/Users/cltbld', 15:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:50 INFO - 'LOGNAME': 'cltbld', 15:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:50 INFO - 'MOZ_NO_REMOTE': '1', 15:59:50 INFO - 'NO_EM_RESTART': '1', 15:59:50 INFO - 'PAGER': '/bin/cat', 15:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:51 INFO - 'PWD': '/builds/slave/test', 15:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:51 INFO - 'SHELL': '/bin/bash', 15:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 15:59:51 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 15:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:51 INFO - 'USER': 'cltbld', 15:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:51 INFO - 'XPC_FLAGS': '0x0', 15:59:51 INFO - 'XPC_SERVICE_NAME': '0', 15:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 INFO - Downloading docopt-0.6.1.tar.gz 15:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:54 INFO - Running setup.py install for blobuploader 15:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:55 INFO - Running setup.py install for requests 15:59:55 INFO - Running setup.py install for docopt 15:59:55 INFO - Successfully installed blobuploader requests docopt 15:59:55 INFO - Cleaning up... 15:59:55 INFO - Return code: 0 15:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:55 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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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:59:55 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:59:55 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:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 15:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:55 INFO - 'HOME': '/Users/cltbld', 15:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:55 INFO - 'LOGNAME': 'cltbld', 15:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:55 INFO - 'MOZ_NO_REMOTE': '1', 15:59:55 INFO - 'NO_EM_RESTART': '1', 15:59:55 INFO - 'PAGER': '/bin/cat', 15:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:55 INFO - 'PWD': '/builds/slave/test', 15:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:55 INFO - 'SHELL': '/bin/bash', 15:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 15:59:55 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 15:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:55 INFO - 'USER': 'cltbld', 15:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:55 INFO - 'XPC_FLAGS': '0x0', 15:59:55 INFO - 'XPC_SERVICE_NAME': '0', 15:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-8765DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-cs5ufN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-1gCPlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-u2u0Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-ZMFqnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-NPYaQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-UkeTaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-HTGWyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:56 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-ni0k87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-iWRHeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-r42bMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-jFU38C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-mAkvcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-R2VVQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-G0_Rmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-DKUyAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:57 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-Uu0iZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:57 INFO - Running setup.py install for manifestparser 15:59:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:57 INFO - Running setup.py install for mozcrash 15:59:58 INFO - Running setup.py install for mozdebug 15:59:58 INFO - Running setup.py install for mozdevice 15:59:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Running setup.py install for mozfile 15:59:58 INFO - Running setup.py install for mozhttpd 15:59:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Running setup.py install for mozinfo 15:59:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Running setup.py install for mozInstall 15:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Running setup.py install for mozleak 15:59:59 INFO - Running setup.py install for mozlog 15:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Running setup.py install for moznetwork 15:59:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Running setup.py install for mozprocess 15:59:59 INFO - Running setup.py install for mozprofile 15:59:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Running setup.py install for mozrunner 15:59:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:59 INFO - Running setup.py install for mozscreenshot 16:00:00 INFO - Running setup.py install for moztest 16:00:00 INFO - Running setup.py install for mozversion 16:00:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:00 INFO - Cleaning up... 16:00:00 INFO - Return code: 0 16:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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 16:00:00 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 16:00:00 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 16:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 16:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:00 INFO - 'HOME': '/Users/cltbld', 16:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:00 INFO - 'LOGNAME': 'cltbld', 16:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:00 INFO - 'MOZ_NO_REMOTE': '1', 16:00:00 INFO - 'NO_EM_RESTART': '1', 16:00:00 INFO - 'PAGER': '/bin/cat', 16:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:00 INFO - 'PWD': '/builds/slave/test', 16:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:00 INFO - 'SHELL': '/bin/bash', 16:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 16:00:00 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 16:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:00 INFO - 'USER': 'cltbld', 16:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:00 INFO - 'XPC_FLAGS': '0x0', 16:00:00 INFO - 'XPC_SERVICE_NAME': '0', 16:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:00:00 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-o_7Eku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:00:00 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)) 16:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:00:00 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-mV6LzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:00:00 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)) 16:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:00:00 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-DMJAOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:00:00 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)) 16:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-7JsBy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-lcApxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-stgPao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-PhHudE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-uXNoHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-tnOgJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-QSzl3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-Xsaoha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-Eibwms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:00:01 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-7ayiyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:00:02 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)) 16:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:00:02 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-OiIrBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:00:02 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)) 16:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:02 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-j98p1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:02 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)) 16:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:00:02 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-V_7KVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:00:02 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)) 16:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:00:02 INFO - Running setup.py (path:/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/pip-jtm4Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:00:02 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)) 16:00:02 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)) 16:00:02 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)) 16:00:02 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)) 16:00:02 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)) 16:00:02 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)) 16:00:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:02 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 16:00:04 INFO - Downloading blessings-1.6.tar.gz 16:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:05 INFO - Installing collected packages: blessings 16:00:05 INFO - Running setup.py install for blessings 16:00:05 INFO - Successfully installed blessings 16:00:05 INFO - Cleaning up... 16:00:05 INFO - Return code: 0 16:00:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:05 INFO - Reading from file tmpfile_stdout 16:00:05 INFO - Current package versions: 16:00:05 INFO - blessings == 1.6 16:00:05 INFO - blobuploader == 1.2.4 16:00:05 INFO - docopt == 0.6.1 16:00:05 INFO - manifestparser == 1.1 16:00:05 INFO - mozInstall == 1.12 16:00:05 INFO - mozcrash == 0.17 16:00:05 INFO - mozdebug == 0.1 16:00:05 INFO - mozdevice == 0.48 16:00:05 INFO - mozfile == 1.2 16:00:05 INFO - mozhttpd == 0.7 16:00:05 INFO - mozinfo == 0.9 16:00:05 INFO - mozleak == 0.1 16:00:05 INFO - mozlog == 3.1 16:00:05 INFO - moznetwork == 0.27 16:00:05 INFO - mozprocess == 0.22 16:00:05 INFO - mozprofile == 0.28 16:00:05 INFO - mozrunner == 6.11 16:00:05 INFO - mozscreenshot == 0.1 16:00:05 INFO - mozsystemmonitor == 0.0 16:00:05 INFO - moztest == 0.7 16:00:05 INFO - mozversion == 1.4 16:00:05 INFO - psutil == 3.1.1 16:00:05 INFO - requests == 1.2.3 16:00:05 INFO - wsgiref == 0.1.2 16:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00: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')]} 16:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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')]} 16:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:05 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 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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 16:00:05 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 16:00:05 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 16:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 16:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:05 INFO - 'HOME': '/Users/cltbld', 16:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:05 INFO - 'LOGNAME': 'cltbld', 16:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:05 INFO - 'MOZ_NO_REMOTE': '1', 16:00:05 INFO - 'NO_EM_RESTART': '1', 16:00:05 INFO - 'PAGER': '/bin/cat', 16:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:05 INFO - 'PWD': '/builds/slave/test', 16:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:05 INFO - 'SHELL': '/bin/bash', 16:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 16:00:05 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 16:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:05 INFO - 'USER': 'cltbld', 16:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:05 INFO - 'XPC_FLAGS': '0x0', 16:00:05 INFO - 'XPC_SERVICE_NAME': '0', 16:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 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)) 16:00:05 INFO - Cleaning up... 16:00:05 INFO - Return code: 0 16:00:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:00: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')]} 16:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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')]} 16:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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 16:00: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', 'jsonschema'] in /builds/slave/test/build 16:00: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 jsonschema 16:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 16:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:05 INFO - 'HOME': '/Users/cltbld', 16:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:05 INFO - 'LOGNAME': 'cltbld', 16:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:05 INFO - 'MOZ_NO_REMOTE': '1', 16:00:05 INFO - 'NO_EM_RESTART': '1', 16:00:05 INFO - 'PAGER': '/bin/cat', 16:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:05 INFO - 'PWD': '/builds/slave/test', 16:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:05 INFO - 'SHELL': '/bin/bash', 16:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 16:00:05 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 16:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:05 INFO - 'USER': 'cltbld', 16:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:05 INFO - 'XPC_FLAGS': '0x0', 16:00:05 INFO - 'XPC_SERVICE_NAME': '0', 16:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:06 INFO - Downloading/unpacking jsonschema 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:00:08 INFO - Downloading/unpacking functools32 (from jsonschema) 16:00:08 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 16:00:08 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 16:00:08 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 16:00:08 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 16:00:08 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 16:00:08 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 16:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:00:09 INFO - warning: no files found matching '*.txt' 16:00:09 INFO - no previously-included directories found matching 'build' 16:00:09 INFO - no previously-included directories found matching 'dist' 16:00:09 INFO - no previously-included directories found matching '.git*' 16:00:09 INFO - Installing collected packages: jsonschema, functools32 16:00:09 INFO - Running setup.py install for functools32 16:00:09 INFO - warning: no files found matching '*.txt' 16:00:09 INFO - no previously-included directories found matching 'build' 16:00:09 INFO - no previously-included directories found matching 'dist' 16:00:09 INFO - no previously-included directories found matching '.git*' 16:00:09 INFO - Successfully installed jsonschema functools32 16:00:09 INFO - Cleaning up... 16:00:09 INFO - Return code: 0 16:00:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:00: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')]} 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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')]} 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10255da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee41c89210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, '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.1qDJob1o5F/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.vhxko9pu0V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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 16:00: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', 'flake8'] in /builds/slave/test/build 16:00: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 flake8 16:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 16:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:09 INFO - 'HOME': '/Users/cltbld', 16:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:09 INFO - 'LOGNAME': 'cltbld', 16:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:09 INFO - 'MOZ_NO_REMOTE': '1', 16:00:09 INFO - 'NO_EM_RESTART': '1', 16:00:09 INFO - 'PAGER': '/bin/cat', 16:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:09 INFO - 'PWD': '/builds/slave/test', 16:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:09 INFO - 'SHELL': '/bin/bash', 16:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 16:00:09 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 16:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:09 INFO - 'USER': 'cltbld', 16:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:09 INFO - 'XPC_FLAGS': '0x0', 16:00:09 INFO - 'XPC_SERVICE_NAME': '0', 16:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:09 INFO - Downloading/unpacking flake8 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:00:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:00:14 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 16:00:14 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 16:00:14 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 16:00:14 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 16:00:14 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 16:00:14 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 16:00:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:00:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00: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 16:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:00:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:16 INFO - no previously-included directories found matching 'docs/_build' 16:00:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:00:16 INFO - Running setup.py install for pep8 16:00:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:16 INFO - no previously-included directories found matching 'docs/_build' 16:00:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:00:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:00:16 INFO - Cleaning up... 16:00:16 INFO - Return code: 0 16:00:16 INFO - Running post-action listener: _resource_record_post_action 16:00:16 INFO - Running post-action listener: _start_resource_monitoring 16:00:16 INFO - Starting resource monitoring. 16:00:16 INFO - ##### 16:00:16 INFO - ##### Running install step. 16:00:16 INFO - ##### 16:00:16 INFO - Running pre-action listener: _resource_record_pre_action 16:00:16 INFO - Running main action method: install 16:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:16 INFO - Reading from file tmpfile_stdout 16:00:16 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:00:16 INFO - Reading from file tmpfile_stdout 16:00:16 INFO - Output received: 16:00:16 INFO - Usage: mozinstall [options] installer 16:00:16 INFO - Options: 16:00:16 INFO - -h, --help show this help message and exit 16:00:16 INFO - -d DEST, --destination=DEST 16:00:16 INFO - Directory to install application into. [default: 16:00:16 INFO - "/builds/slave/test"] 16:00:16 INFO - --app=APP Application being installed. [default: firefox] 16:00:16 INFO - mkdir: /builds/slave/test/build/application 16:00:16 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'] 16:00:16 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 16:00:49 INFO - Reading from file tmpfile_stdout 16:00:49 INFO - Output received: 16:00:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:00:49 INFO - Running post-action listener: _resource_record_post_action 16:00:49 INFO - ##### 16:00:49 INFO - ##### Running run-tests step. 16:00:49 INFO - ##### 16:00:49 INFO - Running pre-action listener: _resource_record_pre_action 16:00:49 INFO - Running main action method: run_tests 16:00:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:00:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:00:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:00:49 INFO - 2016-06-30 16:00:49.367 screenresolution[2044:12480] starting screenresolution argv=screenresolution get 16:00:49 INFO - 2016-06-30 16:00:49.369 screenresolution[2044:12480] Display 0: 1600x1200x32@60 16:00:49 INFO - 2016-06-30 16:00:49.375 screenresolution[2045:12482] starting screenresolution argv=screenresolution list 16:00:49 INFO - Available Modes on Display 0 16:00:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:00:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:00:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:00:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:00:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:00:49 INFO - Intel Iris: 16:00:49 INFO - Chipset Model: Intel Iris 16:00:49 INFO - Type: GPU 16:00:49 INFO - Bus: Built-In 16:00:49 INFO - VRAM (Dynamic, Max): 1536 MB 16:00:49 INFO - Vendor: Intel (0x8086) 16:00:49 INFO - Device ID: 0x0a2e 16:00:49 INFO - Revision ID: 0x0009 16:00:49 INFO - Displays: 16:00:49 INFO - Display: 16:00:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:00:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:00:49 INFO - Display Serial Number: 1600x1200 60 16:00:49 INFO - Main Display: Yes 16:00:49 INFO - Mirror: Off 16:00:49 INFO - Online: Yes 16:00:49 INFO - Rotation: Supported 16:00:49 INFO - Return code: 0 16:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:49 INFO - Python 2.7.3 16:00:49 INFO - Return code: 0 16:00:49 INFO - grabbing minidump binary from tooltool 16:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:49 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 0x102401d30>, '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 0x102225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:49 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 16:00:49 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 16:00:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:49 INFO - Return code: 0 16:00:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:00:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:00:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:00:50 INFO - Return code: 0 16:00:50 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/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 16:00:50 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/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --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 16:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1qDJob1o5F/Render', 16:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:50 INFO - 'HOME': '/Users/cltbld', 16:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:50 INFO - 'LOGNAME': 'cltbld', 16:00:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:50 INFO - 'MOZ_NO_REMOTE': '1', 16:00:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:50 INFO - 'NO_EM_RESTART': '1', 16:00:50 INFO - 'PAGER': '/bin/cat', 16:00:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:50 INFO - 'PWD': '/builds/slave/test', 16:00:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:50 INFO - 'SHELL': '/bin/bash', 16:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vhxko9pu0V/Listeners', 16:00:50 INFO - 'TMPDIR': '/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/', 16:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:50 INFO - 'USER': 'cltbld', 16:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:50 INFO - 'XPC_FLAGS': '0x0', 16:00:50 INFO - 'XPC_SERVICE_NAME': '0', 16:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:50 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/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--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 16:00:51 INFO - mozversion application_buildid: 20160630132027 16:00:51 INFO - mozversion application_changeset: 889eeaa0392862a345767a4427caf3bb08e46aaa 16:00:51 INFO - mozversion application_display_name: Nightly 16:00:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:51 INFO - mozversion application_name: Firefox 16:00:51 INFO - mozversion application_remotingname: firefox 16:00:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:00:51 INFO - mozversion application_vendor: Mozilla 16:00:51 INFO - mozversion application_version: 47.0.2 16:00:51 INFO - mozversion platform_buildid: 20160630132027 16:00:51 INFO - mozversion platform_changeset: 889eeaa0392862a345767a4427caf3bb08e46aaa 16:00:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:00:51 INFO - mozversion platform_version: 47.0.2 16:00:51 INFO - using testdate: 1467327651 16:00:51 INFO - actual date: 1467327651 16:00:51 INFO - starting webserver on 'localhost:49518' 16:00:51 INFO - SUITE-START | Running 2 tests 16:00:51 INFO - TEST-START | dromaeo_css 16:00:51 INFO - operating with platform_type : mac_ 16:00:51 INFO - Initialising browser for dromaeo_css test... 16:00:51 INFO - TEST-INFO | started process 2063 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/tmpwBWmFF/profile http://localhost:49518/getInfo.html) 16:00:53 INFO - PROCESS | 2063 | __metrics Screen width/height:1600/1200 16:00:53 INFO - PROCESS | 2063 | colorDepth:24 16:00:53 INFO - PROCESS | 2063 | Browser inner width/height: 1024/689 16:00:53 INFO - PROCESS | 2063 | __metrics 16:00:54 ERROR - PROCESS | 2063 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:00:54 INFO - TEST-INFO | 2063: exit 0 16:00:54 INFO - Browser initialized. 16:00:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:54 INFO - TEST-INFO | started process 2066 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/tmpwBWmFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:06 INFO - PROCESS | 2066 | RSS: Main: 195325952 16:01:06 INFO - PROCESS | 2066 | 16:01:56 INFO - PROCESS | 2066 | 1467327716001 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:04:07 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49518/tests/dromaeo/cssquery-ext.html) 16:04:09 INFO - PROCESS | 2066 | RSS: Main: 205602816 16:04:09 INFO - PROCESS | 2066 | 16:07:11 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-ext.html (next: http://localhost:49518/tests/dromaeo/cssquery-jquery.html) 16:07:11 INFO - PROCESS | 2066 | RSS: Main: 217501696 16:07:11 INFO - PROCESS | 2066 | 16:10:13 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49518/tests/dromaeo/cssquery-mootools.html) 16:10:14 INFO - PROCESS | 2066 | RSS: Main: 219279360 16:10:14 INFO - PROCESS | 2066 | 16:13:15 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49518/tests/dromaeo/cssquery-prototype.html) 16:13:16 INFO - PROCESS | 2066 | RSS: Main: 222789632 16:13:16 INFO - PROCESS | 2066 | 16:16:18 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49518/tests/dromaeo/cssquery-yui.html) 16:16:19 INFO - PROCESS | 2066 | RSS: Main: 222154752 16:16:19 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | Cycle 1(1): loaded http://localhost:49518/tests/dromaeo/cssquery-yui.html (next: http://localhost:49518/tests/dromaeo/cssquery-dojo.html) 16:19:21 INFO - PROCESS | 2066 | RSS: Main: 226205696 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | __start_tp_report 16:19:21 INFO - PROCESS | 2066 | _x_x_mozilla_page_load 16:19:21 INFO - PROCESS | 2066 | _x_x_mozilla_page_load_details 16:19:21 INFO - PROCESS | 2066 | |i|pagename|runs| 16:19:21 INFO - PROCESS | 2066 | |0;dojo.html;3526.030341656044;3560.857565697372;3585.4263317869145;3605.729570282228;3636.581793093795;5864.501517371018;5880.176775251468;5919.052951527757;5919.85200369991;5931.555133364998;5921.911171332434;5948.196993405889;5984.880302393961;6003.219581454416;6005.3394126646035;5288.8413347599635;5321.787128514874;5363.195520671911;5404.621676482629;5499.900019996016;3964.682825373963;5302.628815982883;5417.295751552293;5417.756200970965;5453.700046497441;4494.865154045384;5358.839234822962;5382.6232163748555;5400.189971504286;5485.506304432601;4004.83980640774;5160.870978225536;5417.539509141728;5461.890762184774;5469.453054694539;4765.737884416356;5244.606654500928;5263.578913686896;5323.600729945269;5326.6537675050995;5720.742566584514;5744.22452968848;5758.596898217126;5792.710364481759;5799.797007104731;5305.7612407441375;5856.443637854397;6276.215473065867;6278.4663303619245;6293.779717709858;6225.097360882647;6276.748930042792;6297.244330680302;6306.747730090791;6315.842103947392;5950.6132101413705;5976.163337132805;5990.026575890644;6003.759849606055;6025.9096113558335;6237.75048998035;6297.244330680256;6315.179026726496;6335.334789847;6355.809325720235;6209.410106040009;6282.623042617458;6284.528660350401;6293.024581189923;6299.590526615755;6265.530085243625;6286.119943207955;6310.7791227306825;6315.5263355247625;6322.968385158045;6189.907151392733;6193.4425901669065;6201.7519299228425;6211.3478084801345;6274.40393162658;6231.158793562811;6275.560710750295;6279.120923070774;6279.843003924939;6285.779997700059;4948.109340318705;4988.426330971912;4988.625853061035;4993.475685053089;5016.122178618727;4442.022754993896;4448.55514448559;4450.376947227391;4498.392716983165;4512.481064677604;5761.452661997104;5878.147668588116;5897.498712609477;5923.881522369528;5924.555658325643;6283.842903927439;6288.811335659938;6295.811125666238;6313.810585682437;6324.620522768649;5782.537397008229;5900.409959004065;5956.821295361146;5979.611325263931;6005.159277701126;5504.339479262514;5510.641808282448;5530.557555395559;5533.557315414757;5550.417206193372;6422.2614399344675;6447.194100737408;6450.8064758057335;6451.096846441502;6460;6205.2553693557065;6249.0626406039455;6253.280872699515;6298.842528936813;6332.335104814112;6427.357264273535;6428.871422571616;6429.678516074084;6446.64543450096;6474.320196379313;5546;6267.5299352549655;6286.339934306832;6286.402791734778;6294.244690637152;6126.590884096772;6179.598326108789;6227.159333489921;6241.906371404523;6291.622502649856;5278.076336641149;6236.6258024518675;6250.624962502265;6252.562320637512;6269;6095.969520152371;6205.968970155121;6224.221972253468;6265.5927364722975;6280.685965701788;6117.908231376622;6127.571070025056;6127.698530765323;6130.826205142415;6153.815385538441;6249.96875015622;6261.874762504815;6269.279032911274;6281.842953926006;6282.937170628235;6119.632822030692;6132.846678833065;6195.256569211723;6203.069539569101;6223.128761973418 16:19:21 INFO - PROCESS | 2066 | |1;ext.html;484.72350041678516;588.1471865794596;603.3031848215313;626.4424662050774;672.1497305908026;38393.616063839356;39227.82316530505;39279.0180245494;39307.80346098266;39368;40517;40764.980875478126;40818.38772418416;41235.79382103085;41292.38061429081;9479.620815167385;9678.564464599074;9680.419174849496;9717.902820971805;9718.465484398355;9611.231101511863;9735.269854760885;9769.511524423786;9778.266630002743;9779.266555008368;9749.122578967892;9833.557489912972;9835.508224588777;9841.45871977041;9851.162651174658;9717.31978761487;9783;9793.314467987244;9815.852762208573;9833.213342932584;9586.233101351945;9714.708558743248;9717.757056073584;9737.172340351079;9765.365251258645;33739;39614.20771584552;39913;40024.799876000434;40319.59680403188;3163.7943533670236;3344.147242453159;3369.2756057447523;3394.8132852693093;3521.4893840393256;26916;27071.864640676868;27519.724802751916;27813.721862781316;28179.436411271865;2765.958510622342;2785.916422507328;2786.8606569671433;2789.1074856046075;2853.7716982641546;317099;318290;319045;319515;320027;46618.06763864704;47305.290420643716;67843.66078169577;68426;68443;46872.765636172284;47352;47398.526014739415;47582;47584.5241547587;16705.498835034967;16838.073905935293;16875.24061417239;16901.323947042227;16942.830571694372;13499.325033748273;13581;13596.320183990762;13612.65968350799;13614.183149010893;13380.799288010687;15157.772633410508;15310;15442.768358474632;15581;5709.286339207599;6590.176227971504;6707.731690732414;6726.562773419712;6758.952362383839;834.382556907896;1026.2457094035879;1029.9433531155858;1041.6874937518714;1084.915084915085;23401.648975265383;25782;29694;30253;30405;1138.1350173867754;1147.8679951805482;1169.7601991591703;1205.7106294489258;1219.2623462805052;15240.847591524165;15900.363985440454;16225.432109876097;16909.900856444292;17129.22918468672;523715;533633;533802;534017;535618;62348;62671;62861.68569157125;62864.42838929063;62952.74094518176;1544.5057581573788;1578.455432875656;1581.7785510028605;1585.5956731033743;1697.558634754948;30030.849845750632;31279.01920702883;31361.372772544877;31747.84126079355;32000.19999499938;54220;54597.908041839735;54799;54867.17699234435;54903;490758;491438;492255;495403;495823;33339.83330083334;34130.65869341275;34921.82539087288;34967.82516087505;35022.47466288059;45539.54460455485;45579;45677.08645827131;45688;46214;37762.811185943894;37874.810625946695;37981;38108.428373573865;38442.84671459749;36664.63335366612;37636.62363376441;37970.43044354281;38067.809660952626;38142.618573815016;26245.606315905658;36864.26271474609;37349;37793.62206377901;38289;26801.86599066992;30167.245818854703;31497.685023149475;34840.65159348374;38033.4294985581;23314.53370932538;24704.011839526218;25038.62442063334;25307.367315816515;25992.35019124537 16:19:21 INFO - PROCESS | 2066 | |2;jquery.html;373.47153777404975;381.11961369237054;383.1972018620989;385.4468837218593;386.91487872668023;19360.4901490144;20028.399148025583;20292;20880.582388352224;20915.477113072182;17091.31634734609;21008.579828403424;21211;21374;21450.785492145074;5780.653160810365;5885.20549725788;5942.138389933457;5950.494207992326;5953.970230148843;4190.937135942963;4716.716996980175;6369.8089057328125;6371.617702937815;6383.170187875569;6359.491240700733;6457.45111665509;6464.870702585946;6474.1907261592305;6474.417302442779;6137.570370074097;6408.61548307103;6413.070104834819;6416.550841441078;6423.967880160616;5445.37378201504;5570.220169176318;5579.8884022319735;5596.832095037155;5598.524125449342;20242.98785060756;24825.50348993028;24925.875370623213;25030;25205.62191567128;2183.8908054597364;2188.6388745856916;2208;2221.8444708870225;2232.720909886264;15084.698306033928;15243.314050867737;15270.694586108326;15504.612384690361;15529.611759705986;1436.7701167813204;1767.9469615911414;1811.1759149586906;1811.994343139557;1816.781986161669;103291.48354258256;107436;110037.9999999992;110541.44729276303;111858;10494;11073.833892491619;11567.363794991355;11582.305061696325;11659.417029148679;13949.093308934887;13988.230647314496;14047.85952140486;14071.929640351733;14092.154470731788;8843.336749743796;8885.0670679579;8933.955330223307;9003.14470125337;9015.188633022928;9089.50007749567;9166.49584272858;9182;9198.770030749285;9255.074492550826;4438.511763706054;4564.2012647786505;4578.153041687298;4580.564846339593;4617.884552886205;1913.1868955694054;1962.077823422989;1963.2834015584208;2004.0681083296338;2008.0662491941025;857.8798968144465;964.9951750241204;993.3989936088707;1017.2218253036433;1036.875574931013;19892;20380.592388152152;20478.385648430274;20733;20812;959.1703176752059;1021.4280003198085;1021.8365061590258;1049.506731836036;1099.395332567085;10098.091171794575;10545.84181237282;10660.025155223715;11136.888631113585;11916.404179791149;271204;368812;634536;641708;649796;109251;128677;129188.3540582291;135066;135376.32311838376;956.1872408452759;1050.7110544600143;1074.3285446595878;1079.0881704959297;1092.2790957967702;16834;18511.90744046271;18654.813451865306;18755.624887502447;18854.151563179417;40080.99797505086;41370;43623.127537449705;54357.641058973844;55348;76109;78796;79019.60490197512;81455.59272203602;81659;7219.819504512429;8032.879506807286;8172.182781722018;8423.536705481258;8631.26634236097;13300.733985320046;13359.799603006157;13374.866251337362;13691.520796772464;13786.310684465938;9186.989431162434;10322.896771032194;10834.837477437686;11169.609063682732;11369;11475.713107172054;11562.479688413874;11581.478833452684;11659.475323610628;11825.763484730429;11761.764764704829;11816.527338906348;11987.34069626144;12107;12313.69215769577;8410.074891761778;8478.109798471072;8536.274416674403;8653.395667819635;8673.653053877773;11887.762244754884;11899.464524096264;11927.761444770882;12119.939400302943;12174.330411827434 16:19:21 INFO - PROCESS | 2066 | |3;mootools.html;1617.312642127096;1631.0376877642188;1975.6147551227507;2002.1090614676475;2052.066309829028;8309.210624990616;9064.229540489066;9077.863832042516;9281.257499400048;9308.069193080697;9018.594163262653;9069.546522673856;9110.180083792457;9155.542222888862;9167.633294668221;2585.974140258597;2591.883365248568;2593.1701855406277;2599.909003184889;2601.5967525033557;2548.6686730724978;2597.3766296088993;2608.2305719812703;2614.346413396651;2615.6730408698913;2583.6253743207317;2587.767100960913;2603.4923189977962;2624.0553400775707;2628.093307808803;2535.074697735332;2556.0542599238306;2573.5110329037425;2607.1657069737694;2616.306678730119;2498.6127150291554;2517.509085728284;2538.5176816404824;2539.136693524211;2542.8982840686535;9202.631894724203;9215.53922303882;9230.400023998418;9240.722778316662;9240.768980775534;5606.495415412633;5757.395473475267;5774.884502309972;5780.479756821906;5792.420757924216;3615.6022837487853;3736.4768932349493;3748.5876553579355;3774.735768496206;3778.6410291022307;1060.3955745225226;1081.5187241677456;1093.748437859289;1126.3242054767156;1126.915481338903;10417.583296668125;12166.5741699041;12320.815187772101;12326.568570100004;12423.44094515749;5019.799208031711;5062.493750624982;5109.897802043938;5110.591152707774;5124.718140502308;10610.310329828537;10625.628103016357;10640.893591064145;10664.133776589066;10736.785264294671;5647.181158732043;5704.914426283609;5778.88442231153;5794.420557944172;5824.126381042877;4665.136949664323;5014.122528557561;5085.389753229636;5157.123289040872;5219.530242278213;4090.339146463898;4117;4120.340745480708;4166.0834616384955;4190.308599081118;1165.3998190931677;1318.7998920982052;1330.9134906231063;1347.7506661267696;1352.1278775189946;1150.8503894493663;1182.0425455380996;1273.7898246789175;1429.492530151802;1447.9276036198148;8318.8336233275;8333;8385.28725058377;8389.412741108064;8397.454165479347;527.4988760677372;528.1391332128683;534.3827878799915;535.1277417808947;535.7910414938177;6305.558610897193;6322.652254125976;6342.936570634327;6350.682465876687;6444.9355506444335;10747.946260268649;11280.379579123228;11385.14611404148;11418.371989540656;11425.942870285595;10785.514651840685;10952.069074128629;11004.889951100387;11049.723756906142;11067.169962252863;8718.95640521806;8720.040795512488;8742.82514349722;8860.3797734158;8903.976042755037;7453.25467453272;8062.677492900453;8155.673773049249;8167.428280020342;8260.132686067876;9786.608535658494;9932.751681208028;10012.749681258027;10044.196464282986;10061.647842325483;10068;10350.068493835592;10356.948215258875;10509.737256568647;10515.26393152472;7055.858882822417;7649.464537482323;7683.154852966281;7789.4157938155995;7852.960735196288;8468.53423061713;8499;8559.101294364002;8570.700025499078;8581.785455363666;7429.294217049372;7594;7670.309672129535;7679.193684663253;7688.730894418669;7377;7445.957565940881;7446.180920098893;7529.585872776831;7617.771466856003;8005.959970200344;8031.759047228593;8067.152948940511;8085.151059138941;8091;7217.963910180415;7245.637718113968;7271.163816160997;7287.672054757442;7334.97310376537;7341.119065712149;7344.926550734424;7384.261573842573;7406.259374062766;7419.332260096401 16:19:21 INFO - PROCESS | 2066 | |4;prototype.html;295.0572919522125;340.1106107528812;340.6814628322517;341.1028993746448;344.2907610322735;5776.653400795955;6687.799366019027;6773.085633439484;6830.453563714903;6880.965595172023;6820.215675197353;6828.419584335325;6850.3492168244065;6860.588364698109;6893.103896493449;4885.364902562662;4906.239532872392;5002.8993621403415;5045.217991211368;5066.898662026748;5035.345405097332;5037.884088682762;5045.672031317971;5052.7726252318735;5064.721440320781;5010.69935803853;5017.272495488152;5028.723420211887;5039.09296326661;5040.36995375578;4064.268431682296;4216.536181020086;4393.297072468422;4525.845909293125;5031.81752288212;4302.7203231790145;4307.5261721210645;4314.546972567867;4316.719413238129;4331.7617531035785;6302.432781049728;6431.967840160816;6520.2175738911155;6540.149780528548;6563.901541476882;4780.521947805227;4962.503749625044;5903;5915.5859089863725;5935.376785437553;7203.063601731794;7219.0976127984;7223.277672232787;7226.205117437078;7234.2765723427765;4820.6143508519235;4831.782569784368;4836.951630483685;4842.225243960985;4854;7645.197254288275;7660.2722741339485;7671.660143656182;7698.537277917234;7702.807429814244;4761.095391875532;4864.294677271776;4927.9507204927495;4929.309896614477;4940;4139.3583994480905;4971.90056198874;5015.197568389113;5020.849374518771;5031.144705400017;4522.751248681354;5871.178035075093;5875.383084776123;5880.500157486576;5895.852603684856;7291;7302.926970730331;7304.8173795654475;7307.671154798047;7315.597642129734;1715.836995485427;1738.6001219719283;1742.6950283700303;1743.4856717268435;1744.8604111671036;1028.7685270814156;1076.3380520979542;1076.8223243164946;1089.7548051688307;1125.1336470917347;6415.454686351619;6559.573627714183;6570.244421891448;6573.408393244631;6607.306232845578;7474.925250747532;7480.364169045583;7482.139553951257;7504.62476876165;7512.248775122444;6384.170057892445;6534.346565343522;6773.966130169416;6837.965810170917;6849.520533562702;3989.30454556818;4016.1566071124807;4016.6585840203325;4019.658329042006;4040.595940405936;7925.167857375008;7934.523928564305;7958.6418611162635;7964.323032542299;7966.0440747110715;7465.514741541891;7860.292573668283;7867.527948323119;7876.488028278143;7886.802829929297;7825.3739700824935;7856.803579910434;7870.409719271078;7881.842363152705;7901.051873775069;7563.659635316314;7582.848343032998;7590.734324298623;7604.733834315773;7609.086909570887;7432.070991126109;7433.702651893864;7434.996275502738;7443.032405787213;7462.4776265660885;7571.3942884568005;7853.882191767014;7880.448368614142;7903.723369682033;7904.20957904228;4721.079389519011;4734.834280800155;4776.5701086902345;4784.928226076681;4797;7503.1746507883;7503.512271702322;7527.8494430109995;7539.396848252236;7561.584112873845;7275.017872587345;7278.344948954619;7296.452766042462;7298.416126709744;7320.534473970767;7066.57600543969;7263.201047884834;7272;7305.159906610807;7341.229170936975;7049.577025378494;7090.574565525879;7096.290370962863;7101.431885449048;7134.8216294590975;5880.94167041532;7257.600831954293;7270.345668889825;7286.453515986216;7292.708291668274;6895.241523432519;7115.181754098138;7116;7118.572885626671;7128.394086502705 16:19:21 INFO - PROCESS | 2066 | |5;yui.html;633.6134957675814;655.9475241980642;700.8423104801417;714.6033951157108;789.3724489031222;12868.420921058552;14656.560303190909;15304.84695153048;15314.846851531482;15441.613959651015;14112.506062287823;14155.716885662281;14171.220582867938;14185.929070354634;14192.787108193384;760.3005235183631;901.9594118264694;971.7570607348163;973.2214228617113;974.0211087856729;946.9242460603135;950.8240975419535;960.5245403525265;965.2953344058806;965.4159233663638;1013.1742629756725;1016.8779746430439;1018.1447584029414;1019.6482213636284;1021.4739409204266;994.3337963564393;1001.4742260313358;1005.3666190300137;1006.5520843224768;1011.6964910526813;735.4998600951404;746.4401698725956;753.3445902065238;754.9245075492407;758.0297219558973;14819;14953.551393458214;15214.923925380413;15230.695386092217;15506.767398489032;12880.613581592566;12912.354382280848;12972.156809807333;13072.738545229136;13134.474621015148;10065.446400447972;10067.446290454021;10225.284230103896;10353.948230258877;10550.366977981346;3504.3867323218333;3516.314318707853;3517.155882588186;3612.747107702462;3677.3932301170275;82859;83550.16449835485;84336.89157771044;84935.8766030848;85479.57260213721;8376.706815261437;9442;9530.685201597144;9713.417194968184;10159.034891685278;22310.442238943833;22368.440788980406;22384.328470145596;22429.77570224277;22433.43916402103;7010.404115650125;7442.479026468203;7538.660760265691;7668.961655191688;7668.9616551918;4015.357542793139;4072.8778136655947;4075.3275709508193;4100.671946244293;4101.610347017028;3659.4144936810517;3679.5032670589126;3693.9445908311395;3697.2975134724315;3712.0534263763107;661.9669016549153;669.0733334331888;670.5842377725842;671.7413795688695;672.0792514255404;596.1474345258007;600.9819705408845;601.179390132466;602.9668368239701;615.6336979497192;8363.289120424832;8416.452930559493;8421;8452.36607254446;8560.357973152039;543.1879340386148;575.4159528079003;576.9480746732814;603.3724926076831;621.4624349937271;3791.829367678461;3881.340172170738;3890.4747859038666;4081.69387295954;4179.644730197906;85876.71184932231;89026.10973890308;94341;98021;98953;83214;83672;83829.74255386174;83923.5803820977;86148.13851861401;74589;74663.62668186733;74771.25228747752;75320.62339688267;75351.62324188344;7755.457118001686;7766.378689704923;7847.803804904923;7912.525248485109;8205.630746616298;39890;43135;48387.27419088787;50504.49495505145;51305.46083617498;61314.08028879481;68527.31472685409;68779.62440751257;68832.31167688259;69257;10200.030997055268;10225.335353202017;11133.498992545517;11536.82694759596;11544.769104618028;11903.940480297542;11959.701007474883;12057.75884482288;12104.576339828063;12767.872321276669;11566.958973692408;11625.418729063682;11697.473613687574;11788.410579471163;11873.643790686294;11692.94153529227;11965.940170299093;11995.580154694544;12077;12107.152499324962;10986.176036797431;11274.154438417316;11459.140564457532;11525.077993760311;11526.769464610494;9313.34806563534;9771.85342219853;9822.607095716377;9909.355891867006;10074.89925100769;8760.12398760119;9646.807063858543;9707.514624268899;9917.256205784452;10091.495425228562 16:19:21 INFO - PROCESS | 2066 | __end_tp_report 16:19:21 INFO - PROCESS | 2066 | __start_cc_report 16:19:21 INFO - PROCESS | 2066 | _x_x_mozilla_cycle_collect,334 16:19:21 INFO - PROCESS | 2066 | __end_cc_report 16:19:21 INFO - PROCESS | 2066 | __startTimestamp1467328761672__endTimestamp 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | ------- Summary: start ------- 16:19:21 INFO - PROCESS | 2066 | Number of tests: 6 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#0] dojo.html Cycles:165 Average:5827.34 Median:6126.59 stddev:660.03 (10.8%) stddev-sans-first:636.89 16:19:21 INFO - PROCESS | 2066 | Values: 3526.0 3560.9 3585.4 3605.7 3636.6 5864.5 5880.2 5919.1 5919.9 5931.6 5921.9 5948.2 5984.9 6003.2 6005.3 5288.8 5321.8 5363.2 5404.6 5499.9 3964.7 5302.6 5417.3 5417.8 5453.7 4494.9 5358.8 5382.6 5400.2 5485.5 4004.8 5160.9 5417.5 5461.9 5469.5 4765.7 5244.6 5263.6 5323.6 5326.7 5720.7 5744.2 5758.6 5792.7 5799.8 5305.8 5856.4 6276.2 6278.5 6293.8 6225.1 6276.7 6297.2 6306.7 6315.8 5950.6 5976.2 5990.0 6003.8 6025.9 6237.8 6297.2 6315.2 6335.3 6355.8 6209.4 6282.6 6284.5 6293.0 6299.6 6265.5 6286.1 6310.8 6315.5 6323.0 6189.9 6193.4 6201.8 6211.3 6274.4 6231.2 6275.6 6279.1 6279.8 6285.8 4948.1 4988.4 4988.6 4993.5 5016.1 4442.0 4448.6 4450.4 4498.4 4512.5 5761.5 5878.1 5897.5 5923.9 5924.6 6283.8 6288.8 6295.8 6313.8 6324.6 5782.5 5900.4 5956.8 5979.6 6005.2 5504.3 5510.6 5530.6 5533.6 5550.4 6422.3 6447.2 6450.8 6451.1 6460.0 6205.3 6249.1 6253.3 6298.8 6332.3 6427.4 6428.9 6429.7 6446.6 6474.3 5546.0 6267.5 6286.3 6286.4 6294.2 6126.6 6179.6 6227.2 6241.9 6291.6 5278.1 6236.6 6250.6 6252.6 6269.0 6096.0 6206.0 6224.2 6265.6 6280.7 6117.9 6127.6 6127.7 6130.8 6153.8 6250.0 6261.9 6269.3 6281.8 6282.9 6119.6 6132.8 6195.3 6203.1 6223.1 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#1] ext.html Cycles:180 Average:59718.26 Median:38088.12 stddev:121709.46 (319.5%) stddev-sans-first:121969.64 16:19:21 INFO - PROCESS | 2066 | Values: 484.7 588.1 603.3 626.4 672.1 38393.6 39227.8 39279.0 39307.8 39368.0 40517.0 40765.0 40818.4 41235.8 41292.4 9479.6 9678.6 9680.4 9717.9 9718.5 9611.2 9735.3 9769.5 9778.3 9779.3 9749.1 9833.6 9835.5 9841.5 9851.2 9717.3 9783.0 9793.3 9815.9 9833.2 9586.2 9714.7 9717.8 9737.2 9765.4 33739.0 39614.2 39913.0 40024.8 40319.6 3163.8 3344.1 3369.3 3394.8 3521.5 26916.0 27071.9 27519.7 27813.7 28179.4 2766.0 2785.9 2786.9 2789.1 2853.8 317099.0 318290.0 319045.0 319515.0 320027.0 46618.1 47305.3 67843.7 68426.0 68443.0 46872.8 47352.0 47398.5 47582.0 47584.5 16705.5 16838.1 16875.2 16901.3 16942.8 13499.3 13581.0 13596.3 13612.7 13614.2 13380.8 15157.8 15310.0 15442.8 15581.0 5709.3 6590.2 6707.7 6726.6 6759.0 834.4 1026.2 1029.9 1041.7 1084.9 23401.6 25782.0 29694.0 30253.0 30405.0 1138.1 1147.9 1169.8 1205.7 1219.3 15240.8 15900.4 16225.4 16909.9 17129.2 523715.0 533633.0 533802.0 534017.0 535618.0 62348.0 62671.0 62861.7 62864.4 62952.7 1544.5 1578.5 1581.8 1585.6 1697.6 30030.8 31279.0 31361.4 31747.8 32000.2 54220.0 54597.9 54799.0 54867.2 54903.0 490758.0 491438.0 492255.0 495403.0 495823.0 33339.8 34130.7 34921.8 34967.8 35022.5 45539.5 45579.0 45677.1 45688.0 46214.0 37762.8 37874.8 37981.0 38108.4 38442.8 36664.6 37636.6 37970.4 38067.8 38142.6 26245.6 36864.3 37349.0 37793.6 38289.0 26801.9 30167.2 31497.7 34840.7 38033.4 23314.5 24704.0 25038.6 25307.4 25992.4 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#2] jquery.html Cycles:180 Average:32472.36 Median:20962.03 stddev:90326.60 (430.9%) stddev-sans-first:90547.84 16:19:21 INFO - PROCESS | 2066 | Values: 373.5 381.1 383.2 385.4 386.9 19360.5 20028.4 20292.0 20880.6 20915.5 17091.3 21008.6 21211.0 21374.0 21450.8 5780.7 5885.2 5942.1 5950.5 5954.0 4190.9 4716.7 6369.8 6371.6 6383.2 6359.5 6457.5 6464.9 6474.2 6474.4 6137.6 6408.6 6413.1 6416.6 6424.0 5445.4 5570.2 5579.9 5596.8 5598.5 20243.0 24825.5 24925.9 25030.0 25205.6 2183.9 2188.6 2208.0 2221.8 2232.7 15084.7 15243.3 15270.7 15504.6 15529.6 1436.8 1767.9 1811.2 1812.0 1816.8 103291.5 107436.0 110038.0 110541.4 111858.0 10494.0 11073.8 11567.4 11582.3 11659.4 13949.1 13988.2 14047.9 14071.9 14092.2 8843.3 8885.1 8934.0 9003.1 9015.2 9089.5 9166.5 9182.0 9198.8 9255.1 4438.5 4564.2 4578.2 4580.6 4617.9 1913.2 1962.1 1963.3 2004.1 2008.1 857.9 965.0 993.4 1017.2 1036.9 19892.0 20380.6 20478.4 20733.0 20812.0 959.2 1021.4 1021.8 1049.5 1099.4 10098.1 10545.8 10660.0 11136.9 11916.4 271204.0 368812.0 634536.0 641708.0 649796.0 109251.0 128677.0 129188.4 135066.0 135376.3 956.2 1050.7 1074.3 1079.1 1092.3 16834.0 18511.9 18654.8 18755.6 18854.2 40081.0 41370.0 43623.1 54357.6 55348.0 76109.0 78796.0 79019.6 81455.6 81659.0 7219.8 8032.9 8172.2 8423.5 8631.3 13300.7 13359.8 13374.9 13691.5 13786.3 9187.0 10322.9 10834.8 11169.6 11369.0 11475.7 11562.5 11581.5 11659.5 11825.8 11761.8 11816.5 11987.3 12107.0 12313.7 8410.1 8478.1 8536.3 8653.4 8673.7 11887.8 11899.5 11927.8 12119.9 12174.3 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#3] mootools.html Cycles:180 Average:6289.12 Median:5140.92 stddev:3319.77 (64.6%) stddev-sans-first:3310.51 16:19:21 INFO - PROCESS | 2066 | Values: 1617.3 1631.0 1975.6 2002.1 2052.1 8309.2 9064.2 9077.9 9281.3 9308.1 9018.6 9069.5 9110.2 9155.5 9167.6 2586.0 2591.9 2593.2 2599.9 2601.6 2548.7 2597.4 2608.2 2614.3 2615.7 2583.6 2587.8 2603.5 2624.1 2628.1 2535.1 2556.1 2573.5 2607.2 2616.3 2498.6 2517.5 2538.5 2539.1 2542.9 9202.6 9215.5 9230.4 9240.7 9240.8 5606.5 5757.4 5774.9 5780.5 5792.4 3615.6 3736.5 3748.6 3774.7 3778.6 1060.4 1081.5 1093.7 1126.3 1126.9 10417.6 12166.6 12320.8 12326.6 12423.4 5019.8 5062.5 5109.9 5110.6 5124.7 10610.3 10625.6 10640.9 10664.1 10736.8 5647.2 5704.9 5778.9 5794.4 5824.1 4665.1 5014.1 5085.4 5157.1 5219.5 4090.3 4117.0 4120.3 4166.1 4190.3 1165.4 1318.8 1330.9 1347.8 1352.1 1150.9 1182.0 1273.8 1429.5 1447.9 8318.8 8333.0 8385.3 8389.4 8397.5 527.5 528.1 534.4 535.1 535.8 6305.6 6322.7 6342.9 6350.7 6444.9 10747.9 11280.4 11385.1 11418.4 11425.9 10785.5 10952.1 11004.9 11049.7 11067.2 8719.0 8720.0 8742.8 8860.4 8904.0 7453.3 8062.7 8155.7 8167.4 8260.1 9786.6 9932.8 10012.7 10044.2 10061.6 10068.0 10350.1 10356.9 10509.7 10515.3 7055.9 7649.5 7683.2 7789.4 7853.0 8468.5 8499.0 8559.1 8570.7 8581.8 7429.3 7594.0 7670.3 7679.2 7688.7 7377.0 7446.0 7446.2 7529.6 7617.8 8006.0 8031.8 8067.2 8085.2 8091.0 7218.0 7245.6 7271.2 7287.7 7335.0 7341.1 7344.9 7384.3 7406.3 7419.3 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#4] prototype.html Cycles:180 Average:5942.66 Median:6773.53 stddev:1915.59 (28.3%) stddev-sans-first:1873.48 16:19:21 INFO - PROCESS | 2066 | Values: 295.1 340.1 340.7 341.1 344.3 5776.7 6687.8 6773.1 6830.5 6881.0 6820.2 6828.4 6850.3 6860.6 6893.1 4885.4 4906.2 5002.9 5045.2 5066.9 5035.3 5037.9 5045.7 5052.8 5064.7 5010.7 5017.3 5028.7 5039.1 5040.4 4064.3 4216.5 4393.3 4525.8 5031.8 4302.7 4307.5 4314.5 4316.7 4331.8 6302.4 6432.0 6520.2 6540.1 6563.9 4780.5 4962.5 5903.0 5915.6 5935.4 7203.1 7219.1 7223.3 7226.2 7234.3 4820.6 4831.8 4837.0 4842.2 4854.0 7645.2 7660.3 7671.7 7698.5 7702.8 4761.1 4864.3 4928.0 4929.3 4940.0 4139.4 4971.9 5015.2 5020.8 5031.1 4522.8 5871.2 5875.4 5880.5 5895.9 7291.0 7302.9 7304.8 7307.7 7315.6 1715.8 1738.6 1742.7 1743.5 1744.9 1028.8 1076.3 1076.8 1089.8 1125.1 6415.5 6559.6 6570.2 6573.4 6607.3 7474.9 7480.4 7482.1 7504.6 7512.2 6384.2 6534.3 6774.0 6838.0 6849.5 3989.3 4016.2 4016.7 4019.7 4040.6 7925.2 7934.5 7958.6 7964.3 7966.0 7465.5 7860.3 7867.5 7876.5 7886.8 7825.4 7856.8 7870.4 7881.8 7901.1 7563.7 7582.8 7590.7 7604.7 7609.1 7432.1 7433.7 7435.0 7443.0 7462.5 7571.4 7853.9 7880.4 7903.7 7904.2 4721.1 4734.8 4776.6 4784.9 4797.0 7503.2 7503.5 7527.8 7539.4 7561.6 7275.0 7278.3 7296.5 7298.4 7320.5 7066.6 7263.2 7272.0 7305.2 7341.2 7049.6 7090.6 7096.3 7101.4 7134.8 5880.9 7257.6 7270.3 7286.5 7292.7 6895.2 7115.2 7116.0 7118.6 7128.4 16:19:21 INFO - PROCESS | 2066 | 16:19:21 INFO - PROCESS | 2066 | [#5] yui.html Cycles:180 Average:18707.86 Median:50904.98 stddev:26577.31 (52.2%) stddev-sans-first:26617.22 16:19:21 INFO - PROCESS | 2066 | Values: 633.6 655.9 700.8 714.6 789.4 12868.4 14656.6 15304.8 15314.8 15441.6 14112.5 14155.7 14171.2 14185.9 14192.8 760.3 902.0 971.8 973.2 974.0 946.9 950.8 960.5 965.3 965.4 1013.2 1016.9 1018.1 1019.6 1021.5 994.3 1001.5 1005.4 1006.6 1011.7 735.5 746.4 753.3 754.9 758.0 14819.0 14953.6 15214.9 15230.7 15506.8 12880.6 12912.4 12972.2 13072.7 13134.5 10065.4 10067.4 10225.3 10353.9 10550.4 3504.4 3516.3 3517.2 3612.7 3677.4 82859.0 83550.2 84336.9 84935.9 85479.6 8376.7 9442.0 9530.7 9713.4 10159.0 22310.4 22368.4 22384.3 22429.8 22433.4 7010.4 7442.5 7538.7 7669.0 7669.0 4015.4 4072.9 4075.3 4100.7 4101.6 3659.4 3679.5 3693.9 3697.3 3712.1 662.0 669.1 670.6 671.7 672.1 596.1 601.0 601.2 603.0 615.6 8363.3 8416.5 8421.0 8452.4 8560.4 543.2 575.4 576.9 603.4 621.5 3791.8 3881.3 3890.5 4081.7 4179.6 85876.7 89026.1 94341.0 98021.0 98953.0 83214.0 83672.0 83829.7 83923.6 86148.1 74589.0 74663.6 74771.3 75320.6 75351.6 7755.5 7766.4 7847.8 7912.5 8205.6 39890.0 43135.0 48387.3 50504.5 51305.5 61314.1 68527.3 68779.6 68832.3 69257.0 10200.0 10225.3 11133.5 11536.8 11544.8 11903.9 11959.7 12057.8 12104.6 12767.9 11567.0 11625.4 11697.5 11788.4 11873.6 11692.9 11965.9 11995.6 12077.0 12107.2 10986.2 11274.2 11459.1 11525.1 11526.8 9313.3 9771.9 9822.6 9909.4 10074.9 8760.1 9646.8 9707.5 9917.3 10091.5 16:19:21 INFO - PROCESS | 2066 | -------- Summary: end -------- 16:19:21 INFO - PROCESS | 2066 | 16:19:22 INFO - TEST-INFO | 2066: exit 0 16:19:22 INFO - TEST-OK | dromaeo_css | took 1110900ms 16:19:22 INFO - TEST-START | kraken 16:19:22 INFO - operating with platform_type : mac_ 16:19:22 INFO - Initialising browser for kraken test... 16:19:22 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/tmpXz3EIT/profile http://localhost:49518/getInfo.html) 16:19:24 INFO - PROCESS | 2182 | __metrics Screen width/height:1600/1200 16:19:24 INFO - PROCESS | 2182 | colorDepth:24 16:19:24 INFO - PROCESS | 2182 | Browser inner width/height: 1024/689 16:19:24 INFO - PROCESS | 2182 | __metrics 16:19:24 ERROR - PROCESS | 2182 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:19:25 INFO - TEST-INFO | 2182: exit 0 16:19:25 INFO - Browser initialized. 16:19:25 INFO - Running cycle 1/1 for kraken test... 16:19:25 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/T/tmpXz3EIT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:37 INFO - PROCESS | 2185 | RSS: Main: 195719168 16:19:37 INFO - PROCESS | 2185 | 16:19:39 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49518/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:40 INFO - PROCESS | 2185 | RSS: Main: 207646720 16:19:40 INFO - PROCESS | 2185 | 16:19:43 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49518/tests/kraken/driver.html?testName=audio-dft) 16:19:43 INFO - PROCESS | 2185 | RSS: Main: 216883200 16:19:43 INFO - PROCESS | 2185 | 16:19:47 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49518/tests/kraken/driver.html?testName=audio-fft) 16:19:47 INFO - PROCESS | 2185 | RSS: Main: 220090368 16:19:47 INFO - PROCESS | 2185 | 16:19:49 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49518/tests/kraken/driver.html?testName=audio-oscillator) 16:19:50 INFO - PROCESS | 2185 | RSS: Main: 221151232 16:19:50 INFO - PROCESS | 2185 | 16:19:52 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:52 INFO - PROCESS | 2185 | RSS: Main: 222621696 16:19:52 INFO - PROCESS | 2185 | 16:19:55 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49518/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:56 INFO - PROCESS | 2185 | RSS: Main: 222740480 16:19:56 INFO - PROCESS | 2185 | 16:19:58 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49518/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:59 INFO - PROCESS | 2185 | RSS: Main: 222470144 16:19:59 INFO - PROCESS | 2185 | 16:20:02 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49518/tests/kraken/driver.html?testName=json-parse-financial) 16:20:02 INFO - PROCESS | 2185 | RSS: Main: 222523392 16:20:02 INFO - PROCESS | 2185 | 16:20:04 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:05 INFO - PROCESS | 2185 | RSS: Main: 222154752 16:20:05 INFO - PROCESS | 2185 | 16:20:06 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:07 INFO - PROCESS | 2185 | RSS: Main: 222072832 16:20:07 INFO - PROCESS | 2185 | 16:20:09 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:20:10 INFO - PROCESS | 2185 | RSS: Main: 222371840 16:20:10 INFO - PROCESS | 2185 | 16:20:12 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:20:13 INFO - PROCESS | 2185 | RSS: Main: 222416896 16:20:13 INFO - PROCESS | 2185 | 16:20:16 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:16 INFO - PROCESS | 2185 | RSS: Main: 222515200 16:20:16 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:49518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49518/tests/kraken/driver.html?testName=ai-astar) 16:20:18 INFO - PROCESS | 2185 | RSS: Main: 223977472 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | __start_tp_report 16:20:18 INFO - PROCESS | 2185 | _x_x_mozilla_page_load 16:20:18 INFO - PROCESS | 2185 | _x_x_mozilla_page_load_details 16:20:18 INFO - PROCESS | 2185 | |i|pagename|runs| 16:20:18 INFO - PROCESS | 2185 | |0;ai-astar;120;157;163;97;166;186;153;165;148;115 16:20:18 INFO - PROCESS | 2185 | |1;audio-beat-detection;155;123;157;186;140;142;121;155;131;148 16:20:18 INFO - PROCESS | 2185 | |2;audio-dft;199;196;196;202;223;221;197;195;197;199 16:20:18 INFO - PROCESS | 2185 | |3;audio-fft;68;80;88;140;59;55;59;60;122;57 16:20:18 INFO - PROCESS | 2185 | |4;audio-oscillator;86;78;117;79;81;85;119;78;79;145 16:20:18 INFO - PROCESS | 2185 | |5;imaging-gaussian-blur;91;89;90;88;90;87;90;88;90;91 16:20:18 INFO - PROCESS | 2185 | |6;imaging-darkroom;96;96;96;95;111;95;96;96;97;94 16:20:18 INFO - PROCESS | 2185 | |7;imaging-desaturate;93;91;92;92;94;92;96;94;92;106 16:20:18 INFO - PROCESS | 2185 | |8;json-parse-financial;54;59;57;59;60;62;58;60;60;57 16:20:18 INFO - PROCESS | 2185 | |9;json-stringify-tinderbox;65;68;70;90;99;99;88;65;66;68 16:20:18 INFO - PROCESS | 2185 | |10;stanford-crypto-aes;85;82;87;94;102;99;86;81;80;83 16:20:18 INFO - PROCESS | 2185 | |11;stanford-crypto-ccm;117;130;138;114;122;125;131;133;114;128 16:20:18 INFO - PROCESS | 2185 | |12;stanford-crypto-pbkdf2;132;131;171;137;140;172;168;139;133;134 16:20:18 INFO - PROCESS | 2185 | |13;stanford-crypto-sha256-iterative;67;66;71;69;64;67;64;66;66;66 16:20:18 INFO - PROCESS | 2185 | __end_tp_report 16:20:18 INFO - PROCESS | 2185 | __start_cc_report 16:20:18 INFO - PROCESS | 2185 | _x_x_mozilla_cycle_collect,922 16:20:18 INFO - PROCESS | 2185 | __end_cc_report 16:20:18 INFO - PROCESS | 2185 | __startTimestamp1467328818538__endTimestamp 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | ------- Summary: start ------- 16:20:18 INFO - PROCESS | 2185 | Number of tests: 14 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#0] ai-astar Cycles:10 Average:147.00 Median:164.00 stddev:27.59 (16.8%) stddev-sans-first:27.48 16:20:18 INFO - PROCESS | 2185 | Values: 120.0 157.0 163.0 97.0 166.0 186.0 153.0 165.0 148.0 115.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:151.50 stddev:19.20 (12.7%) stddev-sans-first:20.07 16:20:18 INFO - PROCESS | 2185 | Values: 155.0 123.0 157.0 186.0 140.0 142.0 121.0 155.0 131.0 148.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#2] audio-dft Cycles:10 Average:202.50 Median:199.00 stddev:10.48 (5.3%) stddev-sans-first:11.04 16:20:18 INFO - PROCESS | 2185 | Values: 199.0 196.0 196.0 202.0 223.0 221.0 197.0 195.0 197.0 199.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#3] audio-fft Cycles:10 Average:78.80 Median:59.50 stddev:29.80 (50.1%) stddev-sans-first:31.35 16:20:18 INFO - PROCESS | 2185 | Values: 68.0 80.0 88.0 140.0 59.0 55.0 59.0 60.0 122.0 57.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:23.63 (29.9%) stddev-sans-first:24.85 16:20:18 INFO - PROCESS | 2185 | Values: 86.0 78.0 117.0 79.0 81.0 85.0 119.0 78.0 79.0 145.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:1.35 (1.5%) stddev-sans-first:1.30 16:20:18 INFO - PROCESS | 2185 | Values: 91.0 89.0 90.0 88.0 90.0 87.0 90.0 88.0 90.0 91.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:96.00 stddev:4.92 (5.1%) stddev-sans-first:5.20 16:20:18 INFO - PROCESS | 2185 | Values: 96.0 96.0 96.0 95.0 111.0 95.0 96.0 96.0 97.0 94.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:92.50 stddev:4.39 (4.7%) stddev-sans-first:4.64 16:20:18 INFO - PROCESS | 2185 | Values: 93.0 91.0 92.0 92.0 94.0 92.0 96.0 94.0 92.0 106.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.50 stddev:2.22 (3.7%) stddev-sans-first:1.62 16:20:18 INFO - PROCESS | 2185 | Values: 54.0 59.0 57.0 59.0 60.0 62.0 58.0 60.0 60.0 57.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:79.00 stddev:14.42 (18.3%) stddev-sans-first:14.53 16:20:18 INFO - PROCESS | 2185 | Values: 65.0 68.0 70.0 90.0 99.0 99.0 88.0 65.0 66.0 68.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.50 stddev:7.75 (9.1%) stddev-sans-first:8.15 16:20:18 INFO - PROCESS | 2185 | Values: 85.0 82.0 87.0 94.0 102.0 99.0 86.0 81.0 80.0 83.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:129.00 stddev:8.28 (6.4%) stddev-sans-first:8.24 16:20:18 INFO - PROCESS | 2185 | Values: 117.0 130.0 138.0 114.0 122.0 125.0 131.0 133.0 114.0 128.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:139.50 stddev:17.27 (12.4%) stddev-sans-first:17.59 16:20:18 INFO - PROCESS | 2185 | Values: 132.0 131.0 171.0 137.0 140.0 172.0 168.0 139.0 133.0 134.0 16:20:18 INFO - PROCESS | 2185 | 16:20:18 INFO - PROCESS | 2185 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.12 (3.2%) stddev-sans-first:2.24 16:20:18 INFO - PROCESS | 2185 | Values: 67.0 66.0 71.0 69.0 64.0 67.0 64.0 66.0 66.0 66.0 16:20:18 INFO - PROCESS | 2185 | -------- Summary: end -------- 16:20:18 INFO - PROCESS | 2185 | 16:20:19 INFO - TEST-INFO | 2185: exit 0 16:20:19 INFO - TEST-OK | kraken | took 57163ms 16:20:19 INFO - SUITE-END | took 1168s 16:20:19 INFO - Completed test suite (00:19:28) 16:20:19 INFO - javascript benchmark 16:20:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3526.030341656044, 3560.857565697372, 3585.4263317869145, 3605.729570282228, 3636.581793093795, 5864.501517371018, 5880.176775251468, 5919.052951527757, 5919.85200369991, 5931.555133364998, 5921.911171332434, 5948.196993405889, 5984.880302393961, 6003.219581454416, 6005.3394126646035, 5288.8413347599635, 5321.787128514874, 5363.195520671911, 5404.621676482629, 5499.900019996016, 3964.682825373963, 5302.628815982883, 5417.295751552293, 5417.756200970965, 5453.700046497441, 4494.865154045384, 5358.839234822962, 5382.6232163748555, 5400.189971504286, 5485.506304432601, 4004.83980640774, 5160.870978225536, 5417.539509141728, 5461.890762184774, 5469.453054694539, 4765.737884416356, 5244.606654500928, 5263.578913686896, 5323.600729945269, 5326.6537675050995, 5720.742566584514, 5744.22452968848, 5758.596898217126, 5792.710364481759, 5799.797007104731, 5305.7612407441375, 5856.443637854397, 6276.215473065867, 6278.4663303619245, 6293.779717709858, 6225.097360882647, 6276.748930042792, 6297.244330680302, 6306.747730090791, 6315.842103947392, 5950.6132101413705, 5976.163337132805, 5990.026575890644, 6003.759849606055, 6025.9096113558335, 6237.75048998035, 6297.244330680256, 6315.179026726496, 6335.334789847, 6355.809325720235, 6209.410106040009, 6282.623042617458, 6284.528660350401, 6293.024581189923, 6299.590526615755, 6265.530085243625, 6286.119943207955, 6310.7791227306825, 6315.5263355247625, 6322.968385158045, 6189.907151392733, 6193.4425901669065, 6201.7519299228425, 6211.3478084801345, 6274.40393162658, 6231.158793562811, 6275.560710750295, 6279.120923070774, 6279.843003924939, 6285.779997700059, 4948.109340318705, 4988.426330971912, 4988.625853061035, 4993.475685053089, 5016.122178618727, 4442.022754993896, 4448.55514448559, 4450.376947227391, 4498.392716983165, 4512.481064677604, 5761.452661997104, 5878.147668588116, 5897.498712609477, 5923.881522369528, 5924.555658325643, 6283.842903927439, 6288.811335659938, 6295.811125666238, 6313.810585682437, 6324.620522768649, 5782.537397008229, 5900.409959004065, 5956.821295361146, 5979.611325263931, 6005.159277701126, 5504.339479262514, 5510.641808282448, 5530.557555395559, 5533.557315414757, 5550.417206193372, 6422.2614399344675, 6447.194100737408, 6450.8064758057335, 6451.096846441502, 6460.0, 6205.2553693557065, 6249.0626406039455, 6253.280872699515, 6298.842528936813, 6332.335104814112, 6427.357264273535, 6428.871422571616, 6429.678516074084, 6446.64543450096, 6474.320196379313, 5546.0, 6267.5299352549655, 6286.339934306832, 6286.402791734778, 6294.244690637152, 6126.590884096772, 6179.598326108789, 6227.159333489921, 6241.906371404523, 6291.622502649856, 5278.076336641149, 6236.6258024518675, 6250.624962502265, 6252.562320637512, 6269.0, 6095.969520152371, 6205.968970155121, 6224.221972253468, 6265.5927364722975, 6280.685965701788, 6117.908231376622, 6127.571070025056, 6127.698530765323, 6130.826205142415, 6153.815385538441, 6249.96875015622, 6261.874762504815, 6269.279032911274, 6281.842953926006, 6282.937170628235, 6119.632822030692, 6132.846678833065, 6195.256569211723, 6203.069539569101, 6223.128761973418], "unit": "score", "name": "dojo.html", "value": 5787.7004903726065}, {"lowerIsBetter": false, "replicates": [484.72350041678516, 588.1471865794596, 603.3031848215313, 626.4424662050774, 672.1497305908026, 38393.616063839356, 39227.82316530505, 39279.0180245494, 39307.80346098266, 39368.0, 40517.0, 40764.980875478126, 40818.38772418416, 41235.79382103085, 41292.38061429081, 9479.620815167385, 9678.564464599074, 9680.419174849496, 9717.902820971805, 9718.465484398355, 9611.231101511863, 9735.269854760885, 9769.511524423786, 9778.266630002743, 9779.266555008368, 9749.122578967892, 9833.557489912972, 9835.508224588777, 9841.45871977041, 9851.162651174658, 9717.31978761487, 9783.0, 9793.314467987244, 9815.852762208573, 9833.213342932584, 9586.233101351945, 9714.708558743248, 9717.757056073584, 9737.172340351079, 9765.365251258645, 33739.0, 39614.20771584552, 39913.0, 40024.799876000434, 40319.59680403188, 3163.7943533670236, 3344.147242453159, 3369.2756057447523, 3394.8132852693093, 3521.4893840393256, 26916.0, 27071.864640676868, 27519.724802751916, 27813.721862781316, 28179.436411271865, 2765.958510622342, 2785.916422507328, 2786.8606569671433, 2789.1074856046075, 2853.7716982641546, 317099.0, 318290.0, 319045.0, 319515.0, 320027.0, 46618.06763864704, 47305.290420643716, 67843.66078169577, 68426.0, 68443.0, 46872.765636172284, 47352.0, 47398.526014739415, 47582.0, 47584.5241547587, 16705.498835034967, 16838.073905935293, 16875.24061417239, 16901.323947042227, 16942.830571694372, 13499.325033748273, 13581.0, 13596.320183990762, 13612.65968350799, 13614.183149010893, 13380.799288010687, 15157.772633410508, 15310.0, 15442.768358474632, 15581.0, 5709.286339207599, 6590.176227971504, 6707.731690732414, 6726.562773419712, 6758.952362383839, 834.382556907896, 1026.2457094035879, 1029.9433531155858, 1041.6874937518714, 1084.915084915085, 23401.648975265383, 25782.0, 29694.0, 30253.0, 30405.0, 1138.1350173867754, 1147.8679951805482, 1169.7601991591703, 1205.7106294489258, 1219.2623462805052, 15240.847591524165, 15900.363985440454, 16225.432109876097, 16909.900856444292, 17129.22918468672, 523715.0, 533633.0, 533802.0, 534017.0, 535618.0, 62348.0, 62671.0, 62861.68569157125, 62864.42838929063, 62952.74094518176, 1544.5057581573788, 1578.455432875656, 1581.7785510028605, 1585.5956731033743, 1697.558634754948, 30030.849845750632, 31279.01920702883, 31361.372772544877, 31747.84126079355, 32000.19999499938, 54220.0, 54597.908041839735, 54799.0, 54867.17699234435, 54903.0, 490758.0, 491438.0, 492255.0, 495403.0, 495823.0, 33339.83330083334, 34130.65869341275, 34921.82539087288, 34967.82516087505, 35022.47466288059, 45539.54460455485, 45579.0, 45677.08645827131, 45688.0, 46214.0, 37762.811185943894, 37874.810625946695, 37981.0, 38108.428373573865, 38442.84671459749, 36664.63335366612, 37636.62363376441, 37970.43044354281, 38067.809660952626, 38142.618573815016, 26245.606315905658, 36864.26271474609, 37349.0, 37793.62206377901, 38289.0, 26801.86599066992, 30167.245818854703, 31497.685023149475, 34840.65159348374, 38033.4294985581, 23314.53370932538, 24704.011839526218, 25038.62442063334, 25307.367315816515, 25992.35019124537], "unit": "score", "name": "ext.html", "value": 19468.15053748966}, {"lowerIsBetter": false, "replicates": [373.47153777404975, 381.11961369237054, 383.1972018620989, 385.4468837218593, 386.91487872668023, 19360.4901490144, 20028.399148025583, 20292.0, 20880.582388352224, 20915.477113072182, 17091.31634734609, 21008.579828403424, 21211.0, 21374.0, 21450.785492145074, 5780.653160810365, 5885.20549725788, 5942.138389933457, 5950.494207992326, 5953.970230148843, 4190.937135942963, 4716.716996980175, 6369.8089057328125, 6371.617702937815, 6383.170187875569, 6359.491240700733, 6457.45111665509, 6464.870702585946, 6474.1907261592305, 6474.417302442779, 6137.570370074097, 6408.61548307103, 6413.070104834819, 6416.550841441078, 6423.967880160616, 5445.37378201504, 5570.220169176318, 5579.8884022319735, 5596.832095037155, 5598.524125449342, 20242.98785060756, 24825.50348993028, 24925.875370623213, 25030.0, 25205.62191567128, 2183.8908054597364, 2188.6388745856916, 2208.0, 2221.8444708870225, 2232.720909886264, 15084.698306033928, 15243.314050867737, 15270.694586108326, 15504.612384690361, 15529.611759705986, 1436.7701167813204, 1767.9469615911414, 1811.1759149586906, 1811.994343139557, 1816.781986161669, 103291.48354258256, 107436.0, 110037.9999999992, 110541.44729276303, 111858.0, 10494.0, 11073.833892491619, 11567.363794991355, 11582.305061696325, 11659.417029148679, 13949.093308934887, 13988.230647314496, 14047.85952140486, 14071.929640351733, 14092.154470731788, 8843.336749743796, 8885.0670679579, 8933.955330223307, 9003.14470125337, 9015.188633022928, 9089.50007749567, 9166.49584272858, 9182.0, 9198.770030749285, 9255.074492550826, 4438.511763706054, 4564.2012647786505, 4578.153041687298, 4580.564846339593, 4617.884552886205, 1913.1868955694054, 1962.077823422989, 1963.2834015584208, 2004.0681083296338, 2008.0662491941025, 857.8798968144465, 964.9951750241204, 993.3989936088707, 1017.2218253036433, 1036.875574931013, 19892.0, 20380.592388152152, 20478.385648430274, 20733.0, 20812.0, 959.1703176752059, 1021.4280003198085, 1021.8365061590258, 1049.506731836036, 1099.395332567085, 10098.091171794575, 10545.84181237282, 10660.025155223715, 11136.888631113585, 11916.404179791149, 271204.0, 368812.0, 634536.0, 641708.0, 649796.0, 109251.0, 128677.0, 129188.3540582291, 135066.0, 135376.32311838376, 956.1872408452759, 1050.7110544600143, 1074.3285446595878, 1079.0881704959297, 1092.2790957967702, 16834.0, 18511.90744046271, 18654.813451865306, 18755.624887502447, 18854.151563179417, 40080.99797505086, 41370.0, 43623.127537449705, 54357.641058973844, 55348.0, 76109.0, 78796.0, 79019.60490197512, 81455.59272203602, 81659.0, 7219.819504512429, 8032.879506807286, 8172.182781722018, 8423.536705481258, 8631.26634236097, 13300.733985320046, 13359.799603006157, 13374.866251337362, 13691.520796772464, 13786.310684465938, 9186.989431162434, 10322.896771032194, 10834.837477437686, 11169.609063682732, 11369.0, 11475.713107172054, 11562.479688413874, 11581.478833452684, 11659.475323610628, 11825.763484730429, 11761.764764704829, 11816.527338906348, 11987.34069626144, 12107.0, 12313.69215769577, 8410.074891761778, 8478.109798471072, 8536.274416674403, 8653.395667819635, 8673.653053877773, 11887.762244754884, 11899.464524096264, 11927.761444770882, 12119.939400302943, 12174.330411827434], "unit": "score", "name": "jquery.html", "value": 9728.083339336665}, {"lowerIsBetter": false, "replicates": [1617.312642127096, 1631.0376877642188, 1975.6147551227507, 2002.1090614676475, 2052.066309829028, 8309.210624990616, 9064.229540489066, 9077.863832042516, 9281.257499400048, 9308.069193080697, 9018.594163262653, 9069.546522673856, 9110.180083792457, 9155.542222888862, 9167.633294668221, 2585.974140258597, 2591.883365248568, 2593.1701855406277, 2599.909003184889, 2601.5967525033557, 2548.6686730724978, 2597.3766296088993, 2608.2305719812703, 2614.346413396651, 2615.6730408698913, 2583.6253743207317, 2587.767100960913, 2603.4923189977962, 2624.0553400775707, 2628.093307808803, 2535.074697735332, 2556.0542599238306, 2573.5110329037425, 2607.1657069737694, 2616.306678730119, 2498.6127150291554, 2517.509085728284, 2538.5176816404824, 2539.136693524211, 2542.8982840686535, 9202.631894724203, 9215.53922303882, 9230.400023998418, 9240.722778316662, 9240.768980775534, 5606.495415412633, 5757.395473475267, 5774.884502309972, 5780.479756821906, 5792.420757924216, 3615.6022837487853, 3736.4768932349493, 3748.5876553579355, 3774.735768496206, 3778.6410291022307, 1060.3955745225226, 1081.5187241677456, 1093.748437859289, 1126.3242054767156, 1126.915481338903, 10417.583296668125, 12166.5741699041, 12320.815187772101, 12326.568570100004, 12423.44094515749, 5019.799208031711, 5062.493750624982, 5109.897802043938, 5110.591152707774, 5124.718140502308, 10610.310329828537, 10625.628103016357, 10640.893591064145, 10664.133776589066, 10736.785264294671, 5647.181158732043, 5704.914426283609, 5778.88442231153, 5794.420557944172, 5824.126381042877, 4665.136949664323, 5014.122528557561, 5085.389753229636, 5157.123289040872, 5219.530242278213, 4090.339146463898, 4117.0, 4120.340745480708, 4166.0834616384955, 4190.308599081118, 1165.3998190931677, 1318.7998920982052, 1330.9134906231063, 1347.7506661267696, 1352.1278775189946, 1150.8503894493663, 1182.0425455380996, 1273.7898246789175, 1429.492530151802, 1447.9276036198148, 8318.8336233275, 8333.0, 8385.28725058377, 8389.412741108064, 8397.454165479347, 527.4988760677372, 528.1391332128683, 534.3827878799915, 535.1277417808947, 535.7910414938177, 6305.558610897193, 6322.652254125976, 6342.936570634327, 6350.682465876687, 6444.9355506444335, 10747.946260268649, 11280.379579123228, 11385.14611404148, 11418.371989540656, 11425.942870285595, 10785.514651840685, 10952.069074128629, 11004.889951100387, 11049.723756906142, 11067.169962252863, 8718.95640521806, 8720.040795512488, 8742.82514349722, 8860.3797734158, 8903.976042755037, 7453.25467453272, 8062.677492900453, 8155.673773049249, 8167.428280020342, 8260.132686067876, 9786.608535658494, 9932.751681208028, 10012.749681258027, 10044.196464282986, 10061.647842325483, 10068.0, 10350.068493835592, 10356.948215258875, 10509.737256568647, 10515.26393152472, 7055.858882822417, 7649.464537482323, 7683.154852966281, 7789.4157938155995, 7852.960735196288, 8468.53423061713, 8499.0, 8559.101294364002, 8570.700025499078, 8581.785455363666, 7429.294217049372, 7594.0, 7670.309672129535, 7679.193684663253, 7688.730894418669, 7377.0, 7445.957565940881, 7446.180920098893, 7529.585872776831, 7617.771466856003, 8005.959970200344, 8031.759047228593, 8067.152948940511, 8085.151059138941, 8091.0, 7217.963910180415, 7245.637718113968, 7271.163816160997, 7287.672054757442, 7334.97310376537, 7341.119065712149, 7344.926550734424, 7384.261573842573, 7406.259374062766, 7419.332260096401], "unit": "score", "name": "mootools.html", "value": 5045.153242728349}, {"lowerIsBetter": false, "replicates": [295.0572919522125, 340.1106107528812, 340.6814628322517, 341.1028993746448, 344.2907610322735, 5776.653400795955, 6687.799366019027, 6773.085633439484, 6830.453563714903, 6880.965595172023, 6820.215675197353, 6828.419584335325, 6850.3492168244065, 6860.588364698109, 6893.103896493449, 4885.364902562662, 4906.239532872392, 5002.8993621403415, 5045.217991211368, 5066.898662026748, 5035.345405097332, 5037.884088682762, 5045.672031317971, 5052.7726252318735, 5064.721440320781, 5010.69935803853, 5017.272495488152, 5028.723420211887, 5039.09296326661, 5040.36995375578, 4064.268431682296, 4216.536181020086, 4393.297072468422, 4525.845909293125, 5031.81752288212, 4302.7203231790145, 4307.5261721210645, 4314.546972567867, 4316.719413238129, 4331.7617531035785, 6302.432781049728, 6431.967840160816, 6520.2175738911155, 6540.149780528548, 6563.901541476882, 4780.521947805227, 4962.503749625044, 5903.0, 5915.5859089863725, 5935.376785437553, 7203.063601731794, 7219.0976127984, 7223.277672232787, 7226.205117437078, 7234.2765723427765, 4820.6143508519235, 4831.782569784368, 4836.951630483685, 4842.225243960985, 4854.0, 7645.197254288275, 7660.2722741339485, 7671.660143656182, 7698.537277917234, 7702.807429814244, 4761.095391875532, 4864.294677271776, 4927.9507204927495, 4929.309896614477, 4940.0, 4139.3583994480905, 4971.90056198874, 5015.197568389113, 5020.849374518771, 5031.144705400017, 4522.751248681354, 5871.178035075093, 5875.383084776123, 5880.500157486576, 5895.852603684856, 7291.0, 7302.926970730331, 7304.8173795654475, 7307.671154798047, 7315.597642129734, 1715.836995485427, 1738.6001219719283, 1742.6950283700303, 1743.4856717268435, 1744.8604111671036, 1028.7685270814156, 1076.3380520979542, 1076.8223243164946, 1089.7548051688307, 1125.1336470917347, 6415.454686351619, 6559.573627714183, 6570.244421891448, 6573.408393244631, 6607.306232845578, 7474.925250747532, 7480.364169045583, 7482.139553951257, 7504.62476876165, 7512.248775122444, 6384.170057892445, 6534.346565343522, 6773.966130169416, 6837.965810170917, 6849.520533562702, 3989.30454556818, 4016.1566071124807, 4016.6585840203325, 4019.658329042006, 4040.595940405936, 7925.167857375008, 7934.523928564305, 7958.6418611162635, 7964.323032542299, 7966.0440747110715, 7465.514741541891, 7860.292573668283, 7867.527948323119, 7876.488028278143, 7886.802829929297, 7825.3739700824935, 7856.803579910434, 7870.409719271078, 7881.842363152705, 7901.051873775069, 7563.659635316314, 7582.848343032998, 7590.734324298623, 7604.733834315773, 7609.086909570887, 7432.070991126109, 7433.702651893864, 7434.996275502738, 7443.032405787213, 7462.4776265660885, 7571.3942884568005, 7853.882191767014, 7880.448368614142, 7903.723369682033, 7904.20957904228, 4721.079389519011, 4734.834280800155, 4776.5701086902345, 4784.928226076681, 4797.0, 7503.1746507883, 7503.512271702322, 7527.8494430109995, 7539.396848252236, 7561.584112873845, 7275.017872587345, 7278.344948954619, 7296.452766042462, 7298.416126709744, 7320.534473970767, 7066.57600543969, 7263.201047884834, 7272.0, 7305.159906610807, 7341.229170936975, 7049.577025378494, 7090.574565525879, 7096.290370962863, 7101.431885449048, 7134.8216294590975, 5880.94167041532, 7257.600831954293, 7270.345668889825, 7286.453515986216, 7292.708291668274, 6895.241523432519, 7115.181754098138, 7116.0, 7118.572885626671, 7128.394086502705], "unit": "score", "name": "prototype.html", "value": 5300.596364072514}, {"lowerIsBetter": false, "replicates": [633.6134957675814, 655.9475241980642, 700.8423104801417, 714.6033951157108, 789.3724489031222, 12868.420921058552, 14656.560303190909, 15304.84695153048, 15314.846851531482, 15441.613959651015, 14112.506062287823, 14155.716885662281, 14171.220582867938, 14185.929070354634, 14192.787108193384, 760.3005235183631, 901.9594118264694, 971.7570607348163, 973.2214228617113, 974.0211087856729, 946.9242460603135, 950.8240975419535, 960.5245403525265, 965.2953344058806, 965.4159233663638, 1013.1742629756725, 1016.8779746430439, 1018.1447584029414, 1019.6482213636284, 1021.4739409204266, 994.3337963564393, 1001.4742260313358, 1005.3666190300137, 1006.5520843224768, 1011.6964910526813, 735.4998600951404, 746.4401698725956, 753.3445902065238, 754.9245075492407, 758.0297219558973, 14819.0, 14953.551393458214, 15214.923925380413, 15230.695386092217, 15506.767398489032, 12880.613581592566, 12912.354382280848, 12972.156809807333, 13072.738545229136, 13134.474621015148, 10065.446400447972, 10067.446290454021, 10225.284230103896, 10353.948230258877, 10550.366977981346, 3504.3867323218333, 3516.314318707853, 3517.155882588186, 3612.747107702462, 3677.3932301170275, 82859.0, 83550.16449835485, 84336.89157771044, 84935.8766030848, 85479.57260213721, 8376.706815261437, 9442.0, 9530.685201597144, 9713.417194968184, 10159.034891685278, 22310.442238943833, 22368.440788980406, 22384.328470145596, 22429.77570224277, 22433.43916402103, 7010.404115650125, 7442.479026468203, 7538.660760265691, 7668.961655191688, 7668.9616551918, 4015.357542793139, 4072.8778136655947, 4075.3275709508193, 4100.671946244293, 4101.610347017028, 3659.4144936810517, 3679.5032670589126, 3693.9445908311395, 3697.2975134724315, 3712.0534263763107, 661.9669016549153, 669.0733334331888, 670.5842377725842, 671.7413795688695, 672.0792514255404, 596.1474345258007, 600.9819705408845, 601.179390132466, 602.9668368239701, 615.6336979497192, 8363.289120424832, 8416.452930559493, 8421.0, 8452.36607254446, 8560.357973152039, 543.1879340386148, 575.4159528079003, 576.9480746732814, 603.3724926076831, 621.4624349937271, 3791.829367678461, 3881.340172170738, 3890.4747859038666, 4081.69387295954, 4179.644730197906, 85876.71184932231, 89026.10973890308, 94341.0, 98021.0, 98953.0, 83214.0, 83672.0, 83829.74255386174, 83923.5803820977, 86148.13851861401, 74589.0, 74663.62668186733, 74771.25228747752, 75320.62339688267, 75351.62324188344, 7755.457118001686, 7766.378689704923, 7847.803804904923, 7912.525248485109, 8205.630746616298, 39890.0, 43135.0, 48387.27419088787, 50504.49495505145, 51305.46083617498, 61314.08028879481, 68527.31472685409, 68779.62440751257, 68832.31167688259, 69257.0, 10200.030997055268, 10225.335353202017, 11133.498992545517, 11536.82694759596, 11544.769104618028, 11903.940480297542, 11959.701007474883, 12057.75884482288, 12104.576339828063, 12767.872321276669, 11566.958973692408, 11625.418729063682, 11697.473613687574, 11788.410579471163, 11873.643790686294, 11692.94153529227, 11965.940170299093, 11995.580154694544, 12077.0, 12107.152499324962, 10986.176036797431, 11274.154438417316, 11459.140564457532, 11525.077993760311, 11526.769464610494, 9313.34806563534, 9771.85342219853, 9822.607095716377, 9909.355891867006, 10074.89925100769, 8760.12398760119, 9646.807063858543, 9707.514624268899, 9917.256205784452, 10091.495425228562], "unit": "score", "name": "yui.html", "value": 7039.956755475291}], "name": "dromaeo_css", "value": 7687.349716855493}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [120.0, 157.0, 163.0, 97.0, 166.0, 186.0, 153.0, 165.0, 148.0, 115.0], "unit": "score", "name": "ai-astar", "value": 147.0}, {"lowerIsBetter": true, "replicates": [155.0, 123.0, 157.0, 186.0, 140.0, 142.0, 121.0, 155.0, 131.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [199.0, 196.0, 196.0, 202.0, 223.0, 221.0, 197.0, 195.0, 197.0, 199.0], "unit": "score", "name": "audio-dft", "value": 202.5}, {"lowerIsBetter": true, "replicates": [68.0, 80.0, 88.0, 140.0, 59.0, 55.0, 59.0, 60.0, 122.0, 57.0], "unit": "score", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [86.0, 78.0, 117.0, 79.0, 81.0, 85.0, 119.0, 78.0, 79.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 90.0, 88.0, 90.0, 87.0, 90.0, 88.0, 90.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 111.0, 95.0, 96.0, 96.0, 97.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 97.2}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 92.0, 92.0, 94.0, 92.0, 96.0, 94.0, 92.0, 106.0], "unit": "score", "name": "imaging-desaturate", "value": 94.2}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 57.0, 59.0, 60.0, 62.0, 58.0, 60.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 70.0, 90.0, 99.0, 99.0, 88.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.8}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 87.0, 94.0, 102.0, 99.0, 86.0, 81.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [117.0, 130.0, 138.0, 114.0, 122.0, 125.0, 131.0, 133.0, 114.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [132.0, 131.0, 171.0, 137.0, 140.0, 172.0, 168.0, 139.0, 133.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 71.0, 69.0, 64.0, 67.0, 64.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1511.4000000000003}]} 16:20:19 INFO - Return code: 0 16:20:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:20:19 ERROR - # TBPL SUCCESS # 16:20:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:20:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:20:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:20:19 INFO - 2016-06-30 16:20:19.872 screenresolution[2196:15296] starting screenresolution argv=screenresolution get 16:20:19 INFO - 2016-06-30 16:20:19.874 screenresolution[2196:15296] Display 0: 1600x1200x32@60 16:20:19 INFO - 2016-06-30 16:20:19.880 screenresolution[2197:15299] starting screenresolution argv=screenresolution list 16:20:19 INFO - Available Modes on Display 0 16:20:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:20:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:20:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:20:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:20:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:20:20 INFO - Intel Iris: 16:20:20 INFO - Chipset Model: Intel Iris 16:20:20 INFO - Type: GPU 16:20:20 INFO - Bus: Built-In 16:20:20 INFO - VRAM (Dynamic, Max): 1536 MB 16:20:20 INFO - Vendor: Intel (0x8086) 16:20:20 INFO - Device ID: 0x0a2e 16:20:20 INFO - Revision ID: 0x0009 16:20:20 INFO - Displays: 16:20:20 INFO - Display: 16:20:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:20:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:20:20 INFO - Display Serial Number: 1600x1200 60 16:20:20 INFO - Main Display: Yes 16:20:20 INFO - Mirror: Off 16:20:20 INFO - Online: Yes 16:20:20 INFO - Rotation: Supported 16:20:20 INFO - Return code: 0 16:20:20 INFO - Running post-action listener: _resource_record_post_action 16:20:20 INFO - Running post-run listener: _resource_record_post_run 16:20:21 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 1105920; Write bytes: 666672128; Read time: 14; Write time: 1906 16:20:21 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 352250368; Write bytes: 352933376; Read time: 28264; Write time: 657 16:20:21 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1105920; Write bytes: 303408640; Read time: 14; Write time: 1215 16:20:21 INFO - Running post-run listener: _upload_blobber_files 16:20:21 INFO - Blob upload gear active. 16:20:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:20:21 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:20:21 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:20:21 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:20:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:22 INFO - (blobuploader) - INFO - Done attempting. 16:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:23 INFO - (blobuploader) - INFO - Done attempting. 16:20:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:23 INFO - Return code: 0 16:20:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:20:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a0243b95c09f9ee16e5120baa6438d4c624dd2027b9e18dd40c561735fc10975e9af9494950eaecad50e9119f225397024906839d028026ff03a224a12ac2ba1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2e6beaee08b156b54bb4dbcc7c15322a62c1075890ad5ed67e07b49be06f51477a82af9caef4e756b5ad7f7ed0e78ef9849642c8215805496c3d33e08d8f1659"} 16:20:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:20:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:20:23 INFO - Contents: 16:20:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a0243b95c09f9ee16e5120baa6438d4c624dd2027b9e18dd40c561735fc10975e9af9494950eaecad50e9119f225397024906839d028026ff03a224a12ac2ba1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2e6beaee08b156b54bb4dbcc7c15322a62c1075890ad5ed67e07b49be06f51477a82af9caef4e756b5ad7f7ed0e78ef9849642c8215805496c3d33e08d8f1659"} 16:20:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:23 INFO - Copying logs to upload dir... 16:20:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:20:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.659736 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-30 16:20:23.244218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:20:23.247499) ========= 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.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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/a0243b95c09f9ee16e5120baa6438d4c624dd2027b9e18dd40c561735fc10975e9af9494950eaecad50e9119f225397024906839d028026ff03a224a12ac2ba1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2e6beaee08b156b54bb4dbcc7c15322a62c1075890ad5ed67e07b49be06f51477a82af9caef4e756b5ad7f7ed0e78ef9849642c8215805496c3d33e08d8f1659"} build_url:https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/GoBkD8TbQlCw3EQLViDA7Q/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/a0243b95c09f9ee16e5120baa6438d4c624dd2027b9e18dd40c561735fc10975e9af9494950eaecad50e9119f225397024906839d028026ff03a224a12ac2ba1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2e6beaee08b156b54bb4dbcc7c15322a62c1075890ad5ed67e07b49be06f51477a82af9caef4e756b5ad7f7ed0e78ef9849642c8215805496c3d33e08d8f1659"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:20:23.382585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:20:23.382915) ========= 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.1qDJob1o5F/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.vhxko9pu0V/Listeners TMPDIR=/var/folders/s6/fh_2vd2n39xc3pp5fgw6gd3h00000w/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.005186 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:20:23.409796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:20:23.410124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:20:23.410477) ========= ========= Total master_lag: 0.40 =========