builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0340 starttime: 1465499293.68 results: success (0) buildid: 20160609095529 builduid: 50260888102748178194f2d93b146567 revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:13.676314) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:13.681671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:13.682003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:13.707684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:13.708243) ========= 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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-09 12:08:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.5M=0s 2016-06-09 12:08:14 (31.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.460264 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:14.198760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:14.199500) ========= 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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.025628 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:14.268175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 12:08:14.268598) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a23a6103b9bef3d80874d74e2278ee47b458ed87 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-09 12:08:14,352 truncating revision to first 12 chars 2016-06-09 12:08:14,352 Setting DEBUG logging. 2016-06-09 12:08:14,352 attempt 1/10 2016-06-09 12:08:14,352 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a23a6103b9be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 12:08:15,863 unpacking tar archive at: mozilla-beta-a23a6103b9be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.788696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 12:08:16.080881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:16.081263) ========= script_repo_revision: a23a6103b9bef3d80874d74e2278ee47b458ed87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:16.081756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:16.082109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:08:16.099828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-06-09 12:08:16.100297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:08:16 INFO - MultiFileLogger online at 20160609 12:08:16 in /builds/slave/test 12:08:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:08:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:16 INFO - {'append_to_log': False, 12:08:16 INFO - 'base_work_dir': '/builds/slave/test', 12:08:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:08:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:16 INFO - 'branch': 'Mozilla-Beta', 12:08:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:16 INFO - 'config_files': ('talos/mac_config.py',), 12:08:16 INFO - 'default_actions': ('clobber', 12:08:16 INFO - 'read-buildbot-config', 12:08:16 INFO - 'download-and-extract', 12:08:16 INFO - 'populate-webroot', 12:08:16 INFO - 'create-virtualenv', 12:08:16 INFO - 'install', 12:08:16 INFO - 'run-tests'), 12:08:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:16 INFO - 'download_minidump_stackwalk': True, 12:08:16 INFO - 'download_symbols': 'ondemand', 12:08:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:16 INFO - 'installer_path': 'installer.exe', 12:08:16 INFO - 'log_level': 'info', 12:08:16 INFO - 'log_name': 'talos', 12:08:16 INFO - 'log_to_console': True, 12:08:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:16 INFO - 'opt_config_files': (), 12:08:16 INFO - 'pip_index': False, 12:08:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:16 INFO - 'cmd': ('bash', 12:08:16 INFO - '-c', 12:08:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:16 INFO - 'enabled': True, 12:08:16 INFO - 'halt_on_failure': False, 12:08:16 INFO - 'name': 'check_screen_resolution'},), 12:08:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:16 INFO - 'cmd': ('bash', 12:08:16 INFO - '-c', 12:08:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:16 INFO - 'enabled': True, 12:08:16 INFO - 'halt_on_failure': False, 12:08:16 INFO - 'name': 'check_screen_resolution'},), 12:08:16 INFO - 'run_cmd_checks_enabled': True, 12:08:16 INFO - 'sps_profile': False, 12:08:16 INFO - 'sps_profile_interval': 0, 12:08:16 INFO - 'suite': 'dromaeojs-e10s', 12:08:16 INFO - 'system_bits': '32', 12:08:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:16 INFO - 'title': 't-yosemite-r7-0340', 12:08:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:16 INFO - 'use_talos_json': True, 12:08:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:16 INFO - 'work_dir': 'build'} 12:08:16 INFO - ##### 12:08:16 INFO - ##### Running clobber step. 12:08:16 INFO - ##### 12:08:16 INFO - Running pre-action listener: _resource_record_pre_action 12:08:16 INFO - Running main action method: clobber 12:08:16 INFO - rmtree: /builds/slave/test/build 12:08:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:18 INFO - Running post-action listener: _resource_record_post_action 12:08:18 INFO - ##### 12:08:18 INFO - ##### Running read-buildbot-config step. 12:08:18 INFO - ##### 12:08:18 INFO - Running pre-action listener: _resource_record_pre_action 12:08:18 INFO - Running main action method: read_buildbot_config 12:08:18 INFO - Using buildbot properties: 12:08:18 INFO - { 12:08:18 INFO - "project": "", 12:08:18 INFO - "product": "firefox", 12:08:18 INFO - "script_repo_revision": "production", 12:08:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:08:18 INFO - "repository": "", 12:08:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:08:18 INFO - "buildid": "20160609095529", 12:08:18 INFO - "pgo_build": "False", 12:08:18 INFO - "basedir": "/builds/slave/test", 12:08:18 INFO - "buildnumber": 34, 12:08:18 INFO - "slavename": "t-yosemite-r7-0340", 12:08:18 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:08:18 INFO - "platform": "yosemite_r7", 12:08:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:08:18 INFO - "branch": "mozilla-beta", 12:08:18 INFO - "repo_path": "releases/mozilla-beta", 12:08:18 INFO - "revision": "a23a6103b9bef3d80874d74e2278ee47b458ed87", 12:08:18 INFO - "stage_platform": "macosx64", 12:08:18 INFO - "builduid": "50260888102748178194f2d93b146567", 12:08:18 INFO - "slavebuilddir": "test" 12:08:18 INFO - } 12:08:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 12:08:18 INFO - Running post-action listener: _resource_record_post_action 12:08:18 INFO - ##### 12:08:18 INFO - ##### Running download-and-extract step. 12:08:18 INFO - ##### 12:08:18 INFO - Running pre-action listener: _resource_record_pre_action 12:08:18 INFO - Running main action method: download_and_extract 12:08:18 INFO - mkdir: /builds/slave/test/build/tests 12:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:18 INFO - https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 12:08:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json: timed out 12:08:48 INFO - retry: attempt #1 caught exception: timed out 12:08:48 INFO - retry: Failed, sleeping 30 seconds before retrying 12:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #2 12:09:21 INFO - Downloaded 1165 bytes. 12:09:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:09:21 INFO - Using the following test package requirements: 12:09:21 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:09:21 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 12:09:21 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 12:09:21 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:09:21 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 12:09:21 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:09:21 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 12:09:21 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 12:09:21 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 12:09:21 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:09:21 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 12:09:21 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 12:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:21 INFO - https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 12:09:23 INFO - Downloaded 18292402 bytes. 12:09:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:09:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:09:26 INFO - Return code: 0 12:09:26 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:26 INFO - https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 12:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 12:09:27 INFO - Downloaded 18292402 bytes. 12:09:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:09:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:09:31 INFO - Return code: 0 12:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:31 INFO - https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 12:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 12:09:32 INFO - Downloaded 10840145 bytes. 12:09:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:09:32 INFO - Return code: 0 12:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:32 INFO - https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 12:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 12:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 12:09:35 INFO - Downloaded 86249130 bytes. 12:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:09:35 INFO - mkdir: /builds/slave/test/properties 12:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:35 INFO - Contents: 12:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:09:36 INFO - Running post-action listener: _resource_record_post_action 12:09:36 INFO - Running post-action listener: set_extra_try_arguments 12:09:36 INFO - ##### 12:09:36 INFO - ##### Running populate-webroot step. 12:09:36 INFO - ##### 12:09:36 INFO - Running pre-action listener: _resource_record_pre_action 12:09:36 INFO - Running main action method: populate_webroot 12:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:09:36 INFO - '--tppagecycles', 12:09:36 INFO - '7'], 12:09:36 INFO - 'tests': ['tsvgm']}}, 12:09:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:09:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:09:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:09:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['damp', 'tps']}, 12:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'tests': ['damp', 'tps']}, 12:09:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['dromaeo_dom']}, 12:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'other-e10s': {'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['a11yr', 12:09:36 INFO - 'ts_paint', 12:09:36 INFO - 'tpaint', 12:09:36 INFO - 'sessionrestore', 12:09:36 INFO - 'sessionrestore_no_auto_restore', 12:09:36 INFO - 'tabpaint']}, 12:09:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['tsvgx', 12:09:36 INFO - 'tsvgr_opacity', 12:09:36 INFO - 'tart', 12:09:36 INFO - 'tscrollx', 12:09:36 INFO - 'cart']}, 12:09:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:09:36 INFO - 'tsvgr_opacity', 12:09:36 INFO - 'tart', 12:09:36 INFO - 'tscrollx', 12:09:36 INFO - 'cart']}, 12:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'talos_options': ['--disable-e10s'], 12:09:36 INFO - 'tests': ['tp5o']}, 12:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'tests': ['tp5o']}, 12:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'talos_options': ['--disable-e10s', 12:09:36 INFO - '--xperf_path', 12:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:36 INFO - 'tests': ['tp5n']}, 12:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:36 INFO - 'talos_options': ['--xperf_path', 12:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:36 INFO - 'tests': ['tp5n']}}, 12:09:36 INFO - 'talos.zip': {'path': '', 12:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:09:36 INFO - Running post-action listener: _resource_record_post_action 12:09:36 INFO - ##### 12:09:36 INFO - ##### Running create-virtualenv step. 12:09:36 INFO - ##### 12:09:36 INFO - Running pre-action listener: _resource_record_pre_action 12:09:36 INFO - Running main action method: create_virtualenv 12:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:36 INFO - Using real prefix '/tools/python27' 12:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:40 INFO - Installing pip.................done. 12:09:40 INFO - Return code: 0 12:09:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:40 INFO - 'HOME': '/Users/cltbld', 12:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:40 INFO - 'LOGNAME': 'cltbld', 12:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:40 INFO - 'MOZ_NO_REMOTE': '1', 12:09:40 INFO - 'NO_EM_RESTART': '1', 12:09:40 INFO - 'PAGER': '/bin/cat', 12:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:40 INFO - 'PWD': '/builds/slave/test', 12:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:40 INFO - 'SHELL': '/bin/bash', 12:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:40 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:40 INFO - 'USER': 'cltbld', 12:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:40 INFO - 'XPC_FLAGS': '0x0', 12:09:40 INFO - 'XPC_SERVICE_NAME': '0', 12:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:09:40 INFO - Cleaning up... 12:09:40 INFO - Return code: 0 12:09:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:40 INFO - 'HOME': '/Users/cltbld', 12:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:40 INFO - 'LOGNAME': 'cltbld', 12:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:40 INFO - 'MOZ_NO_REMOTE': '1', 12:09:40 INFO - 'NO_EM_RESTART': '1', 12:09:40 INFO - 'PAGER': '/bin/cat', 12:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:40 INFO - 'PWD': '/builds/slave/test', 12:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:40 INFO - 'SHELL': '/bin/bash', 12:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:40 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:40 INFO - 'USER': 'cltbld', 12:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:40 INFO - 'XPC_FLAGS': '0x0', 12:09:40 INFO - 'XPC_SERVICE_NAME': '0', 12:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:40 INFO - Downloading/unpacking psutil>=0.7.1 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:43 INFO - Installing collected packages: psutil 12:09:43 INFO - Running setup.py install for psutil 12:09:43 INFO - building 'psutil._psutil_osx' extension 12:09:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:09:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:09:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:09:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:09:44 INFO - building 'psutil._psutil_posix' extension 12:09:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:09:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:09:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:09:44 INFO - ^ 12:09:44 INFO - 1 warning generated. 12:09:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:09:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:45 INFO - Successfully installed psutil 12:09:45 INFO - Cleaning up... 12:09:45 INFO - Return code: 0 12:09:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:45 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:45 INFO - 'HOME': '/Users/cltbld', 12:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:45 INFO - 'LOGNAME': 'cltbld', 12:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:45 INFO - 'MOZ_NO_REMOTE': '1', 12:09:45 INFO - 'NO_EM_RESTART': '1', 12:09:45 INFO - 'PAGER': '/bin/cat', 12:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:45 INFO - 'PWD': '/builds/slave/test', 12:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:45 INFO - 'SHELL': '/bin/bash', 12:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:45 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:45 INFO - 'USER': 'cltbld', 12:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:45 INFO - 'XPC_FLAGS': '0x0', 12:09:45 INFO - 'XPC_SERVICE_NAME': '0', 12:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:09:47 INFO - Installing collected packages: mozsystemmonitor 12:09:47 INFO - Running setup.py install for mozsystemmonitor 12:09:48 INFO - Successfully installed mozsystemmonitor 12:09:48 INFO - Cleaning up... 12:09:48 INFO - Return code: 0 12:09:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:48 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:48 INFO - 'HOME': '/Users/cltbld', 12:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:48 INFO - 'LOGNAME': 'cltbld', 12:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:48 INFO - 'MOZ_NO_REMOTE': '1', 12:09:48 INFO - 'NO_EM_RESTART': '1', 12:09:48 INFO - 'PAGER': '/bin/cat', 12:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:48 INFO - 'PWD': '/builds/slave/test', 12:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:48 INFO - 'SHELL': '/bin/bash', 12:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:48 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:48 INFO - 'USER': 'cltbld', 12:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:48 INFO - 'XPC_FLAGS': '0x0', 12:09:48 INFO - 'XPC_SERVICE_NAME': '0', 12:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09:51 INFO - Downloading docopt-0.6.1.tar.gz 12:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:52 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:52 INFO - Running setup.py install for blobuploader 12:09:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:52 INFO - Running setup.py install for requests 12:09:52 INFO - Running setup.py install for docopt 12:09:52 INFO - Successfully installed blobuploader requests docopt 12:09:52 INFO - Cleaning up... 12:09:52 INFO - Return code: 0 12:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:52 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:52 INFO - 'HOME': '/Users/cltbld', 12:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:52 INFO - 'LOGNAME': 'cltbld', 12:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:52 INFO - 'MOZ_NO_REMOTE': '1', 12:09:52 INFO - 'NO_EM_RESTART': '1', 12:09:52 INFO - 'PAGER': '/bin/cat', 12:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:52 INFO - 'PWD': '/builds/slave/test', 12:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:52 INFO - 'SHELL': '/bin/bash', 12:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:52 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:52 INFO - 'USER': 'cltbld', 12:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:52 INFO - 'XPC_FLAGS': '0x0', 12:09:52 INFO - 'XPC_SERVICE_NAME': '0', 12:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-tZhyB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XNGbew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-RuUanB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-e6T73t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-xjJQGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-RPlHNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-W37_7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:53 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ckv6ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Q8XZBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XnHphB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-E0wy5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-qdkzWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-lMZ_Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-NAcXNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-D29PHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-UlpPDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:54 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-43ZLOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:54 INFO - Running setup.py install for manifestparser 12:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:55 INFO - Running setup.py install for mozcrash 12:09:55 INFO - Running setup.py install for mozdebug 12:09:55 INFO - Running setup.py install for mozdevice 12:09:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:55 INFO - Running setup.py install for mozfile 12:09:55 INFO - Running setup.py install for mozhttpd 12:09:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:55 INFO - Running setup.py install for mozinfo 12:09:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:55 INFO - Running setup.py install for mozInstall 12:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Running setup.py install for mozleak 12:09:56 INFO - Running setup.py install for mozlog 12:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Running setup.py install for moznetwork 12:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Running setup.py install for mozprocess 12:09:56 INFO - Running setup.py install for mozprofile 12:09:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:56 INFO - Running setup.py install for mozrunner 12:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:57 INFO - Running setup.py install for mozscreenshot 12:09:57 INFO - Running setup.py install for moztest 12:09:57 INFO - Running setup.py install for mozversion 12:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:57 INFO - Cleaning up... 12:09:57 INFO - Return code: 0 12:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:57 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:57 INFO - 'HOME': '/Users/cltbld', 12:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:57 INFO - 'LOGNAME': 'cltbld', 12:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:57 INFO - 'MOZ_NO_REMOTE': '1', 12:09:57 INFO - 'NO_EM_RESTART': '1', 12:09:57 INFO - 'PAGER': '/bin/cat', 12:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:57 INFO - 'PWD': '/builds/slave/test', 12:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:57 INFO - 'SHELL': '/bin/bash', 12:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:09:57 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:57 INFO - 'USER': 'cltbld', 12:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:57 INFO - 'XPC_FLAGS': '0x0', 12:09:57 INFO - 'XPC_SERVICE_NAME': '0', 12:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:57 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-dUuULg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:57 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-byGluw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:57 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pznhPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Y0rW7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-dFxWQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XYqaI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-vWutOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Jbl7jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9FLa_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-1ABexX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Qs4X_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:58 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CGliUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:59 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-qruZwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:59 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9qou42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:59 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XnTO4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:59 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-sbngGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:59 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-mC6B13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:02 INFO - Downloading blessings-1.6.tar.gz 12:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:10:02 INFO - Installing collected packages: blessings 12:10:02 INFO - Running setup.py install for blessings 12:10:02 INFO - Successfully installed blessings 12:10:02 INFO - Cleaning up... 12:10:02 INFO - Return code: 0 12:10:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:02 INFO - Reading from file tmpfile_stdout 12:10:02 INFO - Current package versions: 12:10:02 INFO - blessings == 1.6 12:10:02 INFO - blobuploader == 1.2.4 12:10:02 INFO - docopt == 0.6.1 12:10:02 INFO - manifestparser == 1.1 12:10:02 INFO - mozInstall == 1.12 12:10:02 INFO - mozcrash == 0.17 12:10:02 INFO - mozdebug == 0.1 12:10:02 INFO - mozdevice == 0.48 12:10:02 INFO - mozfile == 1.2 12:10:02 INFO - mozhttpd == 0.7 12:10:02 INFO - mozinfo == 0.9 12:10:02 INFO - mozleak == 0.1 12:10:02 INFO - mozlog == 3.1 12:10:02 INFO - moznetwork == 0.27 12:10:02 INFO - mozprocess == 0.22 12:10:02 INFO - mozprofile == 0.28 12:10:02 INFO - mozrunner == 6.11 12:10:02 INFO - mozscreenshot == 0.1 12:10:02 INFO - mozsystemmonitor == 0.0 12:10:02 INFO - moztest == 0.7 12:10:02 INFO - mozversion == 1.4 12:10:02 INFO - psutil == 3.1.1 12:10:02 INFO - requests == 1.2.3 12:10:02 INFO - wsgiref == 0.1.2 12:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:02 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:02 INFO - 'HOME': '/Users/cltbld', 12:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:02 INFO - 'LOGNAME': 'cltbld', 12:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:02 INFO - 'MOZ_NO_REMOTE': '1', 12:10:02 INFO - 'NO_EM_RESTART': '1', 12:10:02 INFO - 'PAGER': '/bin/cat', 12:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:02 INFO - 'PWD': '/builds/slave/test', 12:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:02 INFO - 'SHELL': '/bin/bash', 12:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:10:02 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:02 INFO - 'USER': 'cltbld', 12:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:02 INFO - 'XPC_FLAGS': '0x0', 12:10:02 INFO - 'XPC_SERVICE_NAME': '0', 12:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:10:02 INFO - Cleaning up... 12:10:02 INFO - Return code: 0 12:10:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:02 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:02 INFO - 'HOME': '/Users/cltbld', 12:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:02 INFO - 'LOGNAME': 'cltbld', 12:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:02 INFO - 'MOZ_NO_REMOTE': '1', 12:10:02 INFO - 'NO_EM_RESTART': '1', 12:10:02 INFO - 'PAGER': '/bin/cat', 12:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:02 INFO - 'PWD': '/builds/slave/test', 12:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:02 INFO - 'SHELL': '/bin/bash', 12:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:10:02 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:02 INFO - 'USER': 'cltbld', 12:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:02 INFO - 'XPC_FLAGS': '0x0', 12:10:02 INFO - 'XPC_SERVICE_NAME': '0', 12:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:03 INFO - Downloading/unpacking jsonschema 12:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:10:05 INFO - Downloading/unpacking functools32 (from jsonschema) 12:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 12:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:10:06 INFO - warning: no files found matching '*.txt' 12:10:06 INFO - no previously-included directories found matching 'build' 12:10:06 INFO - no previously-included directories found matching 'dist' 12:10:06 INFO - no previously-included directories found matching '.git*' 12:10:06 INFO - Installing collected packages: jsonschema, functools32 12:10:06 INFO - Running setup.py install for functools32 12:10:06 INFO - warning: no files found matching '*.txt' 12:10:06 INFO - no previously-included directories found matching 'build' 12:10:06 INFO - no previously-included directories found matching 'dist' 12:10:06 INFO - no previously-included directories found matching '.git*' 12:10:06 INFO - Successfully installed jsonschema functools32 12:10:06 INFO - Cleaning up... 12:10:06 INFO - Return code: 0 12:10:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:06 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 0x10bd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5ad999f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, '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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:06 INFO - 'HOME': '/Users/cltbld', 12:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:06 INFO - 'LOGNAME': 'cltbld', 12:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:06 INFO - 'MOZ_NO_REMOTE': '1', 12:10:06 INFO - 'NO_EM_RESTART': '1', 12:10:06 INFO - 'PAGER': '/bin/cat', 12:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:06 INFO - 'PWD': '/builds/slave/test', 12:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:06 INFO - 'SHELL': '/bin/bash', 12:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:10:06 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:06 INFO - 'USER': 'cltbld', 12:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:06 INFO - 'XPC_FLAGS': '0x0', 12:10:06 INFO - 'XPC_SERVICE_NAME': '0', 12:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:06 INFO - Downloading/unpacking flake8 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:10:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:10:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:10:10 INFO - no previously-included directories found matching 'docs/_build' 12:10:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:10:10 INFO - Running setup.py install for pep8 12:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:10:10 INFO - no previously-included directories found matching 'docs/_build' 12:10:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:10:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:10:10 INFO - Cleaning up... 12:10:10 INFO - Return code: 0 12:10:10 INFO - Running post-action listener: _resource_record_post_action 12:10:10 INFO - Running post-action listener: _start_resource_monitoring 12:10:10 INFO - Starting resource monitoring. 12:10:10 INFO - ##### 12:10:10 INFO - ##### Running install step. 12:10:10 INFO - ##### 12:10:10 INFO - Running pre-action listener: _resource_record_pre_action 12:10:10 INFO - Running main action method: install 12:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:10 INFO - Reading from file tmpfile_stdout 12:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:10:11 INFO - Reading from file tmpfile_stdout 12:10:11 INFO - Output received: 12:10:11 INFO - Usage: mozinstall [options] installer 12:10:11 INFO - Options: 12:10:11 INFO - -h, --help show this help message and exit 12:10:11 INFO - -d DEST, --destination=DEST 12:10:11 INFO - Directory to install application into. [default: 12:10:11 INFO - "/builds/slave/test"] 12:10:11 INFO - --app=APP Application being installed. [default: firefox] 12:10:11 INFO - mkdir: /builds/slave/test/build/application 12:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:10:32 INFO - Reading from file tmpfile_stdout 12:10:32 INFO - Output received: 12:10:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:10:32 INFO - Running post-action listener: _resource_record_post_action 12:10:32 INFO - ##### 12:10:32 INFO - ##### Running run-tests step. 12:10:32 INFO - ##### 12:10:32 INFO - Running pre-action listener: _resource_record_pre_action 12:10:32 INFO - Running main action method: run_tests 12:10:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:32 INFO - 2016-06-09 12:10:32.785 screenresolution[1647:9505] starting screenresolution argv=screenresolution get 12:10:32 INFO - 2016-06-09 12:10:32.788 screenresolution[1647:9505] Display 0: 1600x1200x32@60 12:10:32 INFO - 2016-06-09 12:10:32.794 screenresolution[1648:9507] starting screenresolution argv=screenresolution list 12:10:32 INFO - Available Modes on Display 0 12:10:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:33 INFO - Intel Iris: 12:10:33 INFO - Chipset Model: Intel Iris 12:10:33 INFO - Type: GPU 12:10:33 INFO - Bus: Built-In 12:10:33 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:33 INFO - Vendor: Intel (0x8086) 12:10:33 INFO - Device ID: 0x0a2e 12:10:33 INFO - Revision ID: 0x0009 12:10:33 INFO - Displays: 12:10:33 INFO - Display: 12:10:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:33 INFO - Display Serial Number: 1600x1200 60 12:10:33 INFO - Main Display: Yes 12:10:33 INFO - Mirror: Off 12:10:33 INFO - Online: Yes 12:10:33 INFO - Rotation: Supported 12:10:33 INFO - Return code: 0 12:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:10:33 INFO - Python 2.7.3 12:10:33 INFO - Return code: 0 12:10:33 INFO - grabbing minidump binary from tooltool 12:10: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')]} 12:10:33 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 0x10bba8e00>, '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 0x10ba11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:10:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:10:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:10:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:10:33 INFO - Return code: 0 12:10:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:10:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:10:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:10:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:10:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:10:34 INFO - Return code: 0 12:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M3Fh5AWKRS/Render', 12:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:34 INFO - 'HOME': '/Users/cltbld', 12:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:34 INFO - 'LOGNAME': 'cltbld', 12:10:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:34 INFO - 'MOZ_NO_REMOTE': '1', 12:10:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:34 INFO - 'NO_EM_RESTART': '1', 12:10:34 INFO - 'PAGER': '/bin/cat', 12:10:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:34 INFO - 'PWD': '/builds/slave/test', 12:10:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:34 INFO - 'SHELL': '/bin/bash', 12:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W47WzHdBSZ/Listeners', 12:10:34 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 12:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:34 INFO - 'USER': 'cltbld', 12:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:34 INFO - 'XPC_FLAGS': '0x0', 12:10:34 INFO - 'XPC_SERVICE_NAME': '0', 12:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:10:34 INFO - mozversion application_buildid: 20160609095529 12:10:34 INFO - mozversion application_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:10:34 INFO - mozversion application_display_name: Firefox 12:10:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:10:34 INFO - mozversion application_name: Firefox 12:10:34 INFO - mozversion application_remotingname: firefox 12:10:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:10:34 INFO - mozversion application_vendor: Mozilla 12:10:34 INFO - mozversion application_version: 48.0 12:10:34 INFO - mozversion platform_buildid: 20160609095529 12:10:34 INFO - mozversion platform_changeset: a23a6103b9bef3d80874d74e2278ee47b458ed87 12:10:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:10:34 INFO - mozversion platform_version: 48.0 12:10:34 INFO - using testdate: 1465499434 12:10:34 INFO - actual date: 1465499434 12:10:34 INFO - starting webserver on 'localhost:49271' 12:10:34 INFO - SUITE-START | Running 2 tests 12:10:34 INFO - TEST-START | dromaeo_css 12:10:34 INFO - operating with platform_type : mac_ 12:10:34 INFO - Initialising browser for dromaeo_css test... 12:10:34 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpenXyGB/profile http://localhost:49271/getInfo.html) 12:10:37 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 12:10:37 INFO - PROCESS | 1666 | colorDepth:24 12:10:37 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 12:10:37 INFO - PROCESS | 1666 | __metrics 12:10:37 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 12:10:37 INFO - TEST-INFO | 1666: exit 0 12:10:37 INFO - Browser initialized. 12:10:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:10:37 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpenXyGB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:49 INFO - PROCESS | 1671 | RSS: Main: 170987520 12:10:49 INFO - PROCESS | 1671 | 12:11:39 INFO - PROCESS | 1671 | 1465499499428 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:13:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 12:13:50 INFO - PROCESS | 1671 | RSS: Main: 181862400 12:13:50 INFO - PROCESS | 1671 | 12:16:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 12:16:53 INFO - PROCESS | 1671 | RSS: Main: 192897024 12:16:53 INFO - PROCESS | 1671 | 12:19:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:19:55 INFO - PROCESS | 1671 | RSS: Main: 195059712 12:19:55 INFO - PROCESS | 1671 | 12:22:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:22:58 INFO - PROCESS | 1671 | RSS: Main: 198877184 12:22:58 INFO - PROCESS | 1671 | 12:26:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:26:01 INFO - PROCESS | 1671 | RSS: Main: 198025216 12:26:01 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:29:03 INFO - PROCESS | 1671 | RSS: Main: 202948608 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | __start_tp_report 12:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 12:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 12:29:03 INFO - PROCESS | 1671 | |i|pagename|runs| 12:29:03 INFO - PROCESS | 1671 | |0;dojo.html;3553.022918697358;3682.9631703682953;3700.5189325387696;3736.4208547675103;3748;6011.819645410634;6019.067044608082;6022.367651396595;6034.396560343964;6058.909116363253;6012.75948962041;6047.969760151204;6056.969715151429;6077.483413909812;6094.207752992105;5372;5374.596905232103;5422.566194704415;5441.156620723794;5513.669179849222;5324.494173053554;5419.132938729804;5433.782648694068;5435.673859568438;5462.7268636568215;5436.73216525028;5448.645838020536;5461.453854614527;5488.780448782044;5543.334799824027;4825.30033145192;5163;5387.973060134694;5498.395176530578;5527.861803454925;5323.467653234684;5376.247325374451;5420.07858664028;5427;5480.342358916916;5634.859128521779;5782.681952492611;5950.315713692938;5961.374055724174;5996.4603185713495;6329.905051424233;6346.2067241594805;6349.555531112824;6369.299377068519;6375.649339286338;6309.179806625155;6394.584352017104;6442.806715798533;6453.225612926479;6495.4803615710625;6014.218151640346;6014.3985601439945;6091.604045737013;6142.508599312045;6153.876922461525;6520.217573891164;6587.901181482282;6608.900866487006;6609.173853268341;6622.470202383798;6256.186695729617;6273.498120150377;6276.058591211264;6279.995200767947;6285.685715714196;6221.346758590283;6358.1734374531015;6430.903536446957;6469.838254043687;6473.385028422293;6269.937300627026;6278.748850045947;6298.559100862987;6311.463525600284;6324.936750632527;6194.225721784777;6309.589876658002;6322.399372059647;6330.272018717815;6339.873202535923;4961.8511444656715;5100.77581380466;5109.591232701449;5121.897562048738;5167.844964651066;4550.88622784433;4597.747123908151;4601.171789077931;4603.861884143481;4610.792514336863;6010.939890601126;6062.787802426982;6087.056506241451;6104.755809767559;6132.908006379907;6269.623822570569;6349.555531112777;6404.263509696351;6474.838129046811;6501;6028.156058151862;6057.727402266909;6080.48315893154;6083.057126145454;6093.055576385667;5510.8071217507195;5521.47545983139;5529.447055294519;5555;5567.192757050205;6640.335966403321;6665.100211471389;6668.966655166693;6681.365270299314;6712.798616041527;6432.807015789534;6489.415952564292;6490.772822951174;6512.05575191604;6512.837179070561;6460.903086453613;6569.178852643419;6660.300668429745;6679.332066793282;6706.597604143767;6346.397092276226;6376.553641245068;6382.393672601095;6389.456896163692;6395.808125756234;5783.219265399117;6428.935710642833;6475.838104047437;6489.610623362613;6508.967455162694;6045.727942242697;6112.047575716935;6213.689315534296;6244.843878903063;6247.468965138014;6263.530235232284;6266.717997690023;6268.968655156695;6272.2159730033745;6290.339514350927;6054.182685337423;6129.478994285536;6159.568830182024;6163.876722465615;6172.4136207060255;6121.117656725397;6144.955357589131;6209.844753881189;6234.563580549318;6275.843103922439;6086.087086936995;6108.602940809011;6185.505159587312;6194.442500175006;6203.31763506023 12:29:03 INFO - PROCESS | 1671 | |1;ext.html;522.4331600213768;541.8753686652069;541.9430959749229;552.7540244591156;570.1362435909596;33119.33761324775;40746.185076298454;40808.79595602018;40874.79562602186;40961.59038409615;41897.58102418975;42507;42555.93610159748;42581.36127958076;42585.57414425855;9679.177269932065;9851.753706157331;9855.704328870146;9874.901250987507;9920;9656.662016829378;9935.701928942144;9939.20486361093;9943;10054.296199266055;9903.900960990406;9975.251856110785;9979.900200998007;10017.39895606266;10056.19550435967;9892.851607225897;9931.957144499831;9952.353097048668;9973.50132493376;9990.500474976223;9794.9510252449;9880.90119098807;9954.800903981879;9956.352837065568;10064.496775161213;37350.43974340387;37389.06527336811;37422;37475;37566.62433375686;3427.605825330094;3539.1859872229275;3549.3256281306467;3578.6063533011347;3592.317459682652;27402.862985685144;28664.283392915135;28806.855965720246;29205.41589168226;29206.70793292061;2716.443129158518;2761.765249953756;2784.4570308789794;2802.831830090201;2838.8296702197936;444979;446755;449967;450087.74956125335;451042;37790.244195116495;38577.03557411087;66813;67713.66143169253;67732.32267677359;37081.443778343346;37095.88712338634;37111.81444092762;37266.44100338497;37322.813385932895;16169.757453638205;16241.675166496603;16664.75002874958;16787.328506859834;16816.663666726596;14065.226412547203;14255.857441425453;14479.638009049859;14504.274786260645;14647.340869660891;8183.918160818434;8334.708285209988;8462.830743385099;8537.402381833212;8561.828763424697;3588.8743893964106;3597.8201089945396;3620.31214069326;3641.32635462435;3647.708183345379;993.5826952679892;1009.2027298434155;1055.904968552834;1135.2620796482188;1223.2660403757675;31493.425328733472;31535.684643153276;31756.682433175836;31765.68234317627;31992.200194995312;1124.7469319403233;1150.0856818829052;1170.087331881134;1224.877512248768;1240.1752834365045;16038.75941860873;16174.838251617333;16270.918645406697;16298.755518667229;16495.04989782358;631481.37037259;632300;637727;641676;641749.7912510408;51954;63371.04943425852;63473.68263158655;64336;64340.67829660822;1343.1001229176475;1539.3765524962407;1563.6403627165816;1577.0458872382274;1588.547264029746;30702.539461908535;30742.692573074877;30918.06752083831;31277.530837037917;31635.36729265356;55822.44177558173;56433.43566564282;56616.43383566112;57555;58906;560423;563160;566348;566829;567083;28728.856355718086;43727.34408983804;44366.556334436245;46371.30443043425;46371.76814116043;46861;47601.28598071101;48267.5173248263;48916.75541622269;49487;38314;38413;39373.60626393814;39500.80249598734;39518.40722389109;33547;38014.61985380111;38658.6134138655;38749;39581;33495.665043349254;37341.43987840239;38457.4231386535;38474.42288365621;39581.812545623674;33207;34256.314873701886;34442.13894652654;34655;34689.479657805656;26026.34934126662;26055;26064.609030864933;26152.215433537025;26504 12:29:03 INFO - PROCESS | 1671 | |2;jquery.html;412.43496409918407;415.62386040633237;419.10521037584755;419.68942982193147;428.7299001628973;20994.685079723797;21277.936103194817;21774.673379899315;22608;22931.54136917265;21807.345779626598;22048.779512204874;22062.88968555159;22113.336599901988;22188;5982.940170598293;6187.164732761064;6191.690415479231;6247.375262473739;6253.093301471284;4580.839670611529;6130.938690613081;6198.659073750942;6663.600183988976;7007.614581198032;6817.352351526597;6930.930690693104;6944.4444444444325;6945.722171113174;6965.024896514492;6605.240397354318;6762.087118239024;6768.898466522957;6832.043513908032;6838.974153876933;5886.440788125121;5895.587308888379;5898.085796701475;6016.308124565688;6026.156338112668;21500.354989350344;26583.73416265851;26938.32654183661;27142.5928611071;27552.897884084614;2405.9759402405925;2532.569463191262;2736.904208352718;2912.4175164966878;3108.300632357724;15166;15643.608909777347;15903.52289431319;15912.602184945354;16704.83295167045;1615.87696550896;1759.463363674079;1812.5287425269394;1843.3548258109688;1910.9808901910942;116685.41657291744;119184;120937;121841.39079304636;122917.38541307325;11883.287002779862;11910.94044529789;12024.639260822189;12042.759144817055;12051.819222711667;15284.923575382052;15588.06471611707;15656.765148522782;15675.372985080698;15691.1369874658;8915.910840891638;9295.628174872929;9325.393849399767;9358.4384936904;9443.244540436886;9415.62337506492;9476.715698529055;9477.383970041925;9478.383905046288;9496.667616633385;4769.236922092448;4812.1578723723205;4841.709497430165;4847.903041939141;4858.05267972749;1925.838752144267;2038.9082491287927;2052.3124753207844;2119.385378240324;2142.539354038889;943.9716808495756;947.4694171264114;1031.515187861719;1049.7060822969581;1093.6554985179644;18850.478510614015;20951.476213094793;21197.834119123596;21357.572848542943;21362.78637213608;1014.2747935226348;1058.7564860082225;1060.1042119409087;1069.978600427987;1096.5504143301368;10965.945170274257;11332.660020199408;11423.314601123959;11471;11508.827367589492;588460;591433;601346;606581;641204;108985;138283;138751;139250;143511.56488435192;1050.2858056521638;1070.4861666400327;1084.6908631040274;1087.1683162380784;1103.4151899493281;18232;18751;18815.965121918427;18859.717104243722;19124.61750764949;52444;53124.73437632787;53702;53773.92452151013;54092.91814163773;55897;74338;78586.6070669643;79881.2011879897;82381.17618823735;8312;8482.279006284534;8548.960551314149;8599;8695.217430431292;12035.458404371999;12921.612351629467;13087.345632718136;13268.46926122983;13531.323433828466;11181.888181118085;11298.0396666281;11338.546458141582;11416.657500275005;11475.942620286845;11103.666889993314;11105.888941110485;11312.264702794291;11367.772644546898;11601.361925094201;10397.792044159225;10776.784464310827;11432.714182145513;11454.484548195185;11795.646130616095;7935.246151615587;7961.522308661499;8272.420930535045;8276.379271554779;8385.496870187808;8230.300424463749;11052.502637381176;11127.499262533367;11137.164712646421;11232.269902456314 12:29:03 INFO - PROCESS | 1671 | |3;mootools.html;1626.9105199214043;1639.2623319506222;1857.3870622694512;1956.3544030469936;2014.879107253564;8418.158184181579;9071;9235.584398702058;9409.294302927283;9431.57557909894;7667.118281397641;9041.186293233608;9087.454752714842;9178.21985131263;9222.953885230581;2538.378097366148;2555.4889022195634;2568.4863027394504;2571.1643715792347;2579.290695058855;2194.615942210107;2482.640017197514;2546.923592292225;2554.9361265968314;2556.003158768082;2236.7651396603287;2529.0895277700015;2538.8730563471845;2540.530001949636;2568.858712770797;2502.4869901670204;2512.8869200886006;2521.571332873416;2525.4191535946743;2534.7085085215253;2559.5520783862935;2576.5362234797917;2585.418280886804;2588.896444142232;2600.115960573395;9217.631294748202;9347.719568412958;9352;9396.201322887562;9418.246540276761;5782.681952492611;5820.505257053155;5837.941620583825;5889.352171261158;6011.0382338825575;3698.5746639136573;3762.059485128718;3817.61823817616;3825.617438256152;3842.4044273137706;1053.5627714498473;1063.0751246415591;1077.493578018338;1079.87581428136;1083.712816103733;12384.380780961006;12431.875681243162;12542.937285313606;12546.560870369492;12557.121001529897;4453.799579018952;4963.70217786934;5096.490350964948;5118.948810511922;5248.239005344204;10527.157827373792;10551.630692925712;10586.470676466146;10647.89352106469;10693.251472396858;5681.744321505542;5688.516476099578;5820.156077368758;5940.257467816523;5941.613795103304;4758.738269395148;5104.183330667075;5209.348831396075;5231.816886409034;5267.288915996368;4259.595338442843;4266.722663026893;4287.7641729705165;4328.285832837547;4340.587644173798;1393.08056682589;1407.366684991758;1409.718056388706;1424.287856071964;1427.7215942891244;860.4192170285032;869.7303835810792;931.2829121576349;963.6145541783343;972.1590823937244;6120.265568131764;6145.661988590581;6172.043333283348;6190.3190649028575;6260.217472815898;481.1507688929043;484.9670202468719;486.2099088980407;490.4776413120016;493.23302264978304;3927.19492504036;3975.6421922027157;4076.7146299758733;4088.836446542105;4113.526944401372;11132.443377831076;11509.079273658088;11517;11592.420378981018;11600.477978490988;9223.861642075375;11000.944995274973;11009.339439633648;11014.559417623366;11337.093032557375;8604.397692161489;8683.609237584324;8758.956205219061;8775.122487751174;8847.911520884838;5825.883482330414;6086.60437071589;6099.207103076749;6119.418655227746;6232.940400131898;9872.950635247065;9892.752681183028;9908;9920.305578609428;10110.848337275094;10084.949575252076;10253.58985640566;10313.968603139627;10428.374297542172;10548.683539493828;7204.639768011683;7501;7673.232676732282;7947.284744373034;8077.071136819106;7583.317501424898;8516.977962644522;8545.82908341842;8598.61306241233;8629.834972278662;7596.126445458843;7775.650095745592;7780;7822.335101516207;7849.293563579306;7508.511946723445;7588.696452142073;7593.506422082547;7720.189380115007;7722.227777222458;7177.318154775288;7210.96394518024;7230.6384680764695;7278.09023872016;7302.2697730226555;4129.236091323115;5027.7737501813235;5079.746012699424;5225.503577160163;5254.868628284324;5129.358830146231;5132.2814805926455;5138.3577052868395;5214.97392513035;5352.812651557177 12:29:03 INFO - PROCESS | 1671 | |4;prototype.html;238.8292370954767;325.13027651033497;344.2632765881014;347.10793261318406;349.3397478765133;6852.451803855692;6927.203371612266;6974.860502789941;7050.3302186292285;7057.047298614685;7010.4041156501635;7055.470839687018;7060.858782824341;7093.609851458168;7115.822104447391;5113.565346945514;5123.487651234866;5165.560927321182;5177.792888284464;5185.481451854803;5170.069387510247;5178.119719647669;5182.093133701606;5198.246254293125;5217.2695822584865;5125.948740512585;5132.230165475171;5137.820176293831;5151.613628977823;5163.915577728662;3983.521977362706;4829.7343646099625;5013.072581572421;5131.948680513203;5144.768485418165;4242.4757269424645;4245.448091748053;4261.978690106561;4264.104538047014;4280.785960701984;6637.369449902251;6647.202335719745;6655.667216639149;6683.064370988066;6693.966530167367;5918.171455996164;5951.553633477506;5960.761569537213;5967.522598192178;5974.611650242764;5946.286445626509;7440.888386674204;7447.329740323343;7483.663235154431;7497.250274972514;4534.251848445003;4712.458067322267;4729.858104256843;4732.976335118303;4768.380110585636;7711.383089352838;7748.2251774822635;7773.251018520844;7816.374690024784;7834.4124190685925;4786.928196077061;4798.448178459522;4799.400074990626;4804.591609713144;4810.158222311082;4877.487863774323;4884.633652476078;4893.584045356113;4899.191633380524;4911.7298548580175;5879.52963762898;5887.4406931341455;5911.379305172981;5913.793017244376;5930.52555795544;7209.2069872314005;7414.592197429085;7440.995465612182;7452.888206676904;7466.887996680054;1682.2682133272067;1690.5604542818955;1706.2918888661316;1711.0076155829588;1711.6833385823663;863.7322430046705;998.8064263205545;1057.8994995475418;1060.6340812419703;1079.2337440417234;6912.792616221522;6929.688164032631;6951.756688515878;7022.648867556704;7029.29707029293;7717.2668596483245;7783.871338655863;7793.883091753628;7813.335866451302;7832.295093441618;6884.65576721162;6959.304069593101;6962.965185174042;6980.685869135901;7010.579365238102;3974.5627980922077;4072.3280658690983;4109.178164367138;4134.1731653669385;4137.958620413818;7550.433717471102;7936.007999000125;8063.758087257392;8089.47418417801;8127.59362031896;7905.407094467938;7929.444938854225;7949.085855126619;7985.920140798517;7997.960010199912;6413.935860641427;8029.197080291924;8055.315298199602;8071.677132914618;8076.394270429624;6159.907601385893;6256.374362563707;7612.8477430452185;7804.102528209101;7978.401619878417;6190.442860142609;7765.7670269892;7778.572178530235;7782.143964164051;7812.296893279405;6560.901586476111;8184.099749027721;8203.015638123463;8226.177382261965;8257.256846883809;4791.401074865642;4858.368412106403;4872.098661747588;4873.975630121827;4876.829310974099;7636.653979730397;7753.302202801775;7846.333061689592;7905.56519391439;7961.323287520626;6007.699615019319;7478.140013898471;7478.1774004858335;7523.699052037857;7557.168711441627;7429.517081389692;7481.812954676177;7516.849663006818;7537.962310188634;7545.547267163988;7106.431485481253;7336.449766267445;7343.3390994810725;7349.684849272462;7352.669129889275;6009.90985135232;7497.137829149499;7525.247475252431;7539.698412063456;7574.204708505527;6969.815131427568;7167.892481612885;7284.453665974967;7286.744963926237;7346.33882950537 12:29:03 INFO - PROCESS | 1671 | |5;yui.html;677.7766132131503;722.2308241722565;751.7782254235;772.4438404348867;792.9008873890765;15270.389184432637;15482.535523934272;15759.921200393996;15775.921120394396;15790.4473343433;11780.46987885545;12483.68790780231;14397.280135993211;14568.053076550043;14579.489717859877;769.6805825582377;941.8775559177315;946.507815935713;966.7051549277468;969.2149359019181;929.2240978782725;931.6552875436064;939.3800091939321;947.2469386837481;956.3114557518576;977.2963466304285;1010.7978404319166;1012.1093437774748;1012.696191142658;1016.4917541229386;978.4618459847092;986.1814693804162;989.2432289298692;1015.0914931136665;1015.7257540464108;741.499487845702;742.0687037767567;760.8972788673514;764.9120351159632;768.4620765464198;15101.093934363864;15122.168280744554;15336.15651139187;15416.845831541654;15475.303611337516;12639.684007899876;13424.731505369838;13444.596662100153;13462.259575723332;13579.388927498287;8464.703735369232;9317.72046838596;10281.177505799518;10403.895961040369;10445.007724266183;3580.337637537064;3595.7842529448317;3610.711143108545;3629.0745859805843;3856.9614303856883;86626;87377.25245495119;89648;90066;91528.627070594;9876.851847222297;9901.257405694601;9947.80104397908;10143.64497242593;10168.33905796121;18967.90516047411;22727.772722272897;23436.531269374518;23475.178368757013;23676.408089797893;7668.1181664109345;7757.9224207758325;7851.254130857559;7853.253940875607;7886.014248218973;4135.276326642826;4213.220554197422;4258.53156152823;4259.97760537475;4267.253230684618;3141;3650.7040000799334;3751;3797.6582107609897;3802.980985095057;648.6367634124905;658.0326919428433;659.9967000164968;668.8528523724773;688.3907741648677;562.5808772464541;596.2368168744015;602.1780269931512;620.6059152438235;624.3039011502233;8412.200840920103;8456.704015359555;8467.407281490237;8511.57442127891;8622.827543449095;561.2283110722756;600.495583709686;624.3662682377391;628.3496581038603;632.9746810127635;3872.8644497442456;3985.940210896839;4029.2143032108456;4040.7575545467366;4214.599613036757;84088.73866892002;86522.13477865141;88313;95598;96375.51812240893;79611.20388796154;79955;80210;80305;84181.57909210537;72977;73667.26332736605;73679.89480157802;74226.6288668564;74295;8703.91296087031;8815.691450799191;8875.201231889161;8893.866592001255;8998.415103018282;50951.74524127356;51592;51609;52098;53231.73384133055;56039.439605605054;66735.66632166808;70225;72227.63886180746;75396;10859.674209773719;11266.66200014001;11426.714332141762;11490.425478726198;11539.134564907497;12072.45673944657;12127.090468214743;12283.140180187302;12318.815217771562;12858.807117893426;11623.302601843916;11645.534178632759;11675.35785531804;11781;12260.448279827608;11478.540858365906;11616.535338586362;11645.534178632759;11794;12245.938770306091;11383.487743051417;11403.885961140615;11573.942130289295;11597.478113485082;12162.756744864877;9898.703038908845;9923.702288931056;10031.899681003388;10189.74525636865;10230.846537301797;7788.221177882167;9705.320627556004;9912.553935073083;9952.203823693942;10023.148032417326 12:29:03 INFO - PROCESS | 1671 | __end_tp_report 12:29:03 INFO - PROCESS | 1671 | __start_cc_report 12:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,395 12:29:03 INFO - PROCESS | 1671 | __end_cc_report 12:29:03 INFO - PROCESS | 1671 | __startTimestamp1465500543560__endTimestamp 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | ------- Summary: start ------- 12:29:03 INFO - PROCESS | 1671 | Number of tests: 6 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5955.80 Median:6144.96 stddev:633.00 (10.3%) stddev-sans-first:606.23 12:29:03 INFO - PROCESS | 1671 | Values: 3553.0 3683.0 3700.5 3736.4 3748.0 6011.8 6019.1 6022.4 6034.4 6058.9 6012.8 6048.0 6057.0 6077.5 6094.2 5372.0 5374.6 5422.6 5441.2 5513.7 5324.5 5419.1 5433.8 5435.7 5462.7 5436.7 5448.6 5461.5 5488.8 5543.3 4825.3 5163.0 5388.0 5498.4 5527.9 5323.5 5376.2 5420.1 5427.0 5480.3 5634.9 5782.7 5950.3 5961.4 5996.5 6329.9 6346.2 6349.6 6369.3 6375.6 6309.2 6394.6 6442.8 6453.2 6495.5 6014.2 6014.4 6091.6 6142.5 6153.9 6520.2 6587.9 6608.9 6609.2 6622.5 6256.2 6273.5 6276.1 6280.0 6285.7 6221.3 6358.2 6430.9 6469.8 6473.4 6269.9 6278.7 6298.6 6311.5 6324.9 6194.2 6309.6 6322.4 6330.3 6339.9 4961.9 5100.8 5109.6 5121.9 5167.8 4550.9 4597.7 4601.2 4603.9 4610.8 6010.9 6062.8 6087.1 6104.8 6132.9 6269.6 6349.6 6404.3 6474.8 6501.0 6028.2 6057.7 6080.5 6083.1 6093.1 5510.8 5521.5 5529.4 5555.0 5567.2 6640.3 6665.1 6669.0 6681.4 6712.8 6432.8 6489.4 6490.8 6512.1 6512.8 6460.9 6569.2 6660.3 6679.3 6706.6 6346.4 6376.6 6382.4 6389.5 6395.8 5783.2 6428.9 6475.8 6489.6 6509.0 6045.7 6112.0 6213.7 6244.8 6247.5 6263.5 6266.7 6269.0 6272.2 6290.3 6054.2 6129.5 6159.6 6163.9 6172.4 6121.1 6145.0 6209.8 6234.6 6275.8 6086.1 6108.6 6185.5 6194.4 6203.3 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:68239.02 Median:38363.50 stddev:148485.45 (387.0%) stddev-sans-first:148814.95 12:29:03 INFO - PROCESS | 1671 | Values: 522.4 541.9 541.9 552.8 570.1 33119.3 40746.2 40808.8 40874.8 40961.6 41897.6 42507.0 42555.9 42581.4 42585.6 9679.2 9851.8 9855.7 9874.9 9920.0 9656.7 9935.7 9939.2 9943.0 10054.3 9903.9 9975.3 9979.9 10017.4 10056.2 9892.9 9932.0 9952.4 9973.5 9990.5 9795.0 9880.9 9954.8 9956.4 10064.5 37350.4 37389.1 37422.0 37475.0 37566.6 3427.6 3539.2 3549.3 3578.6 3592.3 27402.9 28664.3 28806.9 29205.4 29206.7 2716.4 2761.8 2784.5 2802.8 2838.8 444979.0 446755.0 449967.0 450087.7 451042.0 37790.2 38577.0 66813.0 67713.7 67732.3 37081.4 37095.9 37111.8 37266.4 37322.8 16169.8 16241.7 16664.8 16787.3 16816.7 14065.2 14255.9 14479.6 14504.3 14647.3 8183.9 8334.7 8462.8 8537.4 8561.8 3588.9 3597.8 3620.3 3641.3 3647.7 993.6 1009.2 1055.9 1135.3 1223.3 31493.4 31535.7 31756.7 31765.7 31992.2 1124.7 1150.1 1170.1 1224.9 1240.2 16038.8 16174.8 16270.9 16298.8 16495.0 631481.4 632300.0 637727.0 641676.0 641749.8 51954.0 63371.0 63473.7 64336.0 64340.7 1343.1 1539.4 1563.6 1577.0 1588.5 30702.5 30742.7 30918.1 31277.5 31635.4 55822.4 56433.4 56616.4 57555.0 58906.0 560423.0 563160.0 566348.0 566829.0 567083.0 28728.9 43727.3 44366.6 46371.3 46371.8 46861.0 47601.3 48267.5 48916.8 49487.0 38314.0 38413.0 39373.6 39500.8 39518.4 33547.0 38014.6 38658.6 38749.0 39581.0 33495.7 37341.4 38457.4 38474.4 39581.8 33207.0 34256.3 34442.1 34655.0 34689.5 26026.3 26055.0 26064.6 26152.2 26504.0 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35870.99 Median:21791.01 stddev:101171.13 (464.3%) stddev-sans-first:101419.91 12:29:03 INFO - PROCESS | 1671 | Values: 412.4 415.6 419.1 419.7 428.7 20994.7 21277.9 21774.7 22608.0 22931.5 21807.3 22048.8 22062.9 22113.3 22188.0 5982.9 6187.2 6191.7 6247.4 6253.1 4580.8 6130.9 6198.7 6663.6 7007.6 6817.4 6930.9 6944.4 6945.7 6965.0 6605.2 6762.1 6768.9 6832.0 6839.0 5886.4 5895.6 5898.1 6016.3 6026.2 21500.4 26583.7 26938.3 27142.6 27552.9 2406.0 2532.6 2736.9 2912.4 3108.3 15166.0 15643.6 15903.5 15912.6 16704.8 1615.9 1759.5 1812.5 1843.4 1911.0 116685.4 119184.0 120937.0 121841.4 122917.4 11883.3 11910.9 12024.6 12042.8 12051.8 15284.9 15588.1 15656.8 15675.4 15691.1 8915.9 9295.6 9325.4 9358.4 9443.2 9415.6 9476.7 9477.4 9478.4 9496.7 4769.2 4812.2 4841.7 4847.9 4858.1 1925.8 2038.9 2052.3 2119.4 2142.5 944.0 947.5 1031.5 1049.7 1093.7 18850.5 20951.5 21197.8 21357.6 21362.8 1014.3 1058.8 1060.1 1070.0 1096.6 10965.9 11332.7 11423.3 11471.0 11508.8 588460.0 591433.0 601346.0 606581.0 641204.0 108985.0 138283.0 138751.0 139250.0 143511.6 1050.3 1070.5 1084.7 1087.2 1103.4 18232.0 18751.0 18816.0 18859.7 19124.6 52444.0 53124.7 53702.0 53773.9 54092.9 55897.0 74338.0 78586.6 79881.2 82381.2 8312.0 8482.3 8549.0 8599.0 8695.2 12035.5 12921.6 13087.3 13268.5 13531.3 11181.9 11298.0 11338.5 11416.7 11475.9 11103.7 11105.9 11312.3 11367.8 11601.4 10397.8 10776.8 11432.7 11454.5 11795.6 7935.2 7961.5 8272.4 8276.4 8385.5 8230.3 11052.5 11127.5 11137.2 11232.3 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5968.73 Median:5088.12 stddev:3336.50 (65.6%) stddev-sans-first:3329.90 12:29:03 INFO - PROCESS | 1671 | Values: 1626.9 1639.3 1857.4 1956.4 2014.9 8418.2 9071.0 9235.6 9409.3 9431.6 7667.1 9041.2 9087.5 9178.2 9223.0 2538.4 2555.5 2568.5 2571.2 2579.3 2194.6 2482.6 2546.9 2554.9 2556.0 2236.8 2529.1 2538.9 2540.5 2568.9 2502.5 2512.9 2521.6 2525.4 2534.7 2559.6 2576.5 2585.4 2588.9 2600.1 9217.6 9347.7 9352.0 9396.2 9418.2 5782.7 5820.5 5837.9 5889.4 6011.0 3698.6 3762.1 3817.6 3825.6 3842.4 1053.6 1063.1 1077.5 1079.9 1083.7 12384.4 12431.9 12542.9 12546.6 12557.1 4453.8 4963.7 5096.5 5118.9 5248.2 10527.2 10551.6 10586.5 10647.9 10693.3 5681.7 5688.5 5820.2 5940.3 5941.6 4758.7 5104.2 5209.3 5231.8 5267.3 4259.6 4266.7 4287.8 4328.3 4340.6 1393.1 1407.4 1409.7 1424.3 1427.7 860.4 869.7 931.3 963.6 972.2 6120.3 6145.7 6172.0 6190.3 6260.2 481.2 485.0 486.2 490.5 493.2 3927.2 3975.6 4076.7 4088.8 4113.5 11132.4 11509.1 11517.0 11592.4 11600.5 9223.9 11000.9 11009.3 11014.6 11337.1 8604.4 8683.6 8759.0 8775.1 8847.9 5825.9 6086.6 6099.2 6119.4 6232.9 9873.0 9892.8 9908.0 9920.3 10110.8 10084.9 10253.6 10314.0 10428.4 10548.7 7204.6 7501.0 7673.2 7947.3 8077.1 7583.3 8517.0 8545.8 8598.6 8629.8 7596.1 7775.7 7780.0 7822.3 7849.3 7508.5 7588.7 7593.5 7720.2 7722.2 7177.3 7211.0 7230.6 7278.1 7302.3 4129.2 5027.8 5079.7 5225.5 5254.9 5129.4 5132.3 5138.4 5215.0 5352.8 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6054.53 Median:6940.72 stddev:1964.38 (28.3%) stddev-sans-first:1920.78 12:29:03 INFO - PROCESS | 1671 | Values: 238.8 325.1 344.3 347.1 349.3 6852.5 6927.2 6974.9 7050.3 7057.0 7010.4 7055.5 7060.9 7093.6 7115.8 5113.6 5123.5 5165.6 5177.8 5185.5 5170.1 5178.1 5182.1 5198.2 5217.3 5125.9 5132.2 5137.8 5151.6 5163.9 3983.5 4829.7 5013.1 5131.9 5144.8 4242.5 4245.4 4262.0 4264.1 4280.8 6637.4 6647.2 6655.7 6683.1 6694.0 5918.2 5951.6 5960.8 5967.5 5974.6 5946.3 7440.9 7447.3 7483.7 7497.3 4534.3 4712.5 4729.9 4733.0 4768.4 7711.4 7748.2 7773.3 7816.4 7834.4 4786.9 4798.4 4799.4 4804.6 4810.2 4877.5 4884.6 4893.6 4899.2 4911.7 5879.5 5887.4 5911.4 5913.8 5930.5 7209.2 7414.6 7441.0 7452.9 7466.9 1682.3 1690.6 1706.3 1711.0 1711.7 863.7 998.8 1057.9 1060.6 1079.2 6912.8 6929.7 6951.8 7022.6 7029.3 7717.3 7783.9 7793.9 7813.3 7832.3 6884.7 6959.3 6963.0 6980.7 7010.6 3974.6 4072.3 4109.2 4134.2 4138.0 7550.4 7936.0 8063.8 8089.5 8127.6 7905.4 7929.4 7949.1 7985.9 7998.0 6413.9 8029.2 8055.3 8071.7 8076.4 6159.9 6256.4 7612.8 7804.1 7978.4 6190.4 7765.8 7778.6 7782.1 7812.3 6560.9 8184.1 8203.0 8226.2 8257.3 4791.4 4858.4 4872.1 4874.0 4876.8 7636.7 7753.3 7846.3 7905.6 7961.3 6007.7 7478.1 7478.2 7523.7 7557.2 7429.5 7481.8 7516.8 7538.0 7545.5 7106.4 7336.4 7343.3 7349.7 7352.7 6009.9 7497.1 7525.2 7539.7 7574.2 6969.8 7167.9 7284.5 7286.7 7346.3 12:29:03 INFO - PROCESS | 1671 | 12:29:03 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18894.01 Median:28300.33 stddev:26587.43 (93.9%) stddev-sans-first:26626.84 12:29:03 INFO - PROCESS | 1671 | Values: 677.8 722.2 751.8 772.4 792.9 15270.4 15482.5 15759.9 15775.9 15790.4 11780.5 12483.7 14397.3 14568.1 14579.5 769.7 941.9 946.5 966.7 969.2 929.2 931.7 939.4 947.2 956.3 977.3 1010.8 1012.1 1012.7 1016.5 978.5 986.2 989.2 1015.1 1015.7 741.5 742.1 760.9 764.9 768.5 15101.1 15122.2 15336.2 15416.8 15475.3 12639.7 13424.7 13444.6 13462.3 13579.4 8464.7 9317.7 10281.2 10403.9 10445.0 3580.3 3595.8 3610.7 3629.1 3857.0 86626.0 87377.3 89648.0 90066.0 91528.6 9876.9 9901.3 9947.8 10143.6 10168.3 18967.9 22727.8 23436.5 23475.2 23676.4 7668.1 7757.9 7851.3 7853.3 7886.0 4135.3 4213.2 4258.5 4260.0 4267.3 3141.0 3650.7 3751.0 3797.7 3803.0 648.6 658.0 660.0 668.9 688.4 562.6 596.2 602.2 620.6 624.3 8412.2 8456.7 8467.4 8511.6 8622.8 561.2 600.5 624.4 628.3 633.0 3872.9 3985.9 4029.2 4040.8 4214.6 84088.7 86522.1 88313.0 95598.0 96375.5 79611.2 79955.0 80210.0 80305.0 84181.6 72977.0 73667.3 73679.9 74226.6 74295.0 8703.9 8815.7 8875.2 8893.9 8998.4 50951.7 51592.0 51609.0 52098.0 53231.7 56039.4 66735.7 70225.0 72227.6 75396.0 10859.7 11266.7 11426.7 11490.4 11539.1 12072.5 12127.1 12283.1 12318.8 12858.8 11623.3 11645.5 11675.4 11781.0 12260.4 11478.5 11616.5 11645.5 11794.0 12245.9 11383.5 11403.9 11573.9 11597.5 12162.8 9898.7 9923.7 10031.9 10189.7 10230.8 7788.2 9705.3 9912.6 9952.2 10023.1 12:29:03 INFO - PROCESS | 1671 | -------- Summary: end -------- 12:29:03 INFO - PROCESS | 1671 | 12:29:04 INFO - TEST-INFO | 1671: exit 0 12:29:04 INFO - TEST-OK | dromaeo_css | took 1109738ms 12:29:04 INFO - TEST-START | kraken 12:29:04 INFO - operating with platform_type : mac_ 12:29:04 INFO - Initialising browser for kraken test... 12:29:04 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpAU1Pb7/profile http://localhost:49271/getInfo.html) 12:29:06 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 12:29:06 INFO - PROCESS | 1678 | colorDepth:24 12:29:06 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 12:29:06 INFO - PROCESS | 1678 | __metrics 12:29:06 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 12:29:07 INFO - TEST-INFO | 1678: exit 0 12:29:07 INFO - Browser initialized. 12:29:07 INFO - Running cycle 1/1 for kraken test... 12:29:07 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpAU1Pb7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:19 INFO - PROCESS | 1682 | RSS: Main: 170881024 12:29:19 INFO - PROCESS | 1682 | 12:29:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 12:29:23 INFO - PROCESS | 1682 | RSS: Main: 183730176 12:29:23 INFO - PROCESS | 1682 | 12:29:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 12:29:26 INFO - PROCESS | 1682 | RSS: Main: 192278528 12:29:26 INFO - PROCESS | 1682 | 12:29:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 12:29:31 INFO - PROCESS | 1682 | RSS: Main: 195985408 12:29:31 INFO - PROCESS | 1682 | 12:29:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 12:29:33 INFO - PROCESS | 1682 | RSS: Main: 197681152 12:29:33 INFO - PROCESS | 1682 | 12:29:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:29:36 INFO - PROCESS | 1682 | RSS: Main: 198205440 12:29:36 INFO - PROCESS | 1682 | 12:29:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 12:29:39 INFO - PROCESS | 1682 | RSS: Main: 197840896 12:29:39 INFO - PROCESS | 1682 | 12:29:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:43 INFO - PROCESS | 1682 | RSS: Main: 197918720 12:29:43 INFO - PROCESS | 1682 | 12:29:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 12:29:46 INFO - PROCESS | 1682 | RSS: Main: 198115328 12:29:46 INFO - PROCESS | 1682 | 12:29:48 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:48 INFO - PROCESS | 1682 | RSS: Main: 197738496 12:29:48 INFO - PROCESS | 1682 | 12:29:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:51 INFO - PROCESS | 1682 | RSS: Main: 197701632 12:29:51 INFO - PROCESS | 1682 | 12:29:53 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:54 INFO - PROCESS | 1682 | RSS: Main: 197742592 12:29:54 INFO - PROCESS | 1682 | 12:29:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:57 INFO - PROCESS | 1682 | RSS: Main: 197849088 12:29:57 INFO - PROCESS | 1682 | 12:30:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:30:01 INFO - PROCESS | 1682 | RSS: Main: 197767168 12:30:01 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 12:30:02 INFO - PROCESS | 1682 | RSS: Main: 199606272 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | __start_tp_report 12:30:02 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 12:30:02 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 12:30:02 INFO - PROCESS | 1682 | |i|pagename|runs| 12:30:02 INFO - PROCESS | 1682 | |0;ai-astar;118;113;117;116;117;129;122;174;171;118 12:30:02 INFO - PROCESS | 1682 | |1;audio-beat-detection;138;107;146;172;151;168;170;123;180;147 12:30:02 INFO - PROCESS | 1682 | |2;audio-dft;192;192;196;202;256;193;275;284;194;194 12:30:02 INFO - PROCESS | 1682 | |3;audio-fft;65;81;103;175;56;57;56;60;116;53 12:30:02 INFO - PROCESS | 1682 | |4;audio-oscillator;78;78;124;76;77;79;116;79;77;106 12:30:02 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;87;88;86;88;107;89;85;90;84 12:30:02 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;92;93;94;95;94;94;97;101;146 12:30:02 INFO - PROCESS | 1682 | |7;imaging-desaturate;150;148;87;112;122;90;115;86;95;94 12:30:02 INFO - PROCESS | 1682 | |8;json-parse-financial;57;60;64;88;95;97;92;76;62;59 12:30:02 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;65;65;70;69;72;71;90;58;65 12:30:02 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;79;81;80;80;80;90;81;83;86 12:30:02 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;126;153;144;125;127;145;138;139;172;151 12:30:02 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;177;204;163;161;162;164;159;170;165;165 12:30:02 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;69;65;70;66;68;65;68;70;80;61 12:30:02 INFO - PROCESS | 1682 | __end_tp_report 12:30:02 INFO - PROCESS | 1682 | __start_cc_report 12:30:02 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1045 12:30:02 INFO - PROCESS | 1682 | __end_cc_report 12:30:02 INFO - PROCESS | 1682 | __startTimestamp1465500602928__endTimestamp 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | ------- Summary: start ------- 12:30:02 INFO - PROCESS | 1682 | Number of tests: 14 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:129.50 Median:120.00 stddev:23.07 (19.2%) stddev-sans-first:24.09 12:30:02 INFO - PROCESS | 1682 | Values: 118.0 113.0 117.0 116.0 117.0 129.0 122.0 174.0 171.0 118.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.50 stddev:23.23 (14.6%) stddev-sans-first:24.21 12:30:02 INFO - PROCESS | 1682 | Values: 138.0 107.0 146.0 172.0 151.0 168.0 170.0 123.0 180.0 147.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:217.80 Median:199.00 stddev:37.89 (19.0%) stddev-sans-first:39.02 12:30:02 INFO - PROCESS | 1682 | Values: 192.0 192.0 196.0 202.0 256.0 193.0 275.0 284.0 194.0 194.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:82.20 Median:56.50 stddev:39.21 (69.4%) stddev-sans-first:41.09 12:30:02 INFO - PROCESS | 1682 | Values: 65.0 81.0 103.0 175.0 56.0 57.0 56.0 60.0 116.0 53.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:77.50 stddev:18.68 (24.1%) stddev-sans-first:19.39 12:30:02 INFO - PROCESS | 1682 | Values: 78.0 78.0 124.0 76.0 77.0 79.0 116.0 79.0 77.0 106.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:88.00 stddev:6.50 (7.4%) stddev-sans-first:6.89 12:30:02 INFO - PROCESS | 1682 | Values: 89.0 87.0 88.0 86.0 88.0 107.0 89.0 85.0 90.0 84.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:94.00 stddev:16.40 (17.4%) stddev-sans-first:17.20 12:30:02 INFO - PROCESS | 1682 | Values: 93.0 92.0 93.0 94.0 95.0 94.0 94.0 97.0 101.0 146.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:109.90 Median:86.50 stddev:24.04 (27.8%) stddev-sans-first:20.66 12:30:02 INFO - PROCESS | 1682 | Values: 150.0 148.0 87.0 112.0 122.0 90.0 115.0 86.0 95.0 94.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:75.00 Median:82.00 stddev:16.46 (20.1%) stddev-sans-first:16.12 12:30:02 INFO - PROCESS | 1682 | Values: 57.0 60.0 64.0 88.0 95.0 97.0 92.0 76.0 62.0 59.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:8.56 (12.3%) stddev-sans-first:8.82 12:30:02 INFO - PROCESS | 1682 | Values: 63.0 65.0 65.0 70.0 69.0 72.0 71.0 90.0 58.0 65.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.50 stddev:3.39 (4.2%) stddev-sans-first:3.60 12:30:02 INFO - PROCESS | 1682 | Values: 82.0 79.0 81.0 80.0 80.0 80.0 90.0 81.0 83.0 86.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:144.50 stddev:14.57 (10.1%) stddev-sans-first:14.25 12:30:02 INFO - PROCESS | 1682 | Values: 126.0 153.0 144.0 125.0 127.0 145.0 138.0 139.0 172.0 151.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:165.00 stddev:13.32 (8.1%) stddev-sans-first:13.81 12:30:02 INFO - PROCESS | 1682 | Values: 177.0 204.0 163.0 161.0 162.0 164.0 159.0 170.0 165.0 165.0 12:30:02 INFO - PROCESS | 1682 | 12:30:02 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:4.98 (7.3%) stddev-sans-first:5.28 12:30:02 INFO - PROCESS | 1682 | Values: 69.0 65.0 70.0 66.0 68.0 65.0 68.0 70.0 80.0 61.0 12:30:02 INFO - PROCESS | 1682 | -------- Summary: end -------- 12:30:02 INFO - PROCESS | 1682 | 12:30:03 INFO - TEST-INFO | 1682: exit 0 12:30:03 INFO - TEST-OK | kraken | took 59471ms 12:30:03 INFO - SUITE-END | took 1169s 12:30:04 INFO - Completed test suite (00:19:29) 12:30:04 INFO - javascript benchmark 12:30:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3553.022918697358, 3682.9631703682953, 3700.5189325387696, 3736.4208547675103, 3748.0, 6011.819645410634, 6019.067044608082, 6022.367651396595, 6034.396560343964, 6058.909116363253, 6012.75948962041, 6047.969760151204, 6056.969715151429, 6077.483413909812, 6094.207752992105, 5372.0, 5374.596905232103, 5422.566194704415, 5441.156620723794, 5513.669179849222, 5324.494173053554, 5419.132938729804, 5433.782648694068, 5435.673859568438, 5462.7268636568215, 5436.73216525028, 5448.645838020536, 5461.453854614527, 5488.780448782044, 5543.334799824027, 4825.30033145192, 5163.0, 5387.973060134694, 5498.395176530578, 5527.861803454925, 5323.467653234684, 5376.247325374451, 5420.07858664028, 5427.0, 5480.342358916916, 5634.859128521779, 5782.681952492611, 5950.315713692938, 5961.374055724174, 5996.4603185713495, 6329.905051424233, 6346.2067241594805, 6349.555531112824, 6369.299377068519, 6375.649339286338, 6309.179806625155, 6394.584352017104, 6442.806715798533, 6453.225612926479, 6495.4803615710625, 6014.218151640346, 6014.3985601439945, 6091.604045737013, 6142.508599312045, 6153.876922461525, 6520.217573891164, 6587.901181482282, 6608.900866487006, 6609.173853268341, 6622.470202383798, 6256.186695729617, 6273.498120150377, 6276.058591211264, 6279.995200767947, 6285.685715714196, 6221.346758590283, 6358.1734374531015, 6430.903536446957, 6469.838254043687, 6473.385028422293, 6269.937300627026, 6278.748850045947, 6298.559100862987, 6311.463525600284, 6324.936750632527, 6194.225721784777, 6309.589876658002, 6322.399372059647, 6330.272018717815, 6339.873202535923, 4961.8511444656715, 5100.77581380466, 5109.591232701449, 5121.897562048738, 5167.844964651066, 4550.88622784433, 4597.747123908151, 4601.171789077931, 4603.861884143481, 4610.792514336863, 6010.939890601126, 6062.787802426982, 6087.056506241451, 6104.755809767559, 6132.908006379907, 6269.623822570569, 6349.555531112777, 6404.263509696351, 6474.838129046811, 6501.0, 6028.156058151862, 6057.727402266909, 6080.48315893154, 6083.057126145454, 6093.055576385667, 5510.8071217507195, 5521.47545983139, 5529.447055294519, 5555.0, 5567.192757050205, 6640.335966403321, 6665.100211471389, 6668.966655166693, 6681.365270299314, 6712.798616041527, 6432.807015789534, 6489.415952564292, 6490.772822951174, 6512.05575191604, 6512.837179070561, 6460.903086453613, 6569.178852643419, 6660.300668429745, 6679.332066793282, 6706.597604143767, 6346.397092276226, 6376.553641245068, 6382.393672601095, 6389.456896163692, 6395.808125756234, 5783.219265399117, 6428.935710642833, 6475.838104047437, 6489.610623362613, 6508.967455162694, 6045.727942242697, 6112.047575716935, 6213.689315534296, 6244.843878903063, 6247.468965138014, 6263.530235232284, 6266.717997690023, 6268.968655156695, 6272.2159730033745, 6290.339514350927, 6054.182685337423, 6129.478994285536, 6159.568830182024, 6163.876722465615, 6172.4136207060255, 6121.117656725397, 6144.955357589131, 6209.844753881189, 6234.563580549318, 6275.843103922439, 6086.087086936995, 6108.602940809011, 6185.505159587312, 6194.442500175006, 6203.31763506023], "value": 5917.466236043055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.4331600213768, 541.8753686652069, 541.9430959749229, 552.7540244591156, 570.1362435909596, 33119.33761324775, 40746.185076298454, 40808.79595602018, 40874.79562602186, 40961.59038409615, 41897.58102418975, 42507.0, 42555.93610159748, 42581.36127958076, 42585.57414425855, 9679.177269932065, 9851.753706157331, 9855.704328870146, 9874.901250987507, 9920.0, 9656.662016829378, 9935.701928942144, 9939.20486361093, 9943.0, 10054.296199266055, 9903.900960990406, 9975.251856110785, 9979.900200998007, 10017.39895606266, 10056.19550435967, 9892.851607225897, 9931.957144499831, 9952.353097048668, 9973.50132493376, 9990.500474976223, 9794.9510252449, 9880.90119098807, 9954.800903981879, 9956.352837065568, 10064.496775161213, 37350.43974340387, 37389.06527336811, 37422.0, 37475.0, 37566.62433375686, 3427.605825330094, 3539.1859872229275, 3549.3256281306467, 3578.6063533011347, 3592.317459682652, 27402.862985685144, 28664.283392915135, 28806.855965720246, 29205.41589168226, 29206.70793292061, 2716.443129158518, 2761.765249953756, 2784.4570308789794, 2802.831830090201, 2838.8296702197936, 444979.0, 446755.0, 449967.0, 450087.74956125335, 451042.0, 37790.244195116495, 38577.03557411087, 66813.0, 67713.66143169253, 67732.32267677359, 37081.443778343346, 37095.88712338634, 37111.81444092762, 37266.44100338497, 37322.813385932895, 16169.757453638205, 16241.675166496603, 16664.75002874958, 16787.328506859834, 16816.663666726596, 14065.226412547203, 14255.857441425453, 14479.638009049859, 14504.274786260645, 14647.340869660891, 8183.918160818434, 8334.708285209988, 8462.830743385099, 8537.402381833212, 8561.828763424697, 3588.8743893964106, 3597.8201089945396, 3620.31214069326, 3641.32635462435, 3647.708183345379, 993.5826952679892, 1009.2027298434155, 1055.904968552834, 1135.2620796482188, 1223.2660403757675, 31493.425328733472, 31535.684643153276, 31756.682433175836, 31765.68234317627, 31992.200194995312, 1124.7469319403233, 1150.0856818829052, 1170.087331881134, 1224.877512248768, 1240.1752834365045, 16038.75941860873, 16174.838251617333, 16270.918645406697, 16298.755518667229, 16495.04989782358, 631481.37037259, 632300.0, 637727.0, 641676.0, 641749.7912510408, 51954.0, 63371.04943425852, 63473.68263158655, 64336.0, 64340.67829660822, 1343.1001229176475, 1539.3765524962407, 1563.6403627165816, 1577.0458872382274, 1588.547264029746, 30702.539461908535, 30742.692573074877, 30918.06752083831, 31277.530837037917, 31635.36729265356, 55822.44177558173, 56433.43566564282, 56616.43383566112, 57555.0, 58906.0, 560423.0, 563160.0, 566348.0, 566829.0, 567083.0, 28728.856355718086, 43727.34408983804, 44366.556334436245, 46371.30443043425, 46371.76814116043, 46861.0, 47601.28598071101, 48267.5173248263, 48916.75541622269, 49487.0, 38314.0, 38413.0, 39373.60626393814, 39500.80249598734, 39518.40722389109, 33547.0, 38014.61985380111, 38658.6134138655, 38749.0, 39581.0, 33495.665043349254, 37341.43987840239, 38457.4231386535, 38474.42288365621, 39581.812545623674, 33207.0, 34256.314873701886, 34442.13894652654, 34655.0, 34689.479657805656, 26026.34934126662, 26055.0, 26064.609030864933, 26152.215433537025, 26504.0], "value": 19436.98490575473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.43496409918407, 415.62386040633237, 419.10521037584755, 419.68942982193147, 428.7299001628973, 20994.685079723797, 21277.936103194817, 21774.673379899315, 22608.0, 22931.54136917265, 21807.345779626598, 22048.779512204874, 22062.88968555159, 22113.336599901988, 22188.0, 5982.940170598293, 6187.164732761064, 6191.690415479231, 6247.375262473739, 6253.093301471284, 4580.839670611529, 6130.938690613081, 6198.659073750942, 6663.600183988976, 7007.614581198032, 6817.352351526597, 6930.930690693104, 6944.4444444444325, 6945.722171113174, 6965.024896514492, 6605.240397354318, 6762.087118239024, 6768.898466522957, 6832.043513908032, 6838.974153876933, 5886.440788125121, 5895.587308888379, 5898.085796701475, 6016.308124565688, 6026.156338112668, 21500.354989350344, 26583.73416265851, 26938.32654183661, 27142.5928611071, 27552.897884084614, 2405.9759402405925, 2532.569463191262, 2736.904208352718, 2912.4175164966878, 3108.300632357724, 15166.0, 15643.608909777347, 15903.52289431319, 15912.602184945354, 16704.83295167045, 1615.87696550896, 1759.463363674079, 1812.5287425269394, 1843.3548258109688, 1910.9808901910942, 116685.41657291744, 119184.0, 120937.0, 121841.39079304636, 122917.38541307325, 11883.287002779862, 11910.94044529789, 12024.639260822189, 12042.759144817055, 12051.819222711667, 15284.923575382052, 15588.06471611707, 15656.765148522782, 15675.372985080698, 15691.1369874658, 8915.910840891638, 9295.628174872929, 9325.393849399767, 9358.4384936904, 9443.244540436886, 9415.62337506492, 9476.715698529055, 9477.383970041925, 9478.383905046288, 9496.667616633385, 4769.236922092448, 4812.1578723723205, 4841.709497430165, 4847.903041939141, 4858.05267972749, 1925.838752144267, 2038.9082491287927, 2052.3124753207844, 2119.385378240324, 2142.539354038889, 943.9716808495756, 947.4694171264114, 1031.515187861719, 1049.7060822969581, 1093.6554985179644, 18850.478510614015, 20951.476213094793, 21197.834119123596, 21357.572848542943, 21362.78637213608, 1014.2747935226348, 1058.7564860082225, 1060.1042119409087, 1069.978600427987, 1096.5504143301368, 10965.945170274257, 11332.660020199408, 11423.314601123959, 11471.0, 11508.827367589492, 588460.0, 591433.0, 601346.0, 606581.0, 641204.0, 108985.0, 138283.0, 138751.0, 139250.0, 143511.56488435192, 1050.2858056521638, 1070.4861666400327, 1084.6908631040274, 1087.1683162380784, 1103.4151899493281, 18232.0, 18751.0, 18815.965121918427, 18859.717104243722, 19124.61750764949, 52444.0, 53124.73437632787, 53702.0, 53773.92452151013, 54092.91814163773, 55897.0, 74338.0, 78586.6070669643, 79881.2011879897, 82381.17618823735, 8312.0, 8482.279006284534, 8548.960551314149, 8599.0, 8695.217430431292, 12035.458404371999, 12921.612351629467, 13087.345632718136, 13268.46926122983, 13531.323433828466, 11181.888181118085, 11298.0396666281, 11338.546458141582, 11416.657500275005, 11475.942620286845, 11103.666889993314, 11105.888941110485, 11312.264702794291, 11367.772644546898, 11601.361925094201, 10397.792044159225, 10776.784464310827, 11432.714182145513, 11454.484548195185, 11795.646130616095, 7935.246151615587, 7961.522308661499, 8272.420930535045, 8276.379271554779, 8385.496870187808, 8230.300424463749, 11052.502637381176, 11127.499262533367, 11137.164712646421, 11232.269902456314], "value": 10178.546888462039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1626.9105199214043, 1639.2623319506222, 1857.3870622694512, 1956.3544030469936, 2014.879107253564, 8418.158184181579, 9071.0, 9235.584398702058, 9409.294302927283, 9431.57557909894, 7667.118281397641, 9041.186293233608, 9087.454752714842, 9178.21985131263, 9222.953885230581, 2538.378097366148, 2555.4889022195634, 2568.4863027394504, 2571.1643715792347, 2579.290695058855, 2194.615942210107, 2482.640017197514, 2546.923592292225, 2554.9361265968314, 2556.003158768082, 2236.7651396603287, 2529.0895277700015, 2538.8730563471845, 2540.530001949636, 2568.858712770797, 2502.4869901670204, 2512.8869200886006, 2521.571332873416, 2525.4191535946743, 2534.7085085215253, 2559.5520783862935, 2576.5362234797917, 2585.418280886804, 2588.896444142232, 2600.115960573395, 9217.631294748202, 9347.719568412958, 9352.0, 9396.201322887562, 9418.246540276761, 5782.681952492611, 5820.505257053155, 5837.941620583825, 5889.352171261158, 6011.0382338825575, 3698.5746639136573, 3762.059485128718, 3817.61823817616, 3825.617438256152, 3842.4044273137706, 1053.5627714498473, 1063.0751246415591, 1077.493578018338, 1079.87581428136, 1083.712816103733, 12384.380780961006, 12431.875681243162, 12542.937285313606, 12546.560870369492, 12557.121001529897, 4453.799579018952, 4963.70217786934, 5096.490350964948, 5118.948810511922, 5248.239005344204, 10527.157827373792, 10551.630692925712, 10586.470676466146, 10647.89352106469, 10693.251472396858, 5681.744321505542, 5688.516476099578, 5820.156077368758, 5940.257467816523, 5941.613795103304, 4758.738269395148, 5104.183330667075, 5209.348831396075, 5231.816886409034, 5267.288915996368, 4259.595338442843, 4266.722663026893, 4287.7641729705165, 4328.285832837547, 4340.587644173798, 1393.08056682589, 1407.366684991758, 1409.718056388706, 1424.287856071964, 1427.7215942891244, 860.4192170285032, 869.7303835810792, 931.2829121576349, 963.6145541783343, 972.1590823937244, 6120.265568131764, 6145.661988590581, 6172.043333283348, 6190.3190649028575, 6260.217472815898, 481.1507688929043, 484.9670202468719, 486.2099088980407, 490.4776413120016, 493.23302264978304, 3927.19492504036, 3975.6421922027157, 4076.7146299758733, 4088.836446542105, 4113.526944401372, 11132.443377831076, 11509.079273658088, 11517.0, 11592.420378981018, 11600.477978490988, 9223.861642075375, 11000.944995274973, 11009.339439633648, 11014.559417623366, 11337.093032557375, 8604.397692161489, 8683.609237584324, 8758.956205219061, 8775.122487751174, 8847.911520884838, 5825.883482330414, 6086.60437071589, 6099.207103076749, 6119.418655227746, 6232.940400131898, 9872.950635247065, 9892.752681183028, 9908.0, 9920.305578609428, 10110.848337275094, 10084.949575252076, 10253.58985640566, 10313.968603139627, 10428.374297542172, 10548.683539493828, 7204.639768011683, 7501.0, 7673.232676732282, 7947.284744373034, 8077.071136819106, 7583.317501424898, 8516.977962644522, 8545.82908341842, 8598.61306241233, 8629.834972278662, 7596.126445458843, 7775.650095745592, 7780.0, 7822.335101516207, 7849.293563579306, 7508.511946723445, 7588.696452142073, 7593.506422082547, 7720.189380115007, 7722.227777222458, 7177.318154775288, 7210.96394518024, 7230.6384680764695, 7278.09023872016, 7302.2697730226555, 4129.236091323115, 5027.7737501813235, 5079.746012699424, 5225.503577160163, 5254.868628284324, 5129.358830146231, 5132.2814805926455, 5138.3577052868395, 5214.97392513035, 5352.812651557177], "value": 4738.560172575475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [238.8292370954767, 325.13027651033497, 344.2632765881014, 347.10793261318406, 349.3397478765133, 6852.451803855692, 6927.203371612266, 6974.860502789941, 7050.3302186292285, 7057.047298614685, 7010.4041156501635, 7055.470839687018, 7060.858782824341, 7093.609851458168, 7115.822104447391, 5113.565346945514, 5123.487651234866, 5165.560927321182, 5177.792888284464, 5185.481451854803, 5170.069387510247, 5178.119719647669, 5182.093133701606, 5198.246254293125, 5217.2695822584865, 5125.948740512585, 5132.230165475171, 5137.820176293831, 5151.613628977823, 5163.915577728662, 3983.521977362706, 4829.7343646099625, 5013.072581572421, 5131.948680513203, 5144.768485418165, 4242.4757269424645, 4245.448091748053, 4261.978690106561, 4264.104538047014, 4280.785960701984, 6637.369449902251, 6647.202335719745, 6655.667216639149, 6683.064370988066, 6693.966530167367, 5918.171455996164, 5951.553633477506, 5960.761569537213, 5967.522598192178, 5974.611650242764, 5946.286445626509, 7440.888386674204, 7447.329740323343, 7483.663235154431, 7497.250274972514, 4534.251848445003, 4712.458067322267, 4729.858104256843, 4732.976335118303, 4768.380110585636, 7711.383089352838, 7748.2251774822635, 7773.251018520844, 7816.374690024784, 7834.4124190685925, 4786.928196077061, 4798.448178459522, 4799.400074990626, 4804.591609713144, 4810.158222311082, 4877.487863774323, 4884.633652476078, 4893.584045356113, 4899.191633380524, 4911.7298548580175, 5879.52963762898, 5887.4406931341455, 5911.379305172981, 5913.793017244376, 5930.52555795544, 7209.2069872314005, 7414.592197429085, 7440.995465612182, 7452.888206676904, 7466.887996680054, 1682.2682133272067, 1690.5604542818955, 1706.2918888661316, 1711.0076155829588, 1711.6833385823663, 863.7322430046705, 998.8064263205545, 1057.8994995475418, 1060.6340812419703, 1079.2337440417234, 6912.792616221522, 6929.688164032631, 6951.756688515878, 7022.648867556704, 7029.29707029293, 7717.2668596483245, 7783.871338655863, 7793.883091753628, 7813.335866451302, 7832.295093441618, 6884.65576721162, 6959.304069593101, 6962.965185174042, 6980.685869135901, 7010.579365238102, 3974.5627980922077, 4072.3280658690983, 4109.178164367138, 4134.1731653669385, 4137.958620413818, 7550.433717471102, 7936.007999000125, 8063.758087257392, 8089.47418417801, 8127.59362031896, 7905.407094467938, 7929.444938854225, 7949.085855126619, 7985.920140798517, 7997.960010199912, 6413.935860641427, 8029.197080291924, 8055.315298199602, 8071.677132914618, 8076.394270429624, 6159.907601385893, 6256.374362563707, 7612.8477430452185, 7804.102528209101, 7978.401619878417, 6190.442860142609, 7765.7670269892, 7778.572178530235, 7782.143964164051, 7812.296893279405, 6560.901586476111, 8184.099749027721, 8203.015638123463, 8226.177382261965, 8257.256846883809, 4791.401074865642, 4858.368412106403, 4872.098661747588, 4873.975630121827, 4876.829310974099, 7636.653979730397, 7753.302202801775, 7846.333061689592, 7905.56519391439, 7961.323287520626, 6007.699615019319, 7478.140013898471, 7478.1774004858335, 7523.699052037857, 7557.168711441627, 7429.517081389692, 7481.812954676177, 7516.849663006818, 7537.962310188634, 7545.547267163988, 7106.431485481253, 7336.449766267445, 7343.3390994810725, 7349.684849272462, 7352.669129889275, 6009.90985135232, 7497.137829149499, 7525.247475252431, 7539.698412063456, 7574.204708505527, 6969.815131427568, 7167.892481612885, 7284.453665974967, 7286.744963926237, 7346.33882950537], "value": 5380.504580384315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.7766132131503, 722.2308241722565, 751.7782254235, 772.4438404348867, 792.9008873890765, 15270.389184432637, 15482.535523934272, 15759.921200393996, 15775.921120394396, 15790.4473343433, 11780.46987885545, 12483.68790780231, 14397.280135993211, 14568.053076550043, 14579.489717859877, 769.6805825582377, 941.8775559177315, 946.507815935713, 966.7051549277468, 969.2149359019181, 929.2240978782725, 931.6552875436064, 939.3800091939321, 947.2469386837481, 956.3114557518576, 977.2963466304285, 1010.7978404319166, 1012.1093437774748, 1012.696191142658, 1016.4917541229386, 978.4618459847092, 986.1814693804162, 989.2432289298692, 1015.0914931136665, 1015.7257540464108, 741.499487845702, 742.0687037767567, 760.8972788673514, 764.9120351159632, 768.4620765464198, 15101.093934363864, 15122.168280744554, 15336.15651139187, 15416.845831541654, 15475.303611337516, 12639.684007899876, 13424.731505369838, 13444.596662100153, 13462.259575723332, 13579.388927498287, 8464.703735369232, 9317.72046838596, 10281.177505799518, 10403.895961040369, 10445.007724266183, 3580.337637537064, 3595.7842529448317, 3610.711143108545, 3629.0745859805843, 3856.9614303856883, 86626.0, 87377.25245495119, 89648.0, 90066.0, 91528.627070594, 9876.851847222297, 9901.257405694601, 9947.80104397908, 10143.64497242593, 10168.33905796121, 18967.90516047411, 22727.772722272897, 23436.531269374518, 23475.178368757013, 23676.408089797893, 7668.1181664109345, 7757.9224207758325, 7851.254130857559, 7853.253940875607, 7886.014248218973, 4135.276326642826, 4213.220554197422, 4258.53156152823, 4259.97760537475, 4267.253230684618, 3141.0, 3650.7040000799334, 3751.0, 3797.6582107609897, 3802.980985095057, 648.6367634124905, 658.0326919428433, 659.9967000164968, 668.8528523724773, 688.3907741648677, 562.5808772464541, 596.2368168744015, 602.1780269931512, 620.6059152438235, 624.3039011502233, 8412.200840920103, 8456.704015359555, 8467.407281490237, 8511.57442127891, 8622.827543449095, 561.2283110722756, 600.495583709686, 624.3662682377391, 628.3496581038603, 632.9746810127635, 3872.8644497442456, 3985.940210896839, 4029.2143032108456, 4040.7575545467366, 4214.599613036757, 84088.73866892002, 86522.13477865141, 88313.0, 95598.0, 96375.51812240893, 79611.20388796154, 79955.0, 80210.0, 80305.0, 84181.57909210537, 72977.0, 73667.26332736605, 73679.89480157802, 74226.6288668564, 74295.0, 8703.91296087031, 8815.691450799191, 8875.201231889161, 8893.866592001255, 8998.415103018282, 50951.74524127356, 51592.0, 51609.0, 52098.0, 53231.73384133055, 56039.439605605054, 66735.66632166808, 70225.0, 72227.63886180746, 75396.0, 10859.674209773719, 11266.66200014001, 11426.714332141762, 11490.425478726198, 11539.134564907497, 12072.45673944657, 12127.090468214743, 12283.140180187302, 12318.815217771562, 12858.807117893426, 11623.302601843916, 11645.534178632759, 11675.35785531804, 11781.0, 12260.448279827608, 11478.540858365906, 11616.535338586362, 11645.534178632759, 11794.0, 12245.938770306091, 11383.487743051417, 11403.885961140615, 11573.942130289295, 11597.478113485082, 12162.756744864877, 9898.703038908845, 9923.702288931056, 10031.899681003388, 10189.74525636865, 10230.846537301797, 7788.221177882167, 9705.320627556004, 9912.553935073083, 9952.203823693942, 10023.148032417326], "value": 7141.79786420882, "unit": "score"}], "name": "dromaeo_css", "value": 7729.065305479158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 117.0, 116.0, 117.0, 129.0, 122.0, 174.0, 171.0, 118.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 107.0, 146.0, 172.0, 151.0, 168.0, 170.0, 123.0, 180.0, 147.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 192.0, 196.0, 202.0, 256.0, 193.0, 275.0, 284.0, 194.0, 194.0], "value": 217.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 81.0, 103.0, 175.0, 56.0, 57.0, 56.0, 60.0, 116.0, 53.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 124.0, 76.0, 77.0, 79.0, 116.0, 79.0, 77.0, 106.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 88.0, 107.0, 89.0, 85.0, 90.0, 84.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 94.0, 95.0, 94.0, 94.0, 97.0, 101.0, 146.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 87.0, 112.0, 122.0, 90.0, 115.0, 86.0, 95.0, 94.0], "value": 109.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 64.0, 88.0, 95.0, 97.0, 92.0, 76.0, 62.0, 59.0], "value": 75.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 70.0, 69.0, 72.0, 71.0, 90.0, 58.0, 65.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 80.0, 80.0, 80.0, 90.0, 81.0, 83.0, 86.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 153.0, 144.0, 125.0, 127.0, 145.0, 138.0, 139.0, 172.0, 151.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 204.0, 163.0, 161.0, 162.0, 164.0, 159.0, 170.0, 165.0, 165.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 70.0, 66.0, 68.0, 65.0, 68.0, 70.0, 80.0, 61.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1573.0, "alertThreshold": 2.0}]} 12:30:04 INFO - Return code: 0 12:30:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:30:04 ERROR - # TBPL SUCCESS # 12:30:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:30:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:30:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:30:04 INFO - 2016-06-09 12:30:04.234 screenresolution[1688:12176] starting screenresolution argv=screenresolution get 12:30:04 INFO - 2016-06-09 12:30:04.237 screenresolution[1688:12176] Display 0: 1600x1200x32@60 12:30:04 INFO - 2016-06-09 12:30:04.243 screenresolution[1689:12179] starting screenresolution argv=screenresolution list 12:30:04 INFO - Available Modes on Display 0 12:30:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:30:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:30:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:30:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:30:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:30:04 INFO - Intel Iris: 12:30:04 INFO - Chipset Model: Intel Iris 12:30:04 INFO - Type: GPU 12:30:04 INFO - Bus: Built-In 12:30:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:30:04 INFO - Vendor: Intel (0x8086) 12:30:04 INFO - Device ID: 0x0a2e 12:30:04 INFO - Revision ID: 0x0009 12:30:04 INFO - Displays: 12:30:04 INFO - Display: 12:30:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:30:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:30:04 INFO - Display Serial Number: 1600x1200 60 12:30:04 INFO - Main Display: Yes 12:30:04 INFO - Mirror: Off 12:30:04 INFO - Online: Yes 12:30:04 INFO - Rotation: Supported 12:30:04 INFO - Return code: 0 12:30:04 INFO - Running post-action listener: _resource_record_post_action 12:30:04 INFO - Running post-run listener: _resource_record_post_run 12:30:05 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31501824; Write bytes: 496374272; Read time: 197; Write time: 1563 12:30:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194843136; Write bytes: 195758080; Read time: 17622; Write time: 450 12:30:05 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29720064; Write bytes: 299768320; Read time: 182; Write time: 1111 12:30:05 INFO - Running post-run listener: _upload_blobber_files 12:30:05 INFO - Blob upload gear active. 12:30:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:30:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:30:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:06 INFO - (blobuploader) - INFO - Done attempting. 12:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:30:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:07 INFO - (blobuploader) - INFO - Done attempting. 12:30:07 INFO - (blobuploader) - INFO - Iteration through files over. 12:30:07 INFO - Return code: 0 12:30:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:30:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:30:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/302603db79f112b04565c11e8dd60cc67b83b02c8fc7897471f8a52663d9d1ad9604273e9bc9613de66e2a7f17adafbe6da15e782244d5e629eae81c4c930114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f42d573375a68acca6f8337a463d2aebaf387a09e94912b74d8cde74c4b96b4c72f77370503c2020550114c2be73b29bdc3d6c13ef44794e4de52cb516ec1c40"} 12:30:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:30:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:30:07 INFO - Contents: 12:30:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/302603db79f112b04565c11e8dd60cc67b83b02c8fc7897471f8a52663d9d1ad9604273e9bc9613de66e2a7f17adafbe6da15e782244d5e629eae81c4c930114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f42d573375a68acca6f8337a463d2aebaf387a09e94912b74d8cde74c4b96b4c72f77370503c2020550114c2be73b29bdc3d6c13ef44794e4de52cb516ec1c40"} 12:30:07 INFO - Running post-run listener: copy_logs_to_upload_dir 12:30:07 INFO - Copying logs to upload dir... 12:30:07 INFO - mkdir: /builds/slave/test/build/upload/logs 12:30:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.771340 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-06-09 12:30:07.918742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:30:07.922523) ========= 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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/Mozilla-Beta/sha512/302603db79f112b04565c11e8dd60cc67b83b02c8fc7897471f8a52663d9d1ad9604273e9bc9613de66e2a7f17adafbe6da15e782244d5e629eae81c4c930114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f42d573375a68acca6f8337a463d2aebaf387a09e94912b74d8cde74c4b96b4c72f77370503c2020550114c2be73b29bdc3d6c13ef44794e4de52cb516ec1c40"} build_url:https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010919 build_url: 'https://queue.taskcluster.net/v1/task/cwf6KhB5SiyUwongstxZIA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/302603db79f112b04565c11e8dd60cc67b83b02c8fc7897471f8a52663d9d1ad9604273e9bc9613de66e2a7f17adafbe6da15e782244d5e629eae81c4c930114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f42d573375a68acca6f8337a463d2aebaf387a09e94912b74d8cde74c4b96b4c72f77370503c2020550114c2be73b29bdc3d6c13ef44794e4de52cb516ec1c40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:30:07.956910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:30:07.957253) ========= 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.M3Fh5AWKRS/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.W47WzHdBSZ/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005236 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:30:08.008577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:30:08.009293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:30:08.010010) ========= ========= Total master_lag: 0.21 =========