builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1460988789.55 results: success (0) buildid: 20160418054123 builduid: 76ce0d81b70e43a4a119c6d091e37136 revision: 6066850740cd4711ee5502fda89f422440b7c2cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:09.547007) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:09.547438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-04-18 07:13:09.547750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-04-18 07:13:24.273234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:24.273494) ========= 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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-18 07:13:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.58M=0.002s 2016-04-18 07:13:25 (7.58 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.454981 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:25.144454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-04-18 07:13:25.144784) ========= 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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.030873 ========= master_lag: 4.62 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-04-18 07:13:29.795208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 07:13:29.795557) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6066850740cd4711ee5502fda89f422440b7c2cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6066850740cd4711ee5502fda89f422440b7c2cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-18 07:13:30,330 truncating revision to first 12 chars 2016-04-18 07:13:30,330 Setting DEBUG logging. 2016-04-18 07:13:30,330 attempt 1/10 2016-04-18 07:13:30,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6066850740cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 07:13:30,609 unpacking tar archive at: mozilla-central-6066850740cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532845 ========= master_lag: 0.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 07:13:30.811117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:30.811575) ========= script_repo_revision: 6066850740cd4711ee5502fda89f422440b7c2cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:30.811985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:30.812474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:13:30.871800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-18 07:13:30.872151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:13:31 INFO - MultiFileLogger online at 20160418 07:13:31 in /builds/slave/test 07:13:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:13:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:31 INFO - {'append_to_log': False, 07:13:31 INFO - 'base_work_dir': '/builds/slave/test', 07:13:31 INFO - 'blob_upload_branch': 'Firefox', 07:13:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:31 INFO - 'branch': 'Firefox', 07:13:31 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:31 INFO - 'config_files': ('talos/mac_config.py',), 07:13:31 INFO - 'default_actions': ('clobber', 07:13:31 INFO - 'read-buildbot-config', 07:13:31 INFO - 'download-and-extract', 07:13:31 INFO - 'populate-webroot', 07:13:31 INFO - 'create-virtualenv', 07:13:31 INFO - 'install', 07:13:31 INFO - 'run-tests'), 07:13:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:31 INFO - 'download_minidump_stackwalk': True, 07:13:31 INFO - 'download_symbols': 'ondemand', 07:13:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:31 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:31 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:31 INFO - 'installer_path': 'installer.exe', 07:13:31 INFO - 'log_level': 'info', 07:13:31 INFO - 'log_name': 'talos', 07:13:31 INFO - 'log_to_console': True, 07:13:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:13:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:13:31 INFO - 'opt_config_files': (), 07:13:31 INFO - 'pip_index': False, 07:13:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:31 INFO - 'cmd': ('bash', 07:13:31 INFO - '-c', 07:13:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:31 INFO - 'enabled': True, 07:13:31 INFO - 'halt_on_failure': False, 07:13:31 INFO - 'name': 'check_screen_resolution'},), 07:13:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:31 INFO - 'cmd': ('bash', 07:13:31 INFO - '-c', 07:13:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:31 INFO - 'enabled': True, 07:13:31 INFO - 'halt_on_failure': False, 07:13:31 INFO - 'name': 'check_screen_resolution'},), 07:13:31 INFO - 'run_cmd_checks_enabled': True, 07:13:31 INFO - 'sps_profile': False, 07:13:31 INFO - 'sps_profile_interval': 0, 07:13:31 INFO - 'suite': 'dromaeojs', 07:13:31 INFO - 'system_bits': '32', 07:13:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:31 INFO - 'title': 't-yosemite-r7-0144', 07:13:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:31 INFO - 'use_talos_json': True, 07:13:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:31 INFO - 'work_dir': 'build'} 07:13:31 INFO - ##### 07:13:31 INFO - ##### Running clobber step. 07:13:31 INFO - ##### 07:13:31 INFO - Running pre-action listener: _resource_record_pre_action 07:13:31 INFO - Running main action method: clobber 07:13:31 INFO - rmtree: /builds/slave/test/build 07:13:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:33 INFO - Running post-action listener: _resource_record_post_action 07:13:33 INFO - ##### 07:13:33 INFO - ##### Running read-buildbot-config step. 07:13:33 INFO - ##### 07:13:33 INFO - Running pre-action listener: _resource_record_pre_action 07:13:33 INFO - Running main action method: read_buildbot_config 07:13:33 INFO - Using buildbot properties: 07:13:33 INFO - { 07:13:33 INFO - "project": "", 07:13:33 INFO - "product": "firefox", 07:13:33 INFO - "script_repo_revision": "production", 07:13:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:13:33 INFO - "repository": "", 07:13:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:13:33 INFO - "buildid": "20160418054123", 07:13:33 INFO - "pgo_build": "False", 07:13:33 INFO - "basedir": "/builds/slave/test", 07:13:33 INFO - "buildnumber": 225, 07:13:33 INFO - "slavename": "t-yosemite-r7-0144", 07:13:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:13:33 INFO - "platform": "yosemite_r7", 07:13:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:13:33 INFO - "branch": "mozilla-central", 07:13:33 INFO - "repo_path": "mozilla-central", 07:13:33 INFO - "revision": "6066850740cd4711ee5502fda89f422440b7c2cc", 07:13:33 INFO - "stage_platform": "macosx64", 07:13:33 INFO - "builduid": "76ce0d81b70e43a4a119c6d091e37136", 07:13:33 INFO - "slavebuilddir": "test" 07:13:33 INFO - } 07:13:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:13:33 INFO - Running post-action listener: _resource_record_post_action 07:13:33 INFO - ##### 07:13:33 INFO - ##### Running download-and-extract step. 07:13:33 INFO - ##### 07:13:33 INFO - Running pre-action listener: _resource_record_pre_action 07:13:33 INFO - Running main action method: download_and_extract 07:13:33 INFO - mkdir: /builds/slave/test/build/tests 07:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:33 INFO - https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:13:35 INFO - Downloaded 1199 bytes. 07:13:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:35 INFO - Using the following test package requirements: 07:13:35 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:13:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:13:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'jsshell-mac.zip'], 07:13:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:13:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:13:35 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:13:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:13:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:35 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:13:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:35 INFO - https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:36 INFO - Downloaded 18031989 bytes. 07:13:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:39 INFO - Return code: 0 07:13:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:13:39 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')]} 07:13:39 INFO - https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:40 INFO - Downloaded 18031989 bytes. 07:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:44 INFO - Return code: 0 07:13:44 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')]} 07:13:44 INFO - https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:13:45 INFO - Downloaded 10845952 bytes. 07:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:13:45 INFO - Return code: 0 07:13: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')]} 07:13:45 INFO - https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:13:48 INFO - Downloaded 109977229 bytes. 07:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:48 INFO - mkdir: /builds/slave/test/properties 07:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:48 INFO - Contents: 07:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:50 INFO - Running post-action listener: _resource_record_post_action 07:13:50 INFO - Running post-action listener: set_extra_try_arguments 07:13:50 INFO - ##### 07:13:50 INFO - ##### Running populate-webroot step. 07:13:50 INFO - ##### 07:13:50 INFO - Running pre-action listener: _resource_record_pre_action 07:13:50 INFO - Running main action method: populate_webroot 07:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:13:50 INFO - '--tppagecycles', 07:13:50 INFO - '7'], 07:13:50 INFO - 'tests': ['tsvgm']}}, 07:13:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:13:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:13:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['damp', 'tps']}, 07:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'tests': ['damp', 'tps']}, 07:13:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['dromaeo_dom']}, 07:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['a11yr', 07:13:50 INFO - 'ts_paint', 07:13:50 INFO - 'tpaint', 07:13:50 INFO - 'sessionrestore', 07:13:50 INFO - 'sessionrestore_no_auto_restore', 07:13:50 INFO - 'tabpaint']}, 07:13:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['tsvgx', 07:13:50 INFO - 'tsvgr_opacity', 07:13:50 INFO - 'tart', 07:13:50 INFO - 'tscrollx', 07:13:50 INFO - 'cart']}, 07:13:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:50 INFO - 'tsvgr_opacity', 07:13:50 INFO - 'tart', 07:13:50 INFO - 'tscrollx', 07:13:50 INFO - 'cart']}, 07:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'talos_options': ['--disable-e10s'], 07:13:50 INFO - 'tests': ['tp5o']}, 07:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'tests': ['tp5o']}, 07:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'talos_options': ['--disable-e10s', 07:13:50 INFO - '--xperf_path', 07:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:50 INFO - 'tests': ['tp5n']}, 07:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:50 INFO - 'talos_options': ['--xperf_path', 07:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:50 INFO - 'tests': ['tp5n']}}, 07:13:50 INFO - 'talos.zip': {'path': '', 07:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:13:50 INFO - Running post-action listener: _resource_record_post_action 07:13:50 INFO - ##### 07:13:50 INFO - ##### Running create-virtualenv step. 07:13:50 INFO - ##### 07:13:50 INFO - Running pre-action listener: _resource_record_pre_action 07:13:50 INFO - Running main action method: create_virtualenv 07:13:50 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:50 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 07:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:50 INFO - Using real prefix '/tools/python27' 07:13:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:53 INFO - Installing pip.................done. 07:13:53 INFO - Return code: 0 07:13:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:53 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:13:53 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 07:13:53 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 07:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:53 INFO - 'HOME': '/Users/cltbld', 07:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:53 INFO - 'LOGNAME': 'cltbld', 07:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:53 INFO - 'MOZ_NO_REMOTE': '1', 07:13:53 INFO - 'NO_EM_RESTART': '1', 07:13:53 INFO - 'PAGER': '/bin/cat', 07:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:53 INFO - 'PWD': '/builds/slave/test', 07:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:53 INFO - 'SHELL': '/bin/bash', 07:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:13:53 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:53 INFO - 'USER': 'cltbld', 07:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:53 INFO - 'XPC_FLAGS': '0x0', 07:13:53 INFO - 'XPC_SERVICE_NAME': '0', 07:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:54 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 07:13:54 INFO - Cleaning up... 07:13:54 INFO - Return code: 0 07:13:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:13:54 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')]} 07:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:54 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')]} 07:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:54 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:13:54 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 07:13:54 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 07:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:54 INFO - 'HOME': '/Users/cltbld', 07:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:54 INFO - 'LOGNAME': 'cltbld', 07:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:54 INFO - 'MOZ_NO_REMOTE': '1', 07:13:54 INFO - 'NO_EM_RESTART': '1', 07:13:54 INFO - 'PAGER': '/bin/cat', 07:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:54 INFO - 'PWD': '/builds/slave/test', 07:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:54 INFO - 'SHELL': '/bin/bash', 07:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:13:54 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:54 INFO - 'USER': 'cltbld', 07:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:54 INFO - 'XPC_FLAGS': '0x0', 07:13:54 INFO - 'XPC_SERVICE_NAME': '0', 07:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:54 INFO - Downloading/unpacking psutil>=0.7.1 07:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:57 INFO - Installing collected packages: psutil 07:13:57 INFO - Running setup.py install for psutil 07:13:57 INFO - building 'psutil._psutil_osx' extension 07:13:57 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 07:13:57 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 07:13:57 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 07:13:58 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 07:13:58 INFO - building 'psutil._psutil_posix' extension 07:13:58 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 07:13:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:13:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:13:58 INFO - ^ 07:13:58 INFO - 1 warning generated. 07:13:58 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 07:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:58 INFO - Successfully installed psutil 07:13:58 INFO - Cleaning up... 07:13:58 INFO - Return code: 0 07:13:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:58 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:13:58 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 07:13:58 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 07:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:58 INFO - 'HOME': '/Users/cltbld', 07:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:58 INFO - 'LOGNAME': 'cltbld', 07:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:58 INFO - 'MOZ_NO_REMOTE': '1', 07:13:58 INFO - 'NO_EM_RESTART': '1', 07:13:58 INFO - 'PAGER': '/bin/cat', 07:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:58 INFO - 'PWD': '/builds/slave/test', 07:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:58 INFO - 'SHELL': '/bin/bash', 07:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:13:58 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:58 INFO - 'USER': 'cltbld', 07:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:58 INFO - 'XPC_FLAGS': '0x0', 07:13:58 INFO - 'XPC_SERVICE_NAME': '0', 07:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:13: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 07:13: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 07:13: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 07:13: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 07:13: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 07:13: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 07:14:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:02 INFO - Installing collected packages: mozsystemmonitor 07:14:02 INFO - Running setup.py install for mozsystemmonitor 07:14:02 INFO - Successfully installed mozsystemmonitor 07:14:02 INFO - Cleaning up... 07:14:02 INFO - Return code: 0 07:14:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', '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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:14: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 blobuploader==1.2.4 07:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:02 INFO - 'HOME': '/Users/cltbld', 07:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:02 INFO - 'LOGNAME': 'cltbld', 07:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:02 INFO - 'MOZ_NO_REMOTE': '1', 07:14:02 INFO - 'NO_EM_RESTART': '1', 07:14:02 INFO - 'PAGER': '/bin/cat', 07:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:02 INFO - 'PWD': '/builds/slave/test', 07:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:02 INFO - 'SHELL': '/bin/bash', 07:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:02 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:02 INFO - 'USER': 'cltbld', 07:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:02 INFO - 'XPC_FLAGS': '0x0', 07:14:02 INFO - 'XPC_SERVICE_NAME': '0', 07:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:06 INFO - Downloading docopt-0.6.1.tar.gz 07:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:06 INFO - Running setup.py install for blobuploader 07:14:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:06 INFO - Running setup.py install for requests 07:14:06 INFO - Running setup.py install for docopt 07:14:06 INFO - Successfully installed blobuploader requests docopt 07:14:06 INFO - Cleaning up... 07:14:07 INFO - Return code: 0 07:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:07 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')]} 07:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:07 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')]} 07:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:07 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14:07 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 07:14:07 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 07:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:07 INFO - 'HOME': '/Users/cltbld', 07:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:07 INFO - 'LOGNAME': 'cltbld', 07:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:07 INFO - 'MOZ_NO_REMOTE': '1', 07:14:07 INFO - 'NO_EM_RESTART': '1', 07:14:07 INFO - 'PAGER': '/bin/cat', 07:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:07 INFO - 'PWD': '/builds/slave/test', 07:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:07 INFO - 'SHELL': '/bin/bash', 07:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:07 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:07 INFO - 'USER': 'cltbld', 07:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:07 INFO - 'XPC_FLAGS': '0x0', 07:14:07 INFO - 'XPC_SERVICE_NAME': '0', 07:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-rcHeKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UCDg8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ERwD6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZsFeGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-xDh8iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-_YU5ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-9rPDaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-mSTqMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-f3FZyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lNzRmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-DM1MYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zdQlfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-g7XPiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZGNX66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Ic_xWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:08 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-F_gnpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:09 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-PBMXWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:09 INFO - Running setup.py install for manifestparser 07:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:09 INFO - Running setup.py install for mozcrash 07:14:09 INFO - Running setup.py install for mozdebug 07:14:09 INFO - Running setup.py install for mozdevice 07:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:09 INFO - Running setup.py install for mozfile 07:14:09 INFO - Running setup.py install for mozhttpd 07:14:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Running setup.py install for mozinfo 07:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Running setup.py install for mozInstall 07:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Running setup.py install for mozleak 07:14:10 INFO - Running setup.py install for mozlog 07:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Running setup.py install for moznetwork 07:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:10 INFO - Running setup.py install for mozprocess 07:14:10 INFO - Running setup.py install for mozprofile 07:14:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:11 INFO - Running setup.py install for mozrunner 07:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:11 INFO - Running setup.py install for mozscreenshot 07:14:11 INFO - Running setup.py install for moztest 07:14:11 INFO - Running setup.py install for mozversion 07:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:11 INFO - Cleaning up... 07:14:11 INFO - Return code: 0 07:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:11 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14:11 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 07:14:11 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 07:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:11 INFO - 'HOME': '/Users/cltbld', 07:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:11 INFO - 'LOGNAME': 'cltbld', 07:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:11 INFO - 'MOZ_NO_REMOTE': '1', 07:14:11 INFO - 'NO_EM_RESTART': '1', 07:14:11 INFO - 'PAGER': '/bin/cat', 07:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:11 INFO - 'PWD': '/builds/slave/test', 07:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:11 INFO - 'SHELL': '/bin/bash', 07:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:11 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:11 INFO - 'USER': 'cltbld', 07:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:11 INFO - 'XPC_FLAGS': '0x0', 07:14:11 INFO - 'XPC_SERVICE_NAME': '0', 07:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-tqBBec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lAiZD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-J2bttp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-f3p4Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZSqcqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bgLLB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-rFwRGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VhW6Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pEj8nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:12 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)) 07:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-skssRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cUBdFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1LEVAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-x9CLDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-0WJM4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bEl2T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-s14q4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:13 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)) 07:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:13 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-nP68Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:13 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)) 07:14:13 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)) 07:14:13 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)) 07:14:13 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)) 07:14:13 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)) 07:14:13 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)) 07:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:16 INFO - Downloading blessings-1.6.tar.gz 07:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:16 INFO - Installing collected packages: blessings 07:14:16 INFO - Running setup.py install for blessings 07:14:16 INFO - Successfully installed blessings 07:14:16 INFO - Cleaning up... 07:14:16 INFO - Return code: 0 07:14:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:16 INFO - Reading from file tmpfile_stdout 07:14:16 INFO - Current package versions: 07:14:16 INFO - blessings == 1.6 07:14:16 INFO - blobuploader == 1.2.4 07:14:16 INFO - docopt == 0.6.1 07:14:16 INFO - manifestparser == 1.1 07:14:16 INFO - mozInstall == 1.12 07:14:16 INFO - mozcrash == 0.17 07:14:16 INFO - mozdebug == 0.1 07:14:16 INFO - mozdevice == 0.48 07:14:16 INFO - mozfile == 1.2 07:14:16 INFO - mozhttpd == 0.7 07:14:16 INFO - mozinfo == 0.9 07:14:16 INFO - mozleak == 0.1 07:14:16 INFO - mozlog == 3.1 07:14:16 INFO - moznetwork == 0.27 07:14:16 INFO - mozprocess == 0.22 07:14:16 INFO - mozprofile == 0.28 07:14:16 INFO - mozrunner == 6.11 07:14:16 INFO - mozscreenshot == 0.1 07:14:16 INFO - mozsystemmonitor == 0.0 07:14:16 INFO - moztest == 0.7 07:14:16 INFO - mozversion == 1.4 07:14:16 INFO - psutil == 3.1.1 07:14:16 INFO - requests == 1.2.3 07:14:16 INFO - wsgiref == 0.1.2 07:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14:16 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 07:14:16 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 07:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:16 INFO - 'HOME': '/Users/cltbld', 07:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:16 INFO - 'LOGNAME': 'cltbld', 07:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:16 INFO - 'MOZ_NO_REMOTE': '1', 07:14:16 INFO - 'NO_EM_RESTART': '1', 07:14:16 INFO - 'PAGER': '/bin/cat', 07:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:16 INFO - 'PWD': '/builds/slave/test', 07:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:16 INFO - 'SHELL': '/bin/bash', 07:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:16 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:16 INFO - 'USER': 'cltbld', 07:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:16 INFO - 'XPC_FLAGS': '0x0', 07:14:16 INFO - 'XPC_SERVICE_NAME': '0', 07:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 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)) 07:14:17 INFO - Cleaning up... 07:14:17 INFO - Return code: 0 07:14:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:17 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 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14:17 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 07:14:17 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 07:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:17 INFO - 'HOME': '/Users/cltbld', 07:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:17 INFO - 'LOGNAME': 'cltbld', 07:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:17 INFO - 'MOZ_NO_REMOTE': '1', 07:14:17 INFO - 'NO_EM_RESTART': '1', 07:14:17 INFO - 'PAGER': '/bin/cat', 07:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:17 INFO - 'PWD': '/builds/slave/test', 07:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:17 INFO - 'SHELL': '/bin/bash', 07:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:17 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:17 INFO - 'USER': 'cltbld', 07:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:17 INFO - 'XPC_FLAGS': '0x0', 07:14:17 INFO - 'XPC_SERVICE_NAME': '0', 07:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 INFO - Downloading/unpacking jsonschema 07:14:17 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 07:14:17 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 07:14:17 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 07:14:17 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 07:14:17 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 07:14:17 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 07:14:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:20 INFO - warning: no files found matching '*.txt' 07:14:20 INFO - no previously-included directories found matching 'build' 07:14:20 INFO - no previously-included directories found matching 'dist' 07:14:20 INFO - no previously-included directories found matching '.git*' 07:14:20 INFO - Installing collected packages: jsonschema, functools32 07:14:20 INFO - Running setup.py install for functools32 07:14:20 INFO - warning: no files found matching '*.txt' 07:14:20 INFO - no previously-included directories found matching 'build' 07:14:20 INFO - no previously-included directories found matching 'dist' 07:14:20 INFO - no previously-included directories found matching '.git*' 07:14:20 INFO - Successfully installed jsonschema functools32 07:14:20 INFO - Cleaning up... 07:14:20 INFO - Return code: 0 07:14:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10924da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10925d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9040574f20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, '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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 07:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:20 INFO - 'HOME': '/Users/cltbld', 07:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:20 INFO - 'LOGNAME': 'cltbld', 07:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:20 INFO - 'MOZ_NO_REMOTE': '1', 07:14:20 INFO - 'NO_EM_RESTART': '1', 07:14:20 INFO - 'PAGER': '/bin/cat', 07:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:20 INFO - 'PWD': '/builds/slave/test', 07:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:20 INFO - 'SHELL': '/bin/bash', 07:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:20 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:20 INFO - 'USER': 'cltbld', 07:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:20 INFO - 'XPC_FLAGS': '0x0', 07:14:20 INFO - 'XPC_SERVICE_NAME': '0', 07:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:20 INFO - Downloading/unpacking flake8 07:14:20 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 07:14:20 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 07:14:20 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 07:14:20 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 07:14:20 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 07:14:20 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 07:14:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:24 INFO - no previously-included directories found matching 'docs/_build' 07:14:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:24 INFO - Running setup.py install for pep8 07:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:24 INFO - no previously-included directories found matching 'docs/_build' 07:14:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:24 INFO - Cleaning up... 07:14:24 INFO - Return code: 0 07:14:24 INFO - Running post-action listener: _resource_record_post_action 07:14:24 INFO - Running post-action listener: _start_resource_monitoring 07:14:24 INFO - Starting resource monitoring. 07:14:24 INFO - ##### 07:14:24 INFO - ##### Running install step. 07:14:24 INFO - ##### 07:14:24 INFO - Running pre-action listener: _resource_record_pre_action 07:14:24 INFO - Running main action method: install 07:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:25 INFO - Reading from file tmpfile_stdout 07:14:25 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:25 INFO - Reading from file tmpfile_stdout 07:14:25 INFO - Output received: 07:14:25 INFO - Usage: mozinstall [options] installer 07:14:25 INFO - Options: 07:14:25 INFO - -h, --help show this help message and exit 07:14:25 INFO - -d DEST, --destination=DEST 07:14:25 INFO - Directory to install application into. [default: 07:14:25 INFO - "/builds/slave/test"] 07:14:25 INFO - --app=APP Application being installed. [default: firefox] 07:14:25 INFO - mkdir: /builds/slave/test/build/application 07:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:14:58 INFO - Reading from file tmpfile_stdout 07:14:58 INFO - Output received: 07:14:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:14:58 INFO - Running post-action listener: _resource_record_post_action 07:14:58 INFO - ##### 07:14:58 INFO - ##### Running run-tests step. 07:14:58 INFO - ##### 07:14:58 INFO - Running pre-action listener: _resource_record_pre_action 07:14:58 INFO - Running main action method: run_tests 07:14:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:14:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:14:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:14:58 INFO - 2016-04-18 07:14:58.176 screenresolution[1645:7968] starting screenresolution argv=screenresolution get 07:14:58 INFO - 2016-04-18 07:14:58.179 screenresolution[1645:7968] Display 0: 1600x1200x32@60 07:14:58 INFO - 2016-04-18 07:14:58.185 screenresolution[1646:7970] starting screenresolution argv=screenresolution list 07:14:58 INFO - Available Modes on Display 0 07:14:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:14:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:14:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:14:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:14:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:14:58 INFO - Intel Iris: 07:14:58 INFO - Chipset Model: Intel Iris 07:14:58 INFO - Type: GPU 07:14:58 INFO - Bus: Built-In 07:14:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:14:58 INFO - Vendor: Intel (0x8086) 07:14:58 INFO - Device ID: 0x0a2e 07:14:58 INFO - Revision ID: 0x0009 07:14:58 INFO - Displays: 07:14:58 INFO - Display: 07:14:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:14:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:14:58 INFO - Display Serial Number: 1600x1200 60 07:14:58 INFO - Main Display: Yes 07:14:58 INFO - Mirror: Off 07:14:58 INFO - Online: Yes 07:14:58 INFO - Rotation: Supported 07:14:58 INFO - Return code: 0 07:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:58 INFO - Python 2.7.3 07:14:58 INFO - Return code: 0 07:14:58 INFO - grabbing minidump binary from tooltool 07:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:58 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 0x1090ece00>, '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 0x108f15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:58 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 07:14:58 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 07:14:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:58 INFO - Return code: 0 07:14:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:14:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:14:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:14:59 INFO - Return code: 0 07:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wjV2gQGCs3/Render', 07:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:59 INFO - 'HOME': '/Users/cltbld', 07:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:59 INFO - 'LOGNAME': 'cltbld', 07:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:59 INFO - 'MOZ_NO_REMOTE': '1', 07:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:59 INFO - 'NO_EM_RESTART': '1', 07:14:59 INFO - 'PAGER': '/bin/cat', 07:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:59 INFO - 'PWD': '/builds/slave/test', 07:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:59 INFO - 'SHELL': '/bin/bash', 07:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXQSTKZM2X/Listeners', 07:14:59 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 07:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:59 INFO - 'USER': 'cltbld', 07:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:59 INFO - 'XPC_FLAGS': '0x0', 07:14:59 INFO - 'XPC_SERVICE_NAME': '0', 07:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:14:59 INFO - mozversion application_buildid: 20160418054123 07:14:59 INFO - mozversion application_changeset: 6066850740cd4711ee5502fda89f422440b7c2cc 07:14:59 INFO - mozversion application_display_name: Nightly 07:14:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:59 INFO - mozversion application_name: Firefox 07:14:59 INFO - mozversion application_remotingname: firefox 07:14:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:14:59 INFO - mozversion application_vendor: Mozilla 07:14:59 INFO - mozversion application_version: 48.0a1 07:14:59 INFO - mozversion platform_buildid: 20160418054123 07:14:59 INFO - mozversion platform_changeset: 6066850740cd4711ee5502fda89f422440b7c2cc 07:14:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:14:59 INFO - mozversion platform_version: 48.0a1 07:14:59 INFO - using testdate: 1460988899 07:14:59 INFO - actual date: 1460988899 07:14:59 INFO - starting webserver on 'localhost:49273' 07:14:59 INFO - SUITE-START | Running 2 tests 07:14:59 INFO - TEST-START | dromaeo_css 07:14:59 INFO - operating with platform_type : mac_ 07:14:59 INFO - Initialising browser for dromaeo_css test... 07:14:59 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpbPQLj3/profile http://localhost:49273/getInfo.html) 07:15:02 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 07:15:02 INFO - PROCESS | 1664 | colorDepth:24 07:15:02 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 07:15:02 INFO - PROCESS | 1664 | __metrics 07:15:02 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:02 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:02 INFO - TEST-INFO | 1664: exit 0 07:15:02 INFO - Browser initialized. 07:15:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:02 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpbPQLj3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:14 INFO - PROCESS | 1666 | RSS: Main: 237498368 07:15:14 INFO - PROCESS | 1666 | 07:16:06 INFO - PROCESS | 1666 | 1460988966244 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] 07:18:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 07:18:18 INFO - PROCESS | 1666 | RSS: Main: 354435072 07:18:18 INFO - PROCESS | 1666 | 07:21:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 07:21:21 INFO - PROCESS | 1666 | RSS: Main: 366686208 07:21:21 INFO - PROCESS | 1666 | 07:24:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 07:24:24 INFO - PROCESS | 1666 | RSS: Main: 370143232 07:24:24 INFO - PROCESS | 1666 | 07:27:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 07:27:26 INFO - PROCESS | 1666 | RSS: Main: 369901568 07:27:26 INFO - PROCESS | 1666 | 07:30:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 07:30:30 INFO - PROCESS | 1666 | RSS: Main: 334147584 07:30:30 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 07:33:33 INFO - PROCESS | 1666 | RSS: Main: 396595200 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | __start_tp_report 07:33:33 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:33:33 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:33:33 INFO - PROCESS | 1666 | |i|pagename|runs| 07:33:33 INFO - PROCESS | 1666 | |0;dojo.html;3306.884259050932;3319.7676162668613;3348.3303339332138;3382.171368014837;3392.7964322140656;5536.833894983147;5616.045272303708;5621.747021384037;5630.77476900924;5642.210090587316;5662.348829884564;5678.205051292823;5786.247787787593;5817;5844.766209351632;4176.937345939798;5079.466656001122;5126.615503837208;5142.3829140503;5220.92168617471;5225.63420560559;5248.6063545234065;5263.815766448175;5265.394479634852;5301.814436494724;4432.977835110836;5093.872653183663;5148.459411761749;5153.948460515385;5170.1986192140275;5156.432792392834;5160.870978225536;5164.251183578398;5173.405058418292;5209.192575150858;5088.516590923893;5116.437191908887;5138.152204886189;5162.6128040397125;5211.609129315317;5510.393856675762;5625.71871406428;5639.548836093103;5643.492085712305;5662.943370566283;6141.60874974391;6211.782587609412;6228.87542249157;6246.593971391891;6257.18656574647;6242.937570624281;6245.937540624581;6257.217847769029;6285.560010799246;6289.40250676185;5481.534069604048;5616.438356164351;5768.278965129359;5773.336066352381;5780.046292361797;6214.906776398358;6327.746890124436;6330.082138090043;6335.334789847092;6338.049292606146;6105.389461053859;6108.480779133734;6126.9387306127255;6135.754569817246;6139.662318572521;6003.699815009232;6077.544184186204;6192.8761424771255;6203.131561581382;6245.843853903689;6096.042928203419;6143.662098584531;6207.875842483125;6213.316535181127;6234.438900498977;6226.59527130735;6237.376262373727;6245.375462453719;6265.310815810257;6269.46709529686;4769.499202583748;4856.927146092811;4937.975310123426;4949.158643030693;4996.475370086088;4392.934105988413;4436.0906014267;4441.689701538054;4520.367148599199;4566.817327306937;5644.85887852807;5681.57388195887;5691.3170419549915;5694.288213973254;5742.08126699726;6064.696765161812;6150.015997440388;6206.100115483229;6273.435390814849;6309.116723658692;5592.356878958891;5658.660480371191;5672.716364181774;5679.517241034476;5694.772209111672;3795.962040379616;5351.919721204185;5382.085045542267;5383.353997520323;5427.755750991136;6198;6224.595401299082;6318;6323.968380158161;6324.810255692245;6264.749410023548;6270.561060725888;6291.842703932438;6293.150424692608;6303;6283.434490895658;6301.4328710416285;6303;6312.936870631235;6329.5252856036905;5971.611845230046;6059.394060593905;6124.938750612615;6193.535484838745;6196.225471816023;6262.3111457738705;6278.905816412849;6285.308616052322;6303.275123360872;6310.116583678197;6124.693765311627;6137.140800288053;6142.938570614416;6149.877002460015;6155.47678447337;5916.053431450947;6014.548908831767;6043.123747056564;6123.295820980644;6149.139120523219;4727.692699974491;5937.732802024006;5962.403759624176;5971.28344598651;6018.488428483628;6037.45662890342;6042.879142417215;6087.8782424350375;6110.483995285942;6116.5412594056515;5771.826845194651;5875.265591801025;5934.228550288608;5944.8811023780145;6026.969865150646 07:33:33 INFO - PROCESS | 1666 | |1;ext.html;506.39738710933983;538.120173516301;553.3952233742277;584.7748616782537;661.8543920337527;26604.600930986027;37135.81432092839;37949.43075853864;37958;38075.42886856696;33360;40453.38186472545;41263;41278;41338.17323653525;8385.245327920486;9453.24374050076;9694.515274236295;9695.36980096295;11236.325820450798;11453.308472508954;11633.825492617618;11658.825117623242;11668.124890633195;11669;11528.308301501895;11647.359395233301;11650.650480485556;11655.475503602316;11660.41697915105;8399.496030238175;8780.780480487974;8795.384323097385;11416.600418985296;11572.942135289311;11321.943390282995;11507.654770356903;11514.654560363202;11521.827172592419;11525.596604118815;30033.249168770737;37976.43035354472;38032.04919876998;38041.619583804364;38085.0478738031;3228.1606782236554;3358.6641335866216;3422.709069729076;3461.2212252243044;3573.749837511375;27184.59223111655;28239.294017649518;28536;29246.561301580492;29293.85353073221;2726.8500232487204;2748.958765618517;2762.875670594828;2774.2925553983805;2829.122971878724;471272;472041.99999999657;472260;472867.99999999657;473307;58131.41868581345;58199;58545.70727146337;58715.532111696695;58778.11832822511;62167.75664486775;63979.680101599195;65483.345166547726;65559.67220163964;65700.34299657038;16066.196690165445;16257.756133658004;16257.837421625632;16271.430499932445;16280.511584652479;11486.0811135109;11790.23363481371;12565;12879.484820607071;12894.161879477804;18488.815111848708;18522.907385462986;18585.90707046456;18636.627267454576;18637;7634.160242373335;7776.377889768805;7783.33841623457;7854.921450785533;7873.661477548831;949.126803340928;981.6956743409565;995.5967833027636;1013.2957594471771;1026.3277553202515;28849.711502885122;29294.658408651645;29360.706392935797;29580.55629165564;29772.702272976992;1059.4120263253967;1092.7869065532304;1110.5169251375678;1149.643610480737;1231.6475531734345;13947.302634868216;14974.951753377376;15073.849261507245;15286.770698439532;15328.693426131638;602179;607085;608851;609767;610341;57403;58350.124748128816;58441.707791461624;58441.83116337735;58551;1318.8878945289757;1442.7114577084626;1482.5181815909873;1490.3591455674164;1492.156931333793;28838;29175.416491670472;29210.707892921648;29775.255618609706;29966.550501742928;46056;46101.76949115233;46581;46609.067818644115;46644.53355466402;285977;346878;347581;348775;348933;23111.884440578364;25363.985440582906;25877.870610646827;26027.73972260253;26383.736162638128;41550;41616.79191604022;41927.790361048;41985.370219447344;42373;27661.861690691418;34974.82512587421;34998.12504687403;35306.76426325066;35514.93455196348;35418.46872296866;35570.46644300389;35643.82178089093;36107.81946090358;36178.8191059043;34677.50763810838;34707.652923471454;35410.291794164485;35432;35971.82014089913;30755.384892302478;31768;31839.522407164375;31844.68155318417;31848.36303273968;23531.52936941286;23617.29148125559;23809;23977.880110599337;24147.758522415254 07:33:33 INFO - PROCESS | 1666 | |2;jquery.html;392.11382276056116;393.83065281928776;401.63651895035;403.10309561226296;410.1264307026036;13519;18969.33607323744;19568.608627827434;19663.70504442433;19668.409947701573;15614.453494127707;16361.672766544661;19335.516612084706;19983.800161998377;20092.497687557818;5894.58737888348;6075.544334174932;6099.146119543268;6106.3893610639025;6117.4188452097205;5773.971130144364;5892.204552385438;5943.167956486095;5996.760129594811;6046.455818976291;4122.587741225869;4378.956210437903;6223.408776166257;6542.182227221598;6549.410553050225;6220.813375598739;6505;6524.217093948733;6537.673116344187;6564.081028655992;5697.202391665171;5720.971395143039;5721.71391430431;5729.1119876419225;5752.424757524256;24009;24214.152504662252;24727.752722472724;25443.491130177477;25475.61786573203;2014.4963759060236;2156.54712510373;2179.357089658539;2241.7085778848646;2259.7175353080866;14542;14689.045212061288;14712;14814.555563333117;15773.921130394388;1617.44198251603;1653.2890856931515;1748.2744660965684;1770.3892157205744;1835.5135888989428;108577;114329;117006;122326;128312.35843820815;16062.678746425006;19766.50583735418;20351.982400879897;20598.661087029293;20654;34872.65127348694;34987.65012349844;35024.824875875456;35062.12344691352;35082.64917350845;8468.661253549912;10591.682249532372;10661.413622250851;10689.144868410509;10699.090577300862;7218;8789.912100879037;8805.559722013873;8811.69159079442;8923.643054277885;9293.163615274523;9334.766630834147;9427.670031548863;9439.858402123973;9449.196818270386;2440.6461063145744;3609.314230296235;3727.7204209684382;3778.6032466591164;3784.3188226119014;776.9650365733555;898.8696638987441;944.2163004706077;946.6402766948653;981.8232718110665;19196.520086997938;19464.513387165152;19598.902005490167;20203;20330.390088297376;813.6541969662869;935.387321304533;970.3935040599625;983.2429029647132;989.8069876374182;10298;10611.045005949502;10613.363198208132;10628.937106289464;10639.574417023387;565260;603339;605494;606630;622075;126779;127530;128134;128458;129099;1011.191047162282;1024.538957469142;1034.2605037398296;1041.7447725307347;1042.1402343067;17626.647467050843;17826.91086544559;17830.5542361442;17915.19381627804;18116.27534898642;50469.74765126151;51049;51091.744541277054;52258.47741522536;52469.47530524646;67895.64208715699;71051.64474177803;76129.61935190289;76451;78871.01766156599;7764.378849692124;7852.214778522102;7890.210978902064;7992.560409177551;8096.097417106857;10527.842082368617;12139.635810925687;12433.93783031079;12472.5010999559;12509.248705181464;9615.615375385187;10063.949680251551;10411.531481083219;10917.945410272898;10923.180761442765;8968.372213945222;10456.63401780934;10662.413567253565;10713.464326783474;10978.780424391627;10665.36007839532;10715;10913.126949843834;11070.059044981266;11121.721956950818;7779.611019448892;8031.759047228593;8043.758687239392;8136.267735903797;8223.21879421454;9386.765330866783;10713.892861071601;10744.193237871561;10786.892131078588;10895.96488333607 07:33:33 INFO - PROCESS | 1666 | |3;mootools.html;1380.7100508893132;1564.5775640577044;1584.841515848415;1815.809340019298;1955.8141976512236;7746.302832745052;7865.331446827026;8096.838063238746;8146.470479418848;8165.469244499103;7810.3751699864015;8020.719274825382;8047.597620118985;8054.7180848670305;8059.476134051297;2335.1943579465055;2375.4417711837705;2375.9643605345846;2376.8573885566834;2377.6909001829736;2344.5779759643256;2353.870537120458;2382.9046838126455;2383.7020372453444;2394.976050239493;2339.2689409836767;2354.4349356154485;2371.2886134159685;2374.430136767172;2375.70303712036;2313.6066868632206;2345;2350.6591544226076;2352.0121548949396;2356.8821558921986;2303.5968705476475;2325.2442956039354;2339.0409931927998;2341.4263505441277;2344.788968992782;7934.682612695486;8059.879101813477;8102.39232057598;8114.715984940558;8435.873461898076;5061.569766569846;5216.426193118754;5233.476652334774;5241.449647786965;5302.734863256822;3297.406466835969;3298.917527061819;3374.6119196292493;3393.0838673558;3397.69420752131;997.4962643864874;1003.4531180506568;1025.912797412221;1030.6701855406272;1033.7260625934134;11311.660650180507;11441.141914356456;11460.94269528647;11476.598319058876;11488.965993060665;4405.933910991338;4408.911821763547;4505.098980203972;4531.660125490602;4565.680402371802;8951.239144672645;8957.641694332153;8978.685745998859;8979.775505612412;8981.326400519987;5167.896642067213;5169.991851588904;5171.3277273954145;5172.146595811649;5201.713905735145;4185.455890734185;4312.805923733439;4505.932411013838;4778.593819525309;4851.393575803025;3580.7314451416246;3659.249853779969;3707.1844194277755;3741.4761933329355;3748.737588368788;1163.2555164694602;1185.1822242652543;1187.0800129899396;1192.2905871006737;1193.838831757719;815.4984684419159;884.2307192742227;917.4862077236769;936.8220038192721;942.3733217410345;5656.773729050874;5724.026915424388;5727.8854422912145;5763.394843541368;5851.89331840537;438.37312642920926;444.5798720209371;453.98760763497586;458.8669285907116;461.2734942465563;3728.0493474164455;3749.343864823645;3753.9061523462133;3812.104155523505;3822.6559609635265;10147.644832430977;10550;10557.419341936115;10657.84013239802;10665.946670266754;10612.469376531142;10615.628453004108;10618.575256989634;10621.5220315086;10631;7862.371010319275;8068.22499050208;8088.757337279891;8179.836403271901;8193.71322003727;5579.525740312119;5628;5667;5739.512141468022;5799.884002320015;9531.809363812823;9626;9863.654772082942;9962.402255864672;9982.500874956368;9820.067093626094;10041.096301332915;10223.846642300521;10235.539400727133;10267.84598231042;6334.398232167937;6596.60420374779;6712.2616512184595;6989.755358562629;7042.753503627348;8219.917800821915;8236.258736713724;8300.584970751317;8306.335493160412;8309.750707478785;7062.682179302046;7201.819954501179;7389.076365454318;7450.217727138573;7511.699532018658;7101.11236095488;7127.8574428512175;7235.746748863765;7278.308560686726;7335.339819416278;6693.732250709917;6724.193096828412;6742.7977160683295;6762.594244345355;6765.492588056014;4651.3720647712125;4685.812567497398;4779.856604301876;4844.563989240985;4961.82633607822;4812.470628230822;4817.084753896748;4878;4937.506249375034;5090.338256026693 07:33:33 INFO - PROCESS | 1666 | |4;prototype.html;313.50622769138613;321.6847489460329;324.45167666643357;324.9203945033467;331.07464636341433;5539.9169012464845;5812.651240925542;5972.223610930584;6115.908261376083;6139.72371243294;6027.789027384042;6041.335453100155;6054.152418661391;6063.848403789896;6086.239220097488;4163.854939891524;4247.532771395144;4307.784610769465;4467.82128714851;4469.173202957463;3711.4618380334837;3912.765234085964;4508.594226519613;4541.2733962566;4546.295324224734;4438.7114837535455;4469.575390337929;4506.324051392301;4510.413646225986;4515.193922431037;4286.935695964532;4379.64962802975;4517.119161763458;4548.295014272793;4560.840370587013;3644.653757892996;3731.7201209909367;3919.392494163381;3951.3480275754755;3961.7022127166174;5135;5775;5830.3586605473365;5895.675737834417;5910;4678.976605116953;5204.68771873685;5281.762320695578;5287.735613219362;5298.708571028592;5887.264091988502;6366.331535188831;6381.361863813628;6416.935830641681;6445.548811583191;3679.8344074516444;4159.896002599929;4360.5203427623255;4381.715188512769;4389.934150987738;6457.903131453032;6647.966760166217;6727.990801379783;6741.853884839589;6765.695543700496;4024.0342317843506;4085.2442298174933;4433.049458238364;4452.376667266585;4460.197164510354;4026.5570787213383;4154.584541545822;4534.13851368239;4544.431946006749;4557.817687292538;5084.618653600921;5238.580913526908;5266.3943646480375;5266.973665131726;5290.508264545459;5401.864953376197;6453.806045881527;6463.741450342028;6470.805875823733;6501.772437964649;1420.6078043517412;1538.699798670122;1564.6401327694693;1567.7099736548546;1577.7317855964513;914.7575892388522;918.9891119768201;947.758436448255;998.9200863930868;1065.984010239847;5887.941120588825;5963.850903727354;5993.011153159679;5998.430149135912;6036.63780173191;6317.526185536011;6545.967270163619;6655.600663960178;6682.799516014527;6706.195256569243;4999.575036121898;5947.434993675594;5974.790882319098;5977.880442391128;5989.221401217814;3364.3271345730464;3463.3939060664284;3510.069831494656;3530.2409981854025;3533.851498263075;5721.8569535761935;6820.488463365267;6895.172579290517;6903.585784852925;6910.170779506391;5844.824655260349;6541.934580654228;6645.966770166118;6725;6856.451483881277;5837.861616984647;6435.806925792233;7005.894911576433;7008.964955175192;7034.366906978396;6377.681115944277;6441;6464.806055818333;6756.628385438848;6760.966195168992;5301.4168441472175;6630.53586248958;6652.268250492345;6660.300668429745;6685.465162786868;5701.458361455655;6611.702473388613;6636.701348439428;6732.528722989539;7032.327715468089;4287.6998610097;4298.355246712893;4346.500152482505;4350.564943505624;4350.891227719332;6540.934590654033;6678.766243181465;6746.628935408599;6747.932520674927;6753.864922701617;6107.725152368065;6497.740090396331;6504.317046710216;6509.641969691523;6526.804195874131;6163.260408750979;6473.255575608865;6480.287168411565;6514.73941042353;6530.771423000172;5950.642961422329;6372.968135159294;6378.202724659418;6402.167718196604;6466.935330646634;5171.974140129275;6498.285188629153;6509.544331896911;6522.445592124533;6527.759725652111;5014.498550144956;6057.42454466825;6305.180326557518;6364.840878978062;6438.323975982642 07:33:33 INFO - PROCESS | 1666 | |5;yui.html;666.183924692252;672.1900110367009;718.5688586847892;745.2733584754861;748.3675799651024;11733.589324373637;13848.30758462078;14184.57446276612;14206.147631142112;14226.288685565707;13076.738465230714;13683.863161368383;13686.863131368684;13695.246761428118;13863;950.3917492804611;951.8096380723848;959.1032384720274;959.8464245720686;963.0562049191797;927.8654595083709;932.7341707613332;933.7478880702206;934.7429456899339;935.3312381647121;989.0554520432969;990.8266053440655;991.2516050381987;991.3060857399813;992.9900700993006;980.8577756225343;985.6402413119232;986.8223719730446;987.3582171588453;989.1690979577154;736.4439847914844;737.4579683932305;738.8337624034602;738.9926100738977;740.9814754631124;14183.574492765234;14493.855061449356;14539.854601453955;14548.1998490083;14550.199739014455;12402.503899843996;12515.624531264077;12523.686907827287;12606.054545909003;13453.461861525528;8242.423030387876;9780.266480014028;9953.30326877119;10000.199984001263;10295.021972912562;3495.930081398383;3650.6349365063547;3688.3360995020885;3691.630836916314;3696.8706095286807;57523.71238143783;75456.62271688662;75547.62226188889;75570;82464.58767706124;9304.95347523258;9322.813543729224;9490.572924218426;9550.37922535033;9587.18508926735;19459.22163113488;20210.59578808445;20381.490462738253;20419.4895127623;20473.385798426072;7312.561246325237;7481.625918704043;7484.775456736306;7503.062117235346;7603.885941710879;3807.7144214184045;3841.3661745812187;3860.1121741999495;3895.6493915547735;3977.54258260298;3567.964320356763;3677.595464498903;3680.2087551176623;3682.2635472905527;3683.3922402803237;548.528265691505;660.4320284555279;662.192125606759;663.3134705579702;680.8536164724509;503.3858692395345;508.9262057001714;549.5411331538211;566.0603398358704;632.193952710298;7493.100827900578;7507.1742108368035;7577.16651168371;7588.468807183554;7852.293293603603;536.2117687000103;554.9805756798493;564.266453610305;588.8252935393916;594.8691287916652;3634.327649384872;3653.707703383723;3668.8899333020054;3695.5565332159777;3888.7861167635488;92470;93092.53453732688;96275;96568;96729;58386.70806646025;69991.65004174947;70188.64905675541;70538.58922821618;71217.64391178114;68919.65540172368;70614.64692676504;71139;72026;72236.63881680663;7799.220077992155;7844.4116691247245;7971.92028079735;8055.436119471581;8073.515589064675;29417.705822941498;42155;42804.92987675333;43102;43504;61670;65436;65476.34523654702;66062.34844128936;66224;9026.413283136575;10535.104516116216;10779.784404312026;10913.39976301311;11068.28056176346;11311.773764524827;11406.828897566376;11769.176157669224;11879.821802672794;12543.49826006986;10990.120790336594;11194.832077519006;11238.269512481662;11255.437228138724;11611.941940290244;9359.251259899056;10848.728781780519;10962.397068161008;11075.280106793032;11399.06187535235;10766.676999690022;10970.341779493256;11230.887691122984;11456.94271528637;11518.654440366803;8987.236084932592;9074;9096.636134554808;9301.953570214542;9519.476428796483;7282.781516554512;8502.362322825937;9331.16019558243;9333.346665733334;9379.108984646447 07:33:33 INFO - PROCESS | 1666 | __end_tp_report 07:33:33 INFO - PROCESS | 1666 | __start_cc_report 07:33:33 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1102 07:33:33 INFO - PROCESS | 1666 | __end_cc_report 07:33:33 INFO - PROCESS | 1666 | __startTimestamp1460990013328__endTimestamp 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:33:33 INFO - PROCESS | 1666 | Number of tests: 6 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5702.84 Median:5962.40 stddev:677.94 (11.4%) stddev-sans-first:653.44 07:33:33 INFO - PROCESS | 1666 | Values: 3306.9 3319.8 3348.3 3382.2 3392.8 5536.8 5616.0 5621.7 5630.8 5642.2 5662.3 5678.2 5786.2 5817.0 5844.8 4176.9 5079.5 5126.6 5142.4 5220.9 5225.6 5248.6 5263.8 5265.4 5301.8 4433.0 5093.9 5148.5 5153.9 5170.2 5156.4 5160.9 5164.3 5173.4 5209.2 5088.5 5116.4 5138.2 5162.6 5211.6 5510.4 5625.7 5639.5 5643.5 5662.9 6141.6 6211.8 6228.9 6246.6 6257.2 6242.9 6245.9 6257.2 6285.6 6289.4 5481.5 5616.4 5768.3 5773.3 5780.0 6214.9 6327.7 6330.1 6335.3 6338.0 6105.4 6108.5 6126.9 6135.8 6139.7 6003.7 6077.5 6192.9 6203.1 6245.8 6096.0 6143.7 6207.9 6213.3 6234.4 6226.6 6237.4 6245.4 6265.3 6269.5 4769.5 4856.9 4938.0 4949.2 4996.5 4392.9 4436.1 4441.7 4520.4 4566.8 5644.9 5681.6 5691.3 5694.3 5742.1 6064.7 6150.0 6206.1 6273.4 6309.1 5592.4 5658.7 5672.7 5679.5 5694.8 3796.0 5351.9 5382.1 5383.4 5427.8 6198.0 6224.6 6318.0 6324.0 6324.8 6264.7 6270.6 6291.8 6293.2 6303.0 6283.4 6301.4 6303.0 6312.9 6329.5 5971.6 6059.4 6124.9 6193.5 6196.2 6262.3 6278.9 6285.3 6303.3 6310.1 6124.7 6137.1 6142.9 6149.9 6155.5 5916.1 6014.5 6043.1 6123.3 6149.1 4727.7 5937.7 5962.4 5971.3 6018.5 6037.5 6042.9 6087.9 6110.5 6116.5 5771.8 5875.3 5934.2 5944.9 6027.0 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:61217.59 Median:18359.33 stddev:129445.64 (705.1%) stddev-sans-first:129728.51 07:33:33 INFO - PROCESS | 1666 | Values: 506.4 538.1 553.4 584.8 661.9 26604.6 37135.8 37949.4 37958.0 38075.4 33360.0 40453.4 41263.0 41278.0 41338.2 8385.2 9453.2 9694.5 9695.4 11236.3 11453.3 11633.8 11658.8 11668.1 11669.0 11528.3 11647.4 11650.7 11655.5 11660.4 8399.5 8780.8 8795.4 11416.6 11572.9 11321.9 11507.7 11514.7 11521.8 11525.6 30033.2 37976.4 38032.0 38041.6 38085.0 3228.2 3358.7 3422.7 3461.2 3573.7 27184.6 28239.3 28536.0 29246.6 29293.9 2726.9 2749.0 2762.9 2774.3 2829.1 471272.0 472042.0 472260.0 472868.0 473307.0 58131.4 58199.0 58545.7 58715.5 58778.1 62167.8 63979.7 65483.3 65559.7 65700.3 16066.2 16257.8 16257.8 16271.4 16280.5 11486.1 11790.2 12565.0 12879.5 12894.2 18488.8 18522.9 18585.9 18636.6 18637.0 7634.2 7776.4 7783.3 7854.9 7873.7 949.1 981.7 995.6 1013.3 1026.3 28849.7 29294.7 29360.7 29580.6 29772.7 1059.4 1092.8 1110.5 1149.6 1231.6 13947.3 14975.0 15073.8 15286.8 15328.7 602179.0 607085.0 608851.0 609767.0 610341.0 57403.0 58350.1 58441.7 58441.8 58551.0 1318.9 1442.7 1482.5 1490.4 1492.2 28838.0 29175.4 29210.7 29775.3 29966.6 46056.0 46101.8 46581.0 46609.1 46644.5 285977.0 346878.0 347581.0 348775.0 348933.0 23111.9 25364.0 25877.9 26027.7 26383.7 41550.0 41616.8 41927.8 41985.4 42373.0 27661.9 34974.8 34998.1 35306.8 35514.9 35418.5 35570.5 35643.8 36107.8 36178.8 34677.5 34707.7 35410.3 35432.0 35971.8 30755.4 31768.0 31839.5 31844.7 31848.4 23531.5 23617.3 23809.0 23977.9 24147.8 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35826.65 Median:25459.55 stddev:100067.34 (393.0%) stddev-sans-first:100312.68 07:33:33 INFO - PROCESS | 1666 | Values: 392.1 393.8 401.6 403.1 410.1 13519.0 18969.3 19568.6 19663.7 19668.4 15614.5 16361.7 19335.5 19983.8 20092.5 5894.6 6075.5 6099.1 6106.4 6117.4 5774.0 5892.2 5943.2 5996.8 6046.5 4122.6 4379.0 6223.4 6542.2 6549.4 6220.8 6505.0 6524.2 6537.7 6564.1 5697.2 5721.0 5721.7 5729.1 5752.4 24009.0 24214.2 24727.8 25443.5 25475.6 2014.5 2156.5 2179.4 2241.7 2259.7 14542.0 14689.0 14712.0 14814.6 15773.9 1617.4 1653.3 1748.3 1770.4 1835.5 108577.0 114329.0 117006.0 122326.0 128312.4 16062.7 19766.5 20352.0 20598.7 20654.0 34872.7 34987.7 35024.8 35062.1 35082.6 8468.7 10591.7 10661.4 10689.1 10699.1 7218.0 8789.9 8805.6 8811.7 8923.6 9293.2 9334.8 9427.7 9439.9 9449.2 2440.6 3609.3 3727.7 3778.6 3784.3 777.0 898.9 944.2 946.6 981.8 19196.5 19464.5 19598.9 20203.0 20330.4 813.7 935.4 970.4 983.2 989.8 10298.0 10611.0 10613.4 10628.9 10639.6 565260.0 603339.0 605494.0 606630.0 622075.0 126779.0 127530.0 128134.0 128458.0 129099.0 1011.2 1024.5 1034.3 1041.7 1042.1 17626.6 17826.9 17830.6 17915.2 18116.3 50469.7 51049.0 51091.7 52258.5 52469.5 67895.6 71051.6 76129.6 76451.0 78871.0 7764.4 7852.2 7890.2 7992.6 8096.1 10527.8 12139.6 12433.9 12472.5 12509.2 9615.6 10063.9 10411.5 10917.9 10923.2 8968.4 10456.6 10662.4 10713.5 10978.8 10665.4 10715.0 10913.1 11070.1 11121.7 7779.6 8031.8 8043.8 8136.3 8223.2 9386.8 10713.9 10744.2 10786.9 10896.0 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5507.53 Median:4814.78 stddev:3106.57 (64.5%) stddev-sans-first:3099.81 07:33:33 INFO - PROCESS | 1666 | Values: 1380.7 1564.6 1584.8 1815.8 1955.8 7746.3 7865.3 8096.8 8146.5 8165.5 7810.4 8020.7 8047.6 8054.7 8059.5 2335.2 2375.4 2376.0 2376.9 2377.7 2344.6 2353.9 2382.9 2383.7 2395.0 2339.3 2354.4 2371.3 2374.4 2375.7 2313.6 2345.0 2350.7 2352.0 2356.9 2303.6 2325.2 2339.0 2341.4 2344.8 7934.7 8059.9 8102.4 8114.7 8435.9 5061.6 5216.4 5233.5 5241.4 5302.7 3297.4 3298.9 3374.6 3393.1 3397.7 997.5 1003.5 1025.9 1030.7 1033.7 11311.7 11441.1 11460.9 11476.6 11489.0 4405.9 4408.9 4505.1 4531.7 4565.7 8951.2 8957.6 8978.7 8979.8 8981.3 5167.9 5170.0 5171.3 5172.1 5201.7 4185.5 4312.8 4505.9 4778.6 4851.4 3580.7 3659.2 3707.2 3741.5 3748.7 1163.3 1185.2 1187.1 1192.3 1193.8 815.5 884.2 917.5 936.8 942.4 5656.8 5724.0 5727.9 5763.4 5851.9 438.4 444.6 454.0 458.9 461.3 3728.0 3749.3 3753.9 3812.1 3822.7 10147.6 10550.0 10557.4 10657.8 10665.9 10612.5 10615.6 10618.6 10621.5 10631.0 7862.4 8068.2 8088.8 8179.8 8193.7 5579.5 5628.0 5667.0 5739.5 5799.9 9531.8 9626.0 9863.7 9962.4 9982.5 9820.1 10041.1 10223.8 10235.5 10267.8 6334.4 6596.6 6712.3 6989.8 7042.8 8219.9 8236.3 8300.6 8306.3 8309.8 7062.7 7201.8 7389.1 7450.2 7511.7 7101.1 7127.9 7235.7 7278.3 7335.3 6693.7 6724.2 6742.8 6762.6 6765.5 4651.4 4685.8 4779.9 4844.6 4961.8 4812.5 4817.1 4878.0 4937.5 5090.3 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5220.71 Median:5957.25 stddev:1644.50 (27.6%) stddev-sans-first:1607.33 07:33:33 INFO - PROCESS | 1666 | Values: 313.5 321.7 324.5 324.9 331.1 5539.9 5812.7 5972.2 6115.9 6139.7 6027.8 6041.3 6054.2 6063.8 6086.2 4163.9 4247.5 4307.8 4467.8 4469.2 3711.5 3912.8 4508.6 4541.3 4546.3 4438.7 4469.6 4506.3 4510.4 4515.2 4286.9 4379.6 4517.1 4548.3 4560.8 3644.7 3731.7 3919.4 3951.3 3961.7 5135.0 5775.0 5830.4 5895.7 5910.0 4679.0 5204.7 5281.8 5287.7 5298.7 5887.3 6366.3 6381.4 6416.9 6445.5 3679.8 4159.9 4360.5 4381.7 4389.9 6457.9 6648.0 6728.0 6741.9 6765.7 4024.0 4085.2 4433.0 4452.4 4460.2 4026.6 4154.6 4534.1 4544.4 4557.8 5084.6 5238.6 5266.4 5267.0 5290.5 5401.9 6453.8 6463.7 6470.8 6501.8 1420.6 1538.7 1564.6 1567.7 1577.7 914.8 919.0 947.8 998.9 1066.0 5887.9 5963.9 5993.0 5998.4 6036.6 6317.5 6546.0 6655.6 6682.8 6706.2 4999.6 5947.4 5974.8 5977.9 5989.2 3364.3 3463.4 3510.1 3530.2 3533.9 5721.9 6820.5 6895.2 6903.6 6910.2 5844.8 6541.9 6646.0 6725.0 6856.5 5837.9 6435.8 7005.9 7009.0 7034.4 6377.7 6441.0 6464.8 6756.6 6761.0 5301.4 6630.5 6652.3 6660.3 6685.5 5701.5 6611.7 6636.7 6732.5 7032.3 4287.7 4298.4 4346.5 4350.6 4350.9 6540.9 6678.8 6746.6 6747.9 6753.9 6107.7 6497.7 6504.3 6509.6 6526.8 6163.3 6473.3 6480.3 6514.7 6530.8 5950.6 6373.0 6378.2 6402.2 6466.9 5172.0 6498.3 6509.5 6522.4 6527.8 5014.5 6057.4 6305.2 6364.8 6438.3 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17351.12 Median:33068.39 stddev:24538.52 (74.2%) stddev-sans-first:24575.37 07:33:33 INFO - PROCESS | 1666 | Values: 666.2 672.2 718.6 745.3 748.4 11733.6 13848.3 14184.6 14206.1 14226.3 13076.7 13683.9 13686.9 13695.2 13863.0 950.4 951.8 959.1 959.8 963.1 927.9 932.7 933.7 934.7 935.3 989.1 990.8 991.3 991.3 993.0 980.9 985.6 986.8 987.4 989.2 736.4 737.5 738.8 739.0 741.0 14183.6 14493.9 14539.9 14548.2 14550.2 12402.5 12515.6 12523.7 12606.1 13453.5 8242.4 9780.3 9953.3 10000.2 10295.0 3495.9 3650.6 3688.3 3691.6 3696.9 57523.7 75456.6 75547.6 75570.0 82464.6 9305.0 9322.8 9490.6 9550.4 9587.2 19459.2 20210.6 20381.5 20419.5 20473.4 7312.6 7481.6 7484.8 7503.1 7603.9 3807.7 3841.4 3860.1 3895.6 3977.5 3568.0 3677.6 3680.2 3682.3 3683.4 548.5 660.4 662.2 663.3 680.9 503.4 508.9 549.5 566.1 632.2 7493.1 7507.2 7577.2 7588.5 7852.3 536.2 555.0 564.3 588.8 594.9 3634.3 3653.7 3668.9 3695.6 3888.8 92470.0 93092.5 96275.0 96568.0 96729.0 58386.7 69991.7 70188.6 70538.6 71217.6 68919.7 70614.6 71139.0 72026.0 72236.6 7799.2 7844.4 7971.9 8055.4 8073.5 29417.7 42155.0 42804.9 43102.0 43504.0 61670.0 65436.0 65476.3 66062.3 66224.0 9026.4 10535.1 10779.8 10913.4 11068.3 11311.8 11406.8 11769.2 11879.8 12543.5 10990.1 11194.8 11238.3 11255.4 11611.9 9359.3 10848.7 10962.4 11075.3 11399.1 10766.7 10970.3 11230.9 11456.9 11518.7 8987.2 9074.0 9096.6 9302.0 9519.5 7282.8 8502.4 9331.2 9333.3 9379.1 07:33:33 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:33:33 INFO - PROCESS | 1666 | 07:33:33 INFO - TEST-INFO | 1666: exit 0 07:33:33 INFO - TEST-OK | dromaeo_css | took 1113949ms 07:33:33 INFO - TEST-START | kraken 07:33:33 INFO - operating with platform_type : mac_ 07:33:33 INFO - Initialising browser for kraken test... 07:33:33 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpsRoxgX/profile http://localhost:49273/getInfo.html) 07:33:35 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 07:33:35 INFO - PROCESS | 1677 | colorDepth:24 07:33:35 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 07:33:35 INFO - PROCESS | 1677 | __metrics 07:33:36 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:36 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:33:36 INFO - TEST-INFO | 1677: exit 0 07:33:36 INFO - Browser initialized. 07:33:36 INFO - Running cycle 1/1 for kraken test... 07:33:36 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpsRoxgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:48 INFO - PROCESS | 1679 | RSS: Main: 237682688 07:33:48 INFO - PROCESS | 1679 | 07:33:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:52 INFO - PROCESS | 1679 | RSS: Main: 286150656 07:33:52 INFO - PROCESS | 1679 | 07:33:54 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 07:33:55 INFO - PROCESS | 1679 | RSS: Main: 298758144 07:33:55 INFO - PROCESS | 1679 | 07:33:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 07:33:59 INFO - PROCESS | 1679 | RSS: Main: 386703360 07:33:59 INFO - PROCESS | 1679 | 07:34:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 07:34:02 INFO - PROCESS | 1679 | RSS: Main: 287485952 07:34:02 INFO - PROCESS | 1679 | 07:34:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:04 INFO - PROCESS | 1679 | RSS: Main: 291520512 07:34:04 INFO - PROCESS | 1679 | 07:34:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:08 INFO - PROCESS | 1679 | RSS: Main: 330526720 07:34:08 INFO - PROCESS | 1679 | 07:34:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:11 INFO - PROCESS | 1679 | RSS: Main: 330485760 07:34:11 INFO - PROCESS | 1679 | 07:34:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 07:34:15 INFO - PROCESS | 1679 | RSS: Main: 329576448 07:34:15 INFO - PROCESS | 1679 | 07:34:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:17 INFO - PROCESS | 1679 | RSS: Main: 319946752 07:34:17 INFO - PROCESS | 1679 | 07:34:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:19 INFO - PROCESS | 1679 | RSS: Main: 327127040 07:34:19 INFO - PROCESS | 1679 | 07:34:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:22 INFO - PROCESS | 1679 | RSS: Main: 330125312 07:34:22 INFO - PROCESS | 1679 | 07:34:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:26 INFO - PROCESS | 1679 | RSS: Main: 331112448 07:34:26 INFO - PROCESS | 1679 | 07:34:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:29 INFO - PROCESS | 1679 | RSS: Main: 328986624 07:34:29 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 07:34:31 INFO - PROCESS | 1679 | RSS: Main: 393183232 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | __start_tp_report 07:34:31 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 07:34:31 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 07:34:31 INFO - PROCESS | 1679 | |i|pagename|runs| 07:34:31 INFO - PROCESS | 1679 | |0;ai-astar;113;110;111;110;112;113;118;114;113;113 07:34:31 INFO - PROCESS | 1679 | |1;audio-beat-detection;180;152;129;191;156;175;138;120;169;119 07:34:31 INFO - PROCESS | 1679 | |2;audio-dft;184;185;184;184;183;183;184;183;181;186 07:34:31 INFO - PROCESS | 1679 | |3;audio-fft;76;72;82;92;56;59;58;79;84;59 07:34:31 INFO - PROCESS | 1679 | |4;audio-oscillator;89;97;135;79;78;82;123;79;76;124 07:34:31 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;86;84;85;83;87;83;86;85;85;84 07:34:31 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;93;94;92;92;92;93;93;92;93 07:34:31 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;87;88;90;86;90;109;146;147;86 07:34:31 INFO - PROCESS | 1679 | |8;json-parse-financial;59;60;60;59;60;56;57;75;57;55 07:34:31 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;61;75;112;106;84;66;67;68;66 07:34:31 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;82;79;82;80;81;82;81;84;83 07:34:31 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;138;138;139;150;137;125;153;149;181;157 07:34:31 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;171;171;169;173;171;170;167;171;174;171 07:34:31 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;68;69;66;91;95;96;95;94;67 07:34:31 INFO - PROCESS | 1679 | __end_tp_report 07:34:31 INFO - PROCESS | 1679 | __start_cc_report 07:34:31 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1951 07:34:31 INFO - PROCESS | 1679 | __end_cc_report 07:34:31 INFO - PROCESS | 1679 | __startTimestamp1460990071712__endTimestamp 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | ------- Summary: start ------- 07:34:31 INFO - PROCESS | 1679 | Number of tests: 14 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:2.31 (2.0%) stddev-sans-first:2.45 07:34:31 INFO - PROCESS | 1679 | Values: 113.0 110.0 111.0 110.0 112.0 113.0 118.0 114.0 113.0 113.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:162.50 stddev:25.75 (15.8%) stddev-sans-first:25.38 07:34:31 INFO - PROCESS | 1679 | Values: 180.0 152.0 129.0 191.0 156.0 175.0 138.0 120.0 169.0 119.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.34 (0.7%) stddev-sans-first:1.41 07:34:31 INFO - PROCESS | 1679 | Values: 184.0 185.0 184.0 184.0 183.0 183.0 184.0 183.0 181.0 186.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:71.70 Median:77.50 stddev:12.90 (16.6%) stddev-sans-first:13.59 07:34:31 INFO - PROCESS | 1679 | Values: 76.0 72.0 82.0 92.0 56.0 59.0 58.0 79.0 84.0 59.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:22.56 (28.6%) stddev-sans-first:23.78 07:34:31 INFO - PROCESS | 1679 | Values: 89.0 97.0 135.0 79.0 78.0 82.0 123.0 79.0 76.0 124.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 07:34:31 INFO - PROCESS | 1679 | Values: 86.0 84.0 85.0 83.0 87.0 83.0 86.0 85.0 85.0 84.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 07:34:31 INFO - PROCESS | 1679 | Values: 92.0 93.0 94.0 92.0 92.0 92.0 93.0 93.0 92.0 93.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:87.00 stddev:24.62 (28.3%) stddev-sans-first:25.54 07:34:31 INFO - PROCESS | 1679 | Values: 87.0 87.0 88.0 90.0 86.0 90.0 109.0 146.0 147.0 86.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.50 stddev:5.63 (9.5%) stddev-sans-first:5.97 07:34:31 INFO - PROCESS | 1679 | Values: 59.0 60.0 60.0 59.0 60.0 56.0 57.0 75.0 57.0 55.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:76.80 Median:66.50 stddev:18.24 (27.4%) stddev-sans-first:18.65 07:34:31 INFO - PROCESS | 1679 | Values: 63.0 61.0 75.0 112.0 106.0 84.0 66.0 67.0 68.0 66.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.51 07:34:31 INFO - PROCESS | 1679 | Values: 83.0 82.0 79.0 82.0 80.0 81.0 82.0 81.0 84.0 83.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:149.50 stddev:15.33 (10.3%) stddev-sans-first:15.93 07:34:31 INFO - PROCESS | 1679 | Values: 138.0 138.0 139.0 150.0 137.0 125.0 153.0 149.0 181.0 157.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:1.93 (1.1%) stddev-sans-first:2.05 07:34:31 INFO - PROCESS | 1679 | Values: 171.0 171.0 169.0 173.0 171.0 170.0 167.0 171.0 174.0 171.0 07:34:31 INFO - PROCESS | 1679 | 07:34:31 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.90 Median:92.50 stddev:14.10 (15.2%) stddev-sans-first:14.16 07:34:31 INFO - PROCESS | 1679 | Values: 68.0 68.0 69.0 66.0 91.0 95.0 96.0 95.0 94.0 67.0 07:34:31 INFO - PROCESS | 1679 | -------- Summary: end -------- 07:34:31 INFO - PROCESS | 1679 | 07:34:32 INFO - TEST-INFO | 1679: exit 0 07:34:32 INFO - TEST-OK | kraken | took 58714ms 07:34:32 INFO - SUITE-END | took 1172s 07:34:32 INFO - Completed test suite (00:19:32) 07:34:32 INFO - javascript benchmark 07:34:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.884259050932, 3319.7676162668613, 3348.3303339332138, 3382.171368014837, 3392.7964322140656, 5536.833894983147, 5616.045272303708, 5621.747021384037, 5630.77476900924, 5642.210090587316, 5662.348829884564, 5678.205051292823, 5786.247787787593, 5817.0, 5844.766209351632, 4176.937345939798, 5079.466656001122, 5126.615503837208, 5142.3829140503, 5220.92168617471, 5225.63420560559, 5248.6063545234065, 5263.815766448175, 5265.394479634852, 5301.814436494724, 4432.977835110836, 5093.872653183663, 5148.459411761749, 5153.948460515385, 5170.1986192140275, 5156.432792392834, 5160.870978225536, 5164.251183578398, 5173.405058418292, 5209.192575150858, 5088.516590923893, 5116.437191908887, 5138.152204886189, 5162.6128040397125, 5211.609129315317, 5510.393856675762, 5625.71871406428, 5639.548836093103, 5643.492085712305, 5662.943370566283, 6141.60874974391, 6211.782587609412, 6228.87542249157, 6246.593971391891, 6257.18656574647, 6242.937570624281, 6245.937540624581, 6257.217847769029, 6285.560010799246, 6289.40250676185, 5481.534069604048, 5616.438356164351, 5768.278965129359, 5773.336066352381, 5780.046292361797, 6214.906776398358, 6327.746890124436, 6330.082138090043, 6335.334789847092, 6338.049292606146, 6105.389461053859, 6108.480779133734, 6126.9387306127255, 6135.754569817246, 6139.662318572521, 6003.699815009232, 6077.544184186204, 6192.8761424771255, 6203.131561581382, 6245.843853903689, 6096.042928203419, 6143.662098584531, 6207.875842483125, 6213.316535181127, 6234.438900498977, 6226.59527130735, 6237.376262373727, 6245.375462453719, 6265.310815810257, 6269.46709529686, 4769.499202583748, 4856.927146092811, 4937.975310123426, 4949.158643030693, 4996.475370086088, 4392.934105988413, 4436.0906014267, 4441.689701538054, 4520.367148599199, 4566.817327306937, 5644.85887852807, 5681.57388195887, 5691.3170419549915, 5694.288213973254, 5742.08126699726, 6064.696765161812, 6150.015997440388, 6206.100115483229, 6273.435390814849, 6309.116723658692, 5592.356878958891, 5658.660480371191, 5672.716364181774, 5679.517241034476, 5694.772209111672, 3795.962040379616, 5351.919721204185, 5382.085045542267, 5383.353997520323, 5427.755750991136, 6198.0, 6224.595401299082, 6318.0, 6323.968380158161, 6324.810255692245, 6264.749410023548, 6270.561060725888, 6291.842703932438, 6293.150424692608, 6303.0, 6283.434490895658, 6301.4328710416285, 6303.0, 6312.936870631235, 6329.5252856036905, 5971.611845230046, 6059.394060593905, 6124.938750612615, 6193.535484838745, 6196.225471816023, 6262.3111457738705, 6278.905816412849, 6285.308616052322, 6303.275123360872, 6310.116583678197, 6124.693765311627, 6137.140800288053, 6142.938570614416, 6149.877002460015, 6155.47678447337, 5916.053431450947, 6014.548908831767, 6043.123747056564, 6123.295820980644, 6149.139120523219, 4727.692699974491, 5937.732802024006, 5962.403759624176, 5971.28344598651, 6018.488428483628, 6037.45662890342, 6042.879142417215, 6087.8782424350375, 6110.483995285942, 6116.5412594056515, 5771.826845194651, 5875.265591801025, 5934.228550288608, 5944.8811023780145, 6026.969865150646], "value": 5658.887192259716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.39738710933983, 538.120173516301, 553.3952233742277, 584.7748616782537, 661.8543920337527, 26604.600930986027, 37135.81432092839, 37949.43075853864, 37958.0, 38075.42886856696, 33360.0, 40453.38186472545, 41263.0, 41278.0, 41338.17323653525, 8385.245327920486, 9453.24374050076, 9694.515274236295, 9695.36980096295, 11236.325820450798, 11453.308472508954, 11633.825492617618, 11658.825117623242, 11668.124890633195, 11669.0, 11528.308301501895, 11647.359395233301, 11650.650480485556, 11655.475503602316, 11660.41697915105, 8399.496030238175, 8780.780480487974, 8795.384323097385, 11416.600418985296, 11572.942135289311, 11321.943390282995, 11507.654770356903, 11514.654560363202, 11521.827172592419, 11525.596604118815, 30033.249168770737, 37976.43035354472, 38032.04919876998, 38041.619583804364, 38085.0478738031, 3228.1606782236554, 3358.6641335866216, 3422.709069729076, 3461.2212252243044, 3573.749837511375, 27184.59223111655, 28239.294017649518, 28536.0, 29246.561301580492, 29293.85353073221, 2726.8500232487204, 2748.958765618517, 2762.875670594828, 2774.2925553983805, 2829.122971878724, 471272.0, 472041.99999999657, 472260.0, 472867.99999999657, 473307.0, 58131.41868581345, 58199.0, 58545.70727146337, 58715.532111696695, 58778.11832822511, 62167.75664486775, 63979.680101599195, 65483.345166547726, 65559.67220163964, 65700.34299657038, 16066.196690165445, 16257.756133658004, 16257.837421625632, 16271.430499932445, 16280.511584652479, 11486.0811135109, 11790.23363481371, 12565.0, 12879.484820607071, 12894.161879477804, 18488.815111848708, 18522.907385462986, 18585.90707046456, 18636.627267454576, 18637.0, 7634.160242373335, 7776.377889768805, 7783.33841623457, 7854.921450785533, 7873.661477548831, 949.126803340928, 981.6956743409565, 995.5967833027636, 1013.2957594471771, 1026.3277553202515, 28849.711502885122, 29294.658408651645, 29360.706392935797, 29580.55629165564, 29772.702272976992, 1059.4120263253967, 1092.7869065532304, 1110.5169251375678, 1149.643610480737, 1231.6475531734345, 13947.302634868216, 14974.951753377376, 15073.849261507245, 15286.770698439532, 15328.693426131638, 602179.0, 607085.0, 608851.0, 609767.0, 610341.0, 57403.0, 58350.124748128816, 58441.707791461624, 58441.83116337735, 58551.0, 1318.8878945289757, 1442.7114577084626, 1482.5181815909873, 1490.3591455674164, 1492.156931333793, 28838.0, 29175.416491670472, 29210.707892921648, 29775.255618609706, 29966.550501742928, 46056.0, 46101.76949115233, 46581.0, 46609.067818644115, 46644.53355466402, 285977.0, 346878.0, 347581.0, 348775.0, 348933.0, 23111.884440578364, 25363.985440582906, 25877.870610646827, 26027.73972260253, 26383.736162638128, 41550.0, 41616.79191604022, 41927.790361048, 41985.370219447344, 42373.0, 27661.861690691418, 34974.82512587421, 34998.12504687403, 35306.76426325066, 35514.93455196348, 35418.46872296866, 35570.46644300389, 35643.82178089093, 36107.81946090358, 36178.8191059043, 34677.50763810838, 34707.652923471454, 35410.291794164485, 35432.0, 35971.82014089913, 30755.384892302478, 31768.0, 31839.522407164375, 31844.68155318417, 31848.36303273968, 23531.52936941286, 23617.29148125559, 23809.0, 23977.880110599337, 24147.758522415254], "value": 19409.09666301352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.11382276056116, 393.83065281928776, 401.63651895035, 403.10309561226296, 410.1264307026036, 13519.0, 18969.33607323744, 19568.608627827434, 19663.70504442433, 19668.409947701573, 15614.453494127707, 16361.672766544661, 19335.516612084706, 19983.800161998377, 20092.497687557818, 5894.58737888348, 6075.544334174932, 6099.146119543268, 6106.3893610639025, 6117.4188452097205, 5773.971130144364, 5892.204552385438, 5943.167956486095, 5996.760129594811, 6046.455818976291, 4122.587741225869, 4378.956210437903, 6223.408776166257, 6542.182227221598, 6549.410553050225, 6220.813375598739, 6505.0, 6524.217093948733, 6537.673116344187, 6564.081028655992, 5697.202391665171, 5720.971395143039, 5721.71391430431, 5729.1119876419225, 5752.424757524256, 24009.0, 24214.152504662252, 24727.752722472724, 25443.491130177477, 25475.61786573203, 2014.4963759060236, 2156.54712510373, 2179.357089658539, 2241.7085778848646, 2259.7175353080866, 14542.0, 14689.045212061288, 14712.0, 14814.555563333117, 15773.921130394388, 1617.44198251603, 1653.2890856931515, 1748.2744660965684, 1770.3892157205744, 1835.5135888989428, 108577.0, 114329.0, 117006.0, 122326.0, 128312.35843820815, 16062.678746425006, 19766.50583735418, 20351.982400879897, 20598.661087029293, 20654.0, 34872.65127348694, 34987.65012349844, 35024.824875875456, 35062.12344691352, 35082.64917350845, 8468.661253549912, 10591.682249532372, 10661.413622250851, 10689.144868410509, 10699.090577300862, 7218.0, 8789.912100879037, 8805.559722013873, 8811.69159079442, 8923.643054277885, 9293.163615274523, 9334.766630834147, 9427.670031548863, 9439.858402123973, 9449.196818270386, 2440.6461063145744, 3609.314230296235, 3727.7204209684382, 3778.6032466591164, 3784.3188226119014, 776.9650365733555, 898.8696638987441, 944.2163004706077, 946.6402766948653, 981.8232718110665, 19196.520086997938, 19464.513387165152, 19598.902005490167, 20203.0, 20330.390088297376, 813.6541969662869, 935.387321304533, 970.3935040599625, 983.2429029647132, 989.8069876374182, 10298.0, 10611.045005949502, 10613.363198208132, 10628.937106289464, 10639.574417023387, 565260.0, 603339.0, 605494.0, 606630.0, 622075.0, 126779.0, 127530.0, 128134.0, 128458.0, 129099.0, 1011.191047162282, 1024.538957469142, 1034.2605037398296, 1041.7447725307347, 1042.1402343067, 17626.647467050843, 17826.91086544559, 17830.5542361442, 17915.19381627804, 18116.27534898642, 50469.74765126151, 51049.0, 51091.744541277054, 52258.47741522536, 52469.47530524646, 67895.64208715699, 71051.64474177803, 76129.61935190289, 76451.0, 78871.01766156599, 7764.378849692124, 7852.214778522102, 7890.210978902064, 7992.560409177551, 8096.097417106857, 10527.842082368617, 12139.635810925687, 12433.93783031079, 12472.5010999559, 12509.248705181464, 9615.615375385187, 10063.949680251551, 10411.531481083219, 10917.945410272898, 10923.180761442765, 8968.372213945222, 10456.63401780934, 10662.413567253565, 10713.464326783474, 10978.780424391627, 10665.36007839532, 10715.0, 10913.126949843834, 11070.059044981266, 11121.721956950818, 7779.611019448892, 8031.759047228593, 8043.758687239392, 8136.267735903797, 8223.21879421454, 9386.765330866783, 10713.892861071601, 10744.193237871561, 10786.892131078588, 10895.96488333607], "value": 10294.742208337393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.7100508893132, 1564.5775640577044, 1584.841515848415, 1815.809340019298, 1955.8141976512236, 7746.302832745052, 7865.331446827026, 8096.838063238746, 8146.470479418848, 8165.469244499103, 7810.3751699864015, 8020.719274825382, 8047.597620118985, 8054.7180848670305, 8059.476134051297, 2335.1943579465055, 2375.4417711837705, 2375.9643605345846, 2376.8573885566834, 2377.6909001829736, 2344.5779759643256, 2353.870537120458, 2382.9046838126455, 2383.7020372453444, 2394.976050239493, 2339.2689409836767, 2354.4349356154485, 2371.2886134159685, 2374.430136767172, 2375.70303712036, 2313.6066868632206, 2345.0, 2350.6591544226076, 2352.0121548949396, 2356.8821558921986, 2303.5968705476475, 2325.2442956039354, 2339.0409931927998, 2341.4263505441277, 2344.788968992782, 7934.682612695486, 8059.879101813477, 8102.39232057598, 8114.715984940558, 8435.873461898076, 5061.569766569846, 5216.426193118754, 5233.476652334774, 5241.449647786965, 5302.734863256822, 3297.406466835969, 3298.917527061819, 3374.6119196292493, 3393.0838673558, 3397.69420752131, 997.4962643864874, 1003.4531180506568, 1025.912797412221, 1030.6701855406272, 1033.7260625934134, 11311.660650180507, 11441.141914356456, 11460.94269528647, 11476.598319058876, 11488.965993060665, 4405.933910991338, 4408.911821763547, 4505.098980203972, 4531.660125490602, 4565.680402371802, 8951.239144672645, 8957.641694332153, 8978.685745998859, 8979.775505612412, 8981.326400519987, 5167.896642067213, 5169.991851588904, 5171.3277273954145, 5172.146595811649, 5201.713905735145, 4185.455890734185, 4312.805923733439, 4505.932411013838, 4778.593819525309, 4851.393575803025, 3580.7314451416246, 3659.249853779969, 3707.1844194277755, 3741.4761933329355, 3748.737588368788, 1163.2555164694602, 1185.1822242652543, 1187.0800129899396, 1192.2905871006737, 1193.838831757719, 815.4984684419159, 884.2307192742227, 917.4862077236769, 936.8220038192721, 942.3733217410345, 5656.773729050874, 5724.026915424388, 5727.8854422912145, 5763.394843541368, 5851.89331840537, 438.37312642920926, 444.5798720209371, 453.98760763497586, 458.8669285907116, 461.2734942465563, 3728.0493474164455, 3749.343864823645, 3753.9061523462133, 3812.104155523505, 3822.6559609635265, 10147.644832430977, 10550.0, 10557.419341936115, 10657.84013239802, 10665.946670266754, 10612.469376531142, 10615.628453004108, 10618.575256989634, 10621.5220315086, 10631.0, 7862.371010319275, 8068.22499050208, 8088.757337279891, 8179.836403271901, 8193.71322003727, 5579.525740312119, 5628.0, 5667.0, 5739.512141468022, 5799.884002320015, 9531.809363812823, 9626.0, 9863.654772082942, 9962.402255864672, 9982.500874956368, 9820.067093626094, 10041.096301332915, 10223.846642300521, 10235.539400727133, 10267.84598231042, 6334.398232167937, 6596.60420374779, 6712.2616512184595, 6989.755358562629, 7042.753503627348, 8219.917800821915, 8236.258736713724, 8300.584970751317, 8306.335493160412, 8309.750707478785, 7062.682179302046, 7201.819954501179, 7389.076365454318, 7450.217727138573, 7511.699532018658, 7101.11236095488, 7127.8574428512175, 7235.746748863765, 7278.308560686726, 7335.339819416278, 6693.732250709917, 6724.193096828412, 6742.7977160683295, 6762.594244345355, 6765.492588056014, 4651.3720647712125, 4685.812567497398, 4779.856604301876, 4844.563989240985, 4961.82633607822, 4812.470628230822, 4817.084753896748, 4878.0, 4937.506249375034, 5090.338256026693], "value": 4365.180197616103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.50622769138613, 321.6847489460329, 324.45167666643357, 324.9203945033467, 331.07464636341433, 5539.9169012464845, 5812.651240925542, 5972.223610930584, 6115.908261376083, 6139.72371243294, 6027.789027384042, 6041.335453100155, 6054.152418661391, 6063.848403789896, 6086.239220097488, 4163.854939891524, 4247.532771395144, 4307.784610769465, 4467.82128714851, 4469.173202957463, 3711.4618380334837, 3912.765234085964, 4508.594226519613, 4541.2733962566, 4546.295324224734, 4438.7114837535455, 4469.575390337929, 4506.324051392301, 4510.413646225986, 4515.193922431037, 4286.935695964532, 4379.64962802975, 4517.119161763458, 4548.295014272793, 4560.840370587013, 3644.653757892996, 3731.7201209909367, 3919.392494163381, 3951.3480275754755, 3961.7022127166174, 5135.0, 5775.0, 5830.3586605473365, 5895.675737834417, 5910.0, 4678.976605116953, 5204.68771873685, 5281.762320695578, 5287.735613219362, 5298.708571028592, 5887.264091988502, 6366.331535188831, 6381.361863813628, 6416.935830641681, 6445.548811583191, 3679.8344074516444, 4159.896002599929, 4360.5203427623255, 4381.715188512769, 4389.934150987738, 6457.903131453032, 6647.966760166217, 6727.990801379783, 6741.853884839589, 6765.695543700496, 4024.0342317843506, 4085.2442298174933, 4433.049458238364, 4452.376667266585, 4460.197164510354, 4026.5570787213383, 4154.584541545822, 4534.13851368239, 4544.431946006749, 4557.817687292538, 5084.618653600921, 5238.580913526908, 5266.3943646480375, 5266.973665131726, 5290.508264545459, 5401.864953376197, 6453.806045881527, 6463.741450342028, 6470.805875823733, 6501.772437964649, 1420.6078043517412, 1538.699798670122, 1564.6401327694693, 1567.7099736548546, 1577.7317855964513, 914.7575892388522, 918.9891119768201, 947.758436448255, 998.9200863930868, 1065.984010239847, 5887.941120588825, 5963.850903727354, 5993.011153159679, 5998.430149135912, 6036.63780173191, 6317.526185536011, 6545.967270163619, 6655.600663960178, 6682.799516014527, 6706.195256569243, 4999.575036121898, 5947.434993675594, 5974.790882319098, 5977.880442391128, 5989.221401217814, 3364.3271345730464, 3463.3939060664284, 3510.069831494656, 3530.2409981854025, 3533.851498263075, 5721.8569535761935, 6820.488463365267, 6895.172579290517, 6903.585784852925, 6910.170779506391, 5844.824655260349, 6541.934580654228, 6645.966770166118, 6725.0, 6856.451483881277, 5837.861616984647, 6435.806925792233, 7005.894911576433, 7008.964955175192, 7034.366906978396, 6377.681115944277, 6441.0, 6464.806055818333, 6756.628385438848, 6760.966195168992, 5301.4168441472175, 6630.53586248958, 6652.268250492345, 6660.300668429745, 6685.465162786868, 5701.458361455655, 6611.702473388613, 6636.701348439428, 6732.528722989539, 7032.327715468089, 4287.6998610097, 4298.355246712893, 4346.500152482505, 4350.564943505624, 4350.891227719332, 6540.934590654033, 6678.766243181465, 6746.628935408599, 6747.932520674927, 6753.864922701617, 6107.725152368065, 6497.740090396331, 6504.317046710216, 6509.641969691523, 6526.804195874131, 6163.260408750979, 6473.255575608865, 6480.287168411565, 6514.73941042353, 6530.771423000172, 5950.642961422329, 6372.968135159294, 6378.202724659418, 6402.167718196604, 6466.935330646634, 5171.974140129275, 6498.285188629153, 6509.544331896911, 6522.445592124533, 6527.759725652111, 5014.498550144956, 6057.42454466825, 6305.180326557518, 6364.840878978062, 6438.323975982642], "value": 4683.683086755855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.183924692252, 672.1900110367009, 718.5688586847892, 745.2733584754861, 748.3675799651024, 11733.589324373637, 13848.30758462078, 14184.57446276612, 14206.147631142112, 14226.288685565707, 13076.738465230714, 13683.863161368383, 13686.863131368684, 13695.246761428118, 13863.0, 950.3917492804611, 951.8096380723848, 959.1032384720274, 959.8464245720686, 963.0562049191797, 927.8654595083709, 932.7341707613332, 933.7478880702206, 934.7429456899339, 935.3312381647121, 989.0554520432969, 990.8266053440655, 991.2516050381987, 991.3060857399813, 992.9900700993006, 980.8577756225343, 985.6402413119232, 986.8223719730446, 987.3582171588453, 989.1690979577154, 736.4439847914844, 737.4579683932305, 738.8337624034602, 738.9926100738977, 740.9814754631124, 14183.574492765234, 14493.855061449356, 14539.854601453955, 14548.1998490083, 14550.199739014455, 12402.503899843996, 12515.624531264077, 12523.686907827287, 12606.054545909003, 13453.461861525528, 8242.423030387876, 9780.266480014028, 9953.30326877119, 10000.199984001263, 10295.021972912562, 3495.930081398383, 3650.6349365063547, 3688.3360995020885, 3691.630836916314, 3696.8706095286807, 57523.71238143783, 75456.62271688662, 75547.62226188889, 75570.0, 82464.58767706124, 9304.95347523258, 9322.813543729224, 9490.572924218426, 9550.37922535033, 9587.18508926735, 19459.22163113488, 20210.59578808445, 20381.490462738253, 20419.4895127623, 20473.385798426072, 7312.561246325237, 7481.625918704043, 7484.775456736306, 7503.062117235346, 7603.885941710879, 3807.7144214184045, 3841.3661745812187, 3860.1121741999495, 3895.6493915547735, 3977.54258260298, 3567.964320356763, 3677.595464498903, 3680.2087551176623, 3682.2635472905527, 3683.3922402803237, 548.528265691505, 660.4320284555279, 662.192125606759, 663.3134705579702, 680.8536164724509, 503.3858692395345, 508.9262057001714, 549.5411331538211, 566.0603398358704, 632.193952710298, 7493.100827900578, 7507.1742108368035, 7577.16651168371, 7588.468807183554, 7852.293293603603, 536.2117687000103, 554.9805756798493, 564.266453610305, 588.8252935393916, 594.8691287916652, 3634.327649384872, 3653.707703383723, 3668.8899333020054, 3695.5565332159777, 3888.7861167635488, 92470.0, 93092.53453732688, 96275.0, 96568.0, 96729.0, 58386.70806646025, 69991.65004174947, 70188.64905675541, 70538.58922821618, 71217.64391178114, 68919.65540172368, 70614.64692676504, 71139.0, 72026.0, 72236.63881680663, 7799.220077992155, 7844.4116691247245, 7971.92028079735, 8055.436119471581, 8073.515589064675, 29417.705822941498, 42155.0, 42804.92987675333, 43102.0, 43504.0, 61670.0, 65436.0, 65476.34523654702, 66062.34844128936, 66224.0, 9026.413283136575, 10535.104516116216, 10779.784404312026, 10913.39976301311, 11068.28056176346, 11311.773764524827, 11406.828897566376, 11769.176157669224, 11879.821802672794, 12543.49826006986, 10990.120790336594, 11194.832077519006, 11238.269512481662, 11255.437228138724, 11611.941940290244, 9359.251259899056, 10848.728781780519, 10962.397068161008, 11075.280106793032, 11399.06187535235, 10766.676999690022, 10970.341779493256, 11230.887691122984, 11456.94271528637, 11518.654440366803, 8987.236084932592, 9074.0, 9096.636134554808, 9301.953570214542, 9519.476428796483, 7282.781516554512, 8502.362322825937, 9331.16019558243, 9333.346665733334, 9379.108984646447], "value": 6716.201081243832, "unit": "score"}], "name": "dromaeo_css", "value": 7331.361906682237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 111.0, 110.0, 112.0, 113.0, 118.0, 114.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 152.0, 129.0, 191.0, 156.0, 175.0, 138.0, 120.0, 169.0, 119.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 184.0, 183.0, 183.0, 184.0, 183.0, 181.0, 186.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 82.0, 92.0, 56.0, 59.0, 58.0, 79.0, 84.0, 59.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 97.0, 135.0, 79.0, 78.0, 82.0, 123.0, 79.0, 76.0, 124.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 83.0, 87.0, 83.0, 86.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 94.0, 92.0, 92.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 90.0, 86.0, 90.0, 109.0, 146.0, 147.0, 86.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 56.0, 57.0, 75.0, 57.0, 55.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 75.0, 112.0, 106.0, 84.0, 66.0, 67.0, 68.0, 66.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 79.0, 82.0, 80.0, 81.0, 82.0, 81.0, 84.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 139.0, 150.0, 137.0, 125.0, 153.0, 149.0, 181.0, 157.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 173.0, 171.0, 170.0, 167.0, 171.0, 174.0, 171.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 66.0, 91.0, 95.0, 96.0, 95.0, 94.0, 67.0], "value": 80.9, "unit": "score"}], "name": "kraken", "value": 1512.9, "alertThreshold": 2.0}]} 07:34:32 INFO - Return code: 0 07:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:33 ERROR - # TBPL SUCCESS # 07:34:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:33 INFO - 2016-04-18 07:34:33.037 screenresolution[1683:10400] starting screenresolution argv=screenresolution get 07:34:33 INFO - 2016-04-18 07:34:33.040 screenresolution[1683:10400] Display 0: 1600x1200x32@60 07:34:33 INFO - 2016-04-18 07:34:33.046 screenresolution[1684:10403] starting screenresolution argv=screenresolution list 07:34:33 INFO - Available Modes on Display 0 07:34:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:33 INFO - Intel Iris: 07:34:33 INFO - Chipset Model: Intel Iris 07:34:33 INFO - Type: GPU 07:34:33 INFO - Bus: Built-In 07:34:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:33 INFO - Vendor: Intel (0x8086) 07:34:33 INFO - Device ID: 0x0a2e 07:34:33 INFO - Revision ID: 0x0009 07:34:33 INFO - Displays: 07:34:33 INFO - Display: 07:34:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:33 INFO - Display Serial Number: 1600x1200 60 07:34:33 INFO - Main Display: Yes 07:34:33 INFO - Mirror: Off 07:34:33 INFO - Online: Yes 07:34:33 INFO - Rotation: Supported 07:34:33 INFO - Return code: 0 07:34:33 INFO - Running post-action listener: _resource_record_post_action 07:34:33 INFO - Running post-run listener: _resource_record_post_run 07:34:34 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37660160; Write bytes: 695557120; Read time: 394; Write time: 2278 07:34:34 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 388008448; Write bytes: 382367744; Read time: 28341; Write time: 727 07:34:34 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35878400; Write bytes: 297681920; Read time: 375; Write time: 1518 07:34:34 INFO - Running post-run listener: _upload_blobber_files 07:34:34 INFO - Blob upload gear active. 07:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:34 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 07:34:34 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:34:34 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:34:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:35 INFO - (blobuploader) - INFO - Done attempting. 07:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:37 INFO - (blobuploader) - INFO - Done attempting. 07:34:37 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:37 INFO - Return code: 0 07:34:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab28ce7260a2bfb6a3f4aba9834e6059a8c9f1270f0b41e8baa533b6b4ef23938c6fb7cd4395065e52e34dacad1db49e087ce84358d2f2857484beffd42de56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6eff6aaee6b717c18df334417ad69fea5abc27f46258a14903608d9e279af14b9ab98004097ad433914ee632f6c95d922e39029f848722f155150fa8f99328"} 07:34:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:37 INFO - Contents: 07:34:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab28ce7260a2bfb6a3f4aba9834e6059a8c9f1270f0b41e8baa533b6b4ef23938c6fb7cd4395065e52e34dacad1db49e087ce84358d2f2857484beffd42de56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6eff6aaee6b717c18df334417ad69fea5abc27f46258a14903608d9e279af14b9ab98004097ad433914ee632f6c95d922e39029f848722f155150fa8f99328"} 07:34:37 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:37 INFO - Copying logs to upload dir... 07:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.897763 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-18 07:34:37.254989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:34:37.258056) ========= 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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab28ce7260a2bfb6a3f4aba9834e6059a8c9f1270f0b41e8baa533b6b4ef23938c6fb7cd4395065e52e34dacad1db49e087ce84358d2f2857484beffd42de56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6eff6aaee6b717c18df334417ad69fea5abc27f46258a14903608d9e279af14b9ab98004097ad433914ee632f6c95d922e39029f848722f155150fa8f99328"} build_url:https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/WTBuZrl4QNSicHZwkcsnWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab28ce7260a2bfb6a3f4aba9834e6059a8c9f1270f0b41e8baa533b6b4ef23938c6fb7cd4395065e52e34dacad1db49e087ce84358d2f2857484beffd42de56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6eff6aaee6b717c18df334417ad69fea5abc27f46258a14903608d9e279af14b9ab98004097ad433914ee632f6c95d922e39029f848722f155150fa8f99328"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:34:37.285064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:34:37.285358) ========= 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.wjV2gQGCs3/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.WXQSTKZM2X/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005029 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:34:37.333325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:34:37.333649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:34:37.334057) ========= ========= Total master_lag: 6.06 =========