builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1468865491.97 results: success (0) buildid: 20160718082851 builduid: 650ed7ebe76c4307beb604729a0363e6 revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:31.971277) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:31.971749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:31.972082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:32.014406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:32.015057) ========= 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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-07-18 11:11:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.20M=0.001s 2016-07-18 11:11:32 (9.20 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104072 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:32.146207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:32.146509) ========= 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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.020667 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:32.196859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:11:32.197176) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f4257230dffa106e90cf736df9dbe9859ac5274 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-07-18 11:11:32,271 truncating revision to first 12 chars 2016-07-18 11:11:32,271 Setting DEBUG logging. 2016-07-18 11:11:32,271 attempt 1/10 2016-07-18 11:11:32,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f4257230dff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 11:11:32,927 unpacking tar archive at: mozilla-beta-0f4257230dff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928636 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 11:11:33.424269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:33.424626) ========= script_repo_revision: 0f4257230dffa106e90cf736df9dbe9859ac5274 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:33.425070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:33.425362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 11:11:33.445683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-18 11:11:33.446258) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:11:33 INFO - MultiFileLogger online at 20160718 11:11:33 in /builds/slave/test 11:11:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:33 INFO - {'append_to_log': False, 11:11:33 INFO - 'base_work_dir': '/builds/slave/test', 11:11:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:33 INFO - 'branch': 'Mozilla-Beta', 11:11:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:33 INFO - 'config_files': ('talos/mac_config.py',), 11:11:33 INFO - 'default_actions': ('clobber', 11:11:33 INFO - 'read-buildbot-config', 11:11:33 INFO - 'download-and-extract', 11:11:33 INFO - 'populate-webroot', 11:11:33 INFO - 'create-virtualenv', 11:11:33 INFO - 'install', 11:11:33 INFO - 'run-tests'), 11:11:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:33 INFO - 'download_minidump_stackwalk': True, 11:11:33 INFO - 'download_symbols': 'ondemand', 11:11:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:33 INFO - 'installer_path': 'installer.exe', 11:11:33 INFO - 'log_level': 'info', 11:11:33 INFO - 'log_name': 'talos', 11:11:33 INFO - 'log_to_console': True, 11:11:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:33 INFO - 'opt_config_files': (), 11:11:33 INFO - 'pip_index': False, 11:11:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:33 INFO - 'cmd': ('bash', 11:11:33 INFO - '-c', 11:11:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:33 INFO - 'enabled': True, 11:11:33 INFO - 'halt_on_failure': False, 11:11:33 INFO - 'name': 'check_screen_resolution'},), 11:11:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:33 INFO - 'cmd': ('bash', 11:11:33 INFO - '-c', 11:11:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:33 INFO - 'enabled': True, 11:11:33 INFO - 'halt_on_failure': False, 11:11:33 INFO - 'name': 'check_screen_resolution'},), 11:11:33 INFO - 'run_cmd_checks_enabled': True, 11:11:33 INFO - 'sps_profile': False, 11:11:33 INFO - 'sps_profile_interval': 0, 11:11:33 INFO - 'suite': 'dromaeojs-e10s', 11:11:33 INFO - 'system_bits': '32', 11:11:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:33 INFO - 'title': 't-yosemite-r7-0016', 11:11:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:33 INFO - 'use_talos_json': True, 11:11:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:33 INFO - 'work_dir': 'build'} 11:11:33 INFO - ##### 11:11:33 INFO - ##### Running clobber step. 11:11:33 INFO - ##### 11:11:33 INFO - Running pre-action listener: _resource_record_pre_action 11:11:33 INFO - Running main action method: clobber 11:11:33 INFO - rmtree: /builds/slave/test/build 11:11:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:35 INFO - Running post-action listener: _resource_record_post_action 11:11:35 INFO - ##### 11:11:35 INFO - ##### Running read-buildbot-config step. 11:11:35 INFO - ##### 11:11:35 INFO - Running pre-action listener: _resource_record_pre_action 11:11:35 INFO - Running main action method: read_buildbot_config 11:11:35 INFO - Using buildbot properties: 11:11:35 INFO - { 11:11:35 INFO - "project": "", 11:11:35 INFO - "product": "firefox", 11:11:35 INFO - "script_repo_revision": "production", 11:11:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:11:35 INFO - "repository": "", 11:11:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:11:35 INFO - "buildid": "20160718082851", 11:11:35 INFO - "pgo_build": "False", 11:11:35 INFO - "basedir": "/builds/slave/test", 11:11:35 INFO - "buildnumber": 65, 11:11:35 INFO - "slavename": "t-yosemite-r7-0016", 11:11:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:11:35 INFO - "platform": "yosemite_r7", 11:11:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:11:35 INFO - "branch": "mozilla-beta", 11:11:35 INFO - "repo_path": "releases/mozilla-beta", 11:11:35 INFO - "revision": "0f4257230dffa106e90cf736df9dbe9859ac5274", 11:11:35 INFO - "stage_platform": "macosx64", 11:11:35 INFO - "builduid": "650ed7ebe76c4307beb604729a0363e6", 11:11:35 INFO - "slavebuilddir": "test" 11:11:35 INFO - } 11:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 11:11:35 INFO - Running post-action listener: _resource_record_post_action 11:11:35 INFO - ##### 11:11:35 INFO - ##### Running download-and-extract step. 11:11:35 INFO - ##### 11:11:35 INFO - Running pre-action listener: _resource_record_pre_action 11:11:35 INFO - Running main action method: download_and_extract 11:11:35 INFO - mkdir: /builds/slave/test/build/tests 11:11: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')]} 11:11:35 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 11:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 11:11:36 INFO - Downloaded 1165 bytes. 11:11:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 11:11:36 INFO - Using the following test package requirements: 11:11:36 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:11:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 11:11:36 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 11:11:36 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:11:36 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 11:11:36 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 11:11:36 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 11:11:36 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 11:11:36 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 11:11:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 11:11:36 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 11:11:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 11:11:36 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')]} 11:11:36 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:37 INFO - Downloaded 18314770 bytes. 11:11:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:11:40 INFO - Return code: 0 11:11:40 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:40 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 11:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 11:11:41 INFO - Downloaded 18314770 bytes. 11:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:11:45 INFO - Return code: 0 11:11: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')]} 11:11:45 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 11:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 11:11:46 INFO - Downloaded 10840145 bytes. 11:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:11:46 INFO - Return code: 0 11:11:46 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')]} 11:11:46 INFO - https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 11:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 11:11:48 INFO - Downloaded 86190192 bytes. 11:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:48 INFO - mkdir: /builds/slave/test/properties 11:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:48 INFO - Contents: 11:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 11:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - Running post-action listener: set_extra_try_arguments 11:11:49 INFO - ##### 11:11:49 INFO - ##### Running populate-webroot step. 11:11:49 INFO - ##### 11:11:49 INFO - Running pre-action listener: _resource_record_pre_action 11:11:49 INFO - Running main action method: populate_webroot 11:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:49 INFO - '--tppagecycles', 11:11:49 INFO - '7'], 11:11:49 INFO - 'tests': ['tsvgm']}}, 11:11:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['damp', 'tps']}, 11:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['damp', 'tps']}, 11:11:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['dromaeo_dom']}, 11:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['a11yr', 11:11:49 INFO - 'ts_paint', 11:11:49 INFO - 'tpaint', 11:11:49 INFO - 'sessionrestore', 11:11:49 INFO - 'sessionrestore_no_auto_restore', 11:11:49 INFO - 'tabpaint']}, 11:11:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tsvgx', 11:11:49 INFO - 'tsvgr_opacity', 11:11:49 INFO - 'tart', 11:11:49 INFO - 'tscrollx', 11:11:49 INFO - 'cart']}, 11:11:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:49 INFO - 'tsvgr_opacity', 11:11:49 INFO - 'tart', 11:11:49 INFO - 'tscrollx', 11:11:49 INFO - 'cart']}, 11:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s'], 11:11:49 INFO - 'tests': ['tp5o']}, 11:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'tests': ['tp5o']}, 11:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--disable-e10s', 11:11:49 INFO - '--xperf_path', 11:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:49 INFO - 'tests': ['tp5n']}, 11:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:49 INFO - 'talos_options': ['--xperf_path', 11:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:49 INFO - 'tests': ['tp5n']}}, 11:11:49 INFO - 'talos.zip': {'path': '', 11:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - ##### 11:11:49 INFO - ##### Running create-virtualenv step. 11:11:49 INFO - ##### 11:11:49 INFO - Running pre-action listener: _resource_record_pre_action 11:11:49 INFO - Running main action method: create_virtualenv 11:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:49 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 11:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:49 INFO - Using real prefix '/tools/python27' 11:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:53 INFO - Installing pip.................done. 11:11:53 INFO - Return code: 0 11:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:11: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 11:11: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 11:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:53 INFO - 'HOME': '/Users/cltbld', 11:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:53 INFO - 'LOGNAME': 'cltbld', 11:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:53 INFO - 'MOZ_NO_REMOTE': '1', 11:11:53 INFO - 'NO_EM_RESTART': '1', 11:11:53 INFO - 'PAGER': '/bin/cat', 11:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:53 INFO - 'PWD': '/builds/slave/test', 11:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:53 INFO - 'SHELL': '/bin/bash', 11:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:11:53 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:53 INFO - 'USER': 'cltbld', 11:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:53 INFO - 'XPC_FLAGS': '0x0', 11:11:53 INFO - 'XPC_SERVICE_NAME': '0', 11:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:53 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 11:11:53 INFO - Cleaning up... 11:11:53 INFO - Return code: 0 11:11:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', '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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:11: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:11: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 psutil>=0.7.1 11:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:53 INFO - 'HOME': '/Users/cltbld', 11:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:53 INFO - 'LOGNAME': 'cltbld', 11:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:53 INFO - 'MOZ_NO_REMOTE': '1', 11:11:53 INFO - 'NO_EM_RESTART': '1', 11:11:53 INFO - 'PAGER': '/bin/cat', 11:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:53 INFO - 'PWD': '/builds/slave/test', 11:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:53 INFO - 'SHELL': '/bin/bash', 11:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:11:53 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:53 INFO - 'USER': 'cltbld', 11:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:53 INFO - 'XPC_FLAGS': '0x0', 11:11:53 INFO - 'XPC_SERVICE_NAME': '0', 11:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:53 INFO - Downloading/unpacking psutil>=0.7.1 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:56 INFO - Installing collected packages: psutil 11:11:56 INFO - Running setup.py install for psutil 11:11:56 INFO - building 'psutil._psutil_osx' extension 11:11:56 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 11:11:56 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 11:11:56 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 11:11:56 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 11:11:56 INFO - building 'psutil._psutil_posix' extension 11:11:56 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 11:11:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:11:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:11:56 INFO - ^ 11:11:56 INFO - 1 warning generated. 11:11:56 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 11:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:57 INFO - Successfully installed psutil 11:11:57 INFO - Cleaning up... 11:11:57 INFO - Return code: 0 11:11:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11:57 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:11:57 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 11:11:57 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 11:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:57 INFO - 'HOME': '/Users/cltbld', 11:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:57 INFO - 'LOGNAME': 'cltbld', 11:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:57 INFO - 'MOZ_NO_REMOTE': '1', 11:11:57 INFO - 'NO_EM_RESTART': '1', 11:11:57 INFO - 'PAGER': '/bin/cat', 11:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:57 INFO - 'PWD': '/builds/slave/test', 11:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:57 INFO - 'SHELL': '/bin/bash', 11:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:11:57 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:57 INFO - 'USER': 'cltbld', 11:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:57 INFO - 'XPC_FLAGS': '0x0', 11:11:57 INFO - 'XPC_SERVICE_NAME': '0', 11:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11:57 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 11:11:57 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 11:11:57 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 11:11:57 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 11:11:57 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 11:11:57 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 11:11:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:11:59 INFO - Installing collected packages: mozsystemmonitor 11:11:59 INFO - Running setup.py install for mozsystemmonitor 11:12:00 INFO - Successfully installed mozsystemmonitor 11:12:00 INFO - Cleaning up... 11:12:00 INFO - Return code: 0 11:12:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:00 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:00 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 11:12:00 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 11:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:00 INFO - 'HOME': '/Users/cltbld', 11:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:00 INFO - 'LOGNAME': 'cltbld', 11:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:00 INFO - 'MOZ_NO_REMOTE': '1', 11:12:00 INFO - 'NO_EM_RESTART': '1', 11:12:00 INFO - 'PAGER': '/bin/cat', 11:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:00 INFO - 'PWD': '/builds/slave/test', 11:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:00 INFO - 'SHELL': '/bin/bash', 11:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:00 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:00 INFO - 'USER': 'cltbld', 11:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:00 INFO - 'XPC_FLAGS': '0x0', 11:12:00 INFO - 'XPC_SERVICE_NAME': '0', 11:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:00 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 11:12:00 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 11:12:00 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 11:12:00 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 11:12:00 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 11:12:00 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 11:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:03 INFO - Downloading docopt-0.6.1.tar.gz 11:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:04 INFO - Running setup.py install for blobuploader 11:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:04 INFO - Running setup.py install for requests 11:12:04 INFO - Running setup.py install for docopt 11:12:04 INFO - Successfully installed blobuploader requests docopt 11:12:04 INFO - Cleaning up... 11:12:04 INFO - Return code: 0 11:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:04 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:04 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 11:12:04 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 11:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:04 INFO - 'HOME': '/Users/cltbld', 11:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:04 INFO - 'LOGNAME': 'cltbld', 11:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:04 INFO - 'MOZ_NO_REMOTE': '1', 11:12:04 INFO - 'NO_EM_RESTART': '1', 11:12:04 INFO - 'PAGER': '/bin/cat', 11:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:04 INFO - 'PWD': '/builds/slave/test', 11:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:04 INFO - 'SHELL': '/bin/bash', 11:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:04 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:04 INFO - 'USER': 'cltbld', 11:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:04 INFO - 'XPC_FLAGS': '0x0', 11:12:04 INFO - 'XPC_SERVICE_NAME': '0', 11:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vtWRbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gtBo4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-iZFf7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-3unlxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-MkE5v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-81zb7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-LaXdrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:05 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-tQzDOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-UwqIVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-q9hT3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-D1psA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bjv9qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-UpHMUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-aLvdep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-t9zhas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bcjdRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:06 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-e2sr79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:07 INFO - Running setup.py install for manifestparser 11:12:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozcrash 11:12:07 INFO - Running setup.py install for mozdebug 11:12:07 INFO - Running setup.py install for mozdevice 11:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozfile 11:12:07 INFO - Running setup.py install for mozhttpd 11:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozinfo 11:12:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozInstall 11:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozleak 11:12:08 INFO - Running setup.py install for mozlog 11:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for moznetwork 11:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozprocess 11:12:08 INFO - Running setup.py install for mozprofile 11:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozrunner 11:12:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Running setup.py install for mozscreenshot 11:12:09 INFO - Running setup.py install for moztest 11:12:09 INFO - Running setup.py install for mozversion 11:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:09 INFO - Cleaning up... 11:12:09 INFO - Return code: 0 11:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:09 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:09 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 11:12:09 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 11:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:09 INFO - 'HOME': '/Users/cltbld', 11:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:09 INFO - 'LOGNAME': 'cltbld', 11:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:09 INFO - 'MOZ_NO_REMOTE': '1', 11:12:09 INFO - 'NO_EM_RESTART': '1', 11:12:09 INFO - 'PAGER': '/bin/cat', 11:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:09 INFO - 'PWD': '/builds/slave/test', 11:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:09 INFO - 'SHELL': '/bin/bash', 11:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:09 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:09 INFO - 'USER': 'cltbld', 11:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:09 INFO - 'XPC_FLAGS': '0x0', 11:12:09 INFO - 'XPC_SERVICE_NAME': '0', 11:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:09 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-a5B7z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:09 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)) 11:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:09 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-JL9tLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DdFZtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-unqDoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-cwJtWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FaMDiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-JUO4jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-RbuE9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-foZMeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jWQcW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:10 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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:10 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ejoo2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-cZzT_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-usQD5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bynVbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-xg4PWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-O3Otwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-BSyetn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:11 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)) 11:12:11 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)) 11:12:11 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)) 11:12:11 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)) 11:12:11 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)) 11:12:11 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)) 11:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:11 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 11:12:14 INFO - Downloading blessings-1.6.tar.gz 11:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:14 INFO - Installing collected packages: blessings 11:12:14 INFO - Running setup.py install for blessings 11:12:14 INFO - Successfully installed blessings 11:12:14 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:14 INFO - Reading from file tmpfile_stdout 11:12:14 INFO - Current package versions: 11:12:14 INFO - blessings == 1.6 11:12:14 INFO - blobuploader == 1.2.4 11:12:14 INFO - docopt == 0.6.1 11:12:14 INFO - manifestparser == 1.1 11:12:14 INFO - mozInstall == 1.12 11:12:14 INFO - mozcrash == 0.17 11:12:14 INFO - mozdebug == 0.1 11:12:14 INFO - mozdevice == 0.48 11:12:14 INFO - mozfile == 1.2 11:12:14 INFO - mozhttpd == 0.7 11:12:14 INFO - mozinfo == 0.9 11:12:14 INFO - mozleak == 0.1 11:12:14 INFO - mozlog == 3.1 11:12:14 INFO - moznetwork == 0.27 11:12:14 INFO - mozprocess == 0.22 11:12:14 INFO - mozprofile == 0.28 11:12:14 INFO - mozrunner == 6.11 11:12:14 INFO - mozscreenshot == 0.1 11:12:14 INFO - mozsystemmonitor == 0.0 11:12:14 INFO - moztest == 0.7 11:12:14 INFO - mozversion == 1.4 11:12:14 INFO - psutil == 3.1.1 11:12:14 INFO - requests == 1.2.3 11:12:14 INFO - wsgiref == 0.1.2 11:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:14 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')]} 11:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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')]} 11:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:14 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 11:12:14 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 11:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:14 INFO - 'HOME': '/Users/cltbld', 11:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:14 INFO - 'LOGNAME': 'cltbld', 11:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:14 INFO - 'MOZ_NO_REMOTE': '1', 11:12:14 INFO - 'NO_EM_RESTART': '1', 11:12:14 INFO - 'PAGER': '/bin/cat', 11:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:14 INFO - 'PWD': '/builds/slave/test', 11:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:14 INFO - 'SHELL': '/bin/bash', 11:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:14 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:14 INFO - 'USER': 'cltbld', 11:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:14 INFO - 'XPC_FLAGS': '0x0', 11:12:14 INFO - 'XPC_SERVICE_NAME': '0', 11:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 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)) 11:12:14 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:14 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')]} 11:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 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')]} 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:15 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:15 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 11:12:15 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 11:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:15 INFO - 'HOME': '/Users/cltbld', 11:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:15 INFO - 'LOGNAME': 'cltbld', 11:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:15 INFO - 'MOZ_NO_REMOTE': '1', 11:12:15 INFO - 'NO_EM_RESTART': '1', 11:12:15 INFO - 'PAGER': '/bin/cat', 11:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:15 INFO - 'PWD': '/builds/slave/test', 11:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:15 INFO - 'SHELL': '/bin/bash', 11:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:15 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:15 INFO - 'USER': 'cltbld', 11:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:15 INFO - 'XPC_FLAGS': '0x0', 11:12:15 INFO - 'XPC_SERVICE_NAME': '0', 11:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:15 INFO - Downloading/unpacking jsonschema 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:17 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:18 INFO - warning: no files found matching '*.txt' 11:12:18 INFO - no previously-included directories found matching 'build' 11:12:18 INFO - no previously-included directories found matching 'dist' 11:12:18 INFO - no previously-included directories found matching '.git*' 11:12:18 INFO - Installing collected packages: jsonschema, functools32 11:12:18 INFO - Running setup.py install for functools32 11:12:18 INFO - warning: no files found matching '*.txt' 11:12:18 INFO - no previously-included directories found matching 'build' 11:12:18 INFO - no previously-included directories found matching 'dist' 11:12:18 INFO - no previously-included directories found matching '.git*' 11:12:18 INFO - Successfully installed jsonschema functools32 11:12:18 INFO - Cleaning up... 11:12:18 INFO - Return code: 0 11:12:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:18 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 0x10ab18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab28420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360cab530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, '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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 11:12:18 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 11:12:18 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 11:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:18 INFO - 'HOME': '/Users/cltbld', 11:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:18 INFO - 'LOGNAME': 'cltbld', 11:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:18 INFO - 'MOZ_NO_REMOTE': '1', 11:12:18 INFO - 'NO_EM_RESTART': '1', 11:12:18 INFO - 'PAGER': '/bin/cat', 11:12:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:18 INFO - 'PWD': '/builds/slave/test', 11:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:18 INFO - 'SHELL': '/bin/bash', 11:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:18 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:18 INFO - 'USER': 'cltbld', 11:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:18 INFO - 'XPC_FLAGS': '0x0', 11:12:18 INFO - 'XPC_SERVICE_NAME': '0', 11:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:18 INFO - Downloading/unpacking flake8 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:21 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 11:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:22 INFO - no previously-included directories found matching 'docs/_build' 11:12:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:22 INFO - Running setup.py install for pep8 11:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:22 INFO - no previously-included directories found matching 'docs/_build' 11:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:22 INFO - Cleaning up... 11:12:22 INFO - Return code: 0 11:12:22 INFO - Running post-action listener: _resource_record_post_action 11:12:22 INFO - Running post-action listener: _start_resource_monitoring 11:12:22 INFO - Starting resource monitoring. 11:12:22 INFO - ##### 11:12:22 INFO - ##### Running install step. 11:12:22 INFO - ##### 11:12:22 INFO - Running pre-action listener: _resource_record_pre_action 11:12:22 INFO - Running main action method: install 11:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:23 INFO - Reading from file tmpfile_stdout 11:12:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:23 INFO - Reading from file tmpfile_stdout 11:12:23 INFO - Output received: 11:12:23 INFO - Usage: mozinstall [options] installer 11:12:23 INFO - Options: 11:12:23 INFO - -h, --help show this help message and exit 11:12:23 INFO - -d DEST, --destination=DEST 11:12:23 INFO - Directory to install application into. [default: 11:12:23 INFO - "/builds/slave/test"] 11:12:23 INFO - --app=APP Application being installed. [default: firefox] 11:12:23 INFO - mkdir: /builds/slave/test/build/application 11:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:12:45 INFO - Reading from file tmpfile_stdout 11:12:45 INFO - Output received: 11:12:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:12:45 INFO - Running post-action listener: _resource_record_post_action 11:12:45 INFO - ##### 11:12:45 INFO - ##### Running run-tests step. 11:12:45 INFO - ##### 11:12:45 INFO - Running pre-action listener: _resource_record_pre_action 11:12:45 INFO - Running main action method: run_tests 11:12:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:45 INFO - 2016-07-18 11:12:45.458 screenresolution[1914:15060] starting screenresolution argv=screenresolution get 11:12:45 INFO - 2016-07-18 11:12:45.460 screenresolution[1914:15060] Display 0: 1600x1200x32@60 11:12:45 INFO - 2016-07-18 11:12:45.466 screenresolution[1915:15063] starting screenresolution argv=screenresolution list 11:12:45 INFO - Available Modes on Display 0 11:12:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:45 INFO - Intel Iris: 11:12:45 INFO - Chipset Model: Intel Iris 11:12:45 INFO - Type: GPU 11:12:45 INFO - Bus: Built-In 11:12:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:45 INFO - Vendor: Intel (0x8086) 11:12:45 INFO - Device ID: 0x0a2e 11:12:45 INFO - Revision ID: 0x0009 11:12:45 INFO - Displays: 11:12:45 INFO - Display: 11:12:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:45 INFO - Display Serial Number: 1600x1200 60 11:12:45 INFO - Main Display: Yes 11:12:45 INFO - Mirror: Off 11:12:45 INFO - Online: Yes 11:12:45 INFO - Rotation: Supported 11:12:45 INFO - Return code: 0 11:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:45 INFO - Python 2.7.3 11:12:45 INFO - Return code: 0 11:12:45 INFO - grabbing minidump binary from tooltool 11:12: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')]} 11:12:45 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 0x10a9b7e00>, '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 0x10a820db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:45 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 11:12:45 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 11:12:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:45 INFO - Return code: 0 11:12:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:12:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:12:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:12:46 INFO - Return code: 0 11:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7aBZ1K7rDo/Render', 11:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:46 INFO - 'HOME': '/Users/cltbld', 11:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:46 INFO - 'LOGNAME': 'cltbld', 11:12:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:46 INFO - 'MOZ_NO_REMOTE': '1', 11:12:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:46 INFO - 'NO_EM_RESTART': '1', 11:12:46 INFO - 'PAGER': '/bin/cat', 11:12:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:46 INFO - 'PWD': '/builds/slave/test', 11:12:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:46 INFO - 'SHELL': '/bin/bash', 11:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZgQjKqySdg/Listeners', 11:12:46 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 11:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:46 INFO - 'USER': 'cltbld', 11:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:46 INFO - 'XPC_FLAGS': '0x0', 11:12:46 INFO - 'XPC_SERVICE_NAME': '0', 11:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:12:47 INFO - mozversion application_buildid: 20160718082851 11:12:47 INFO - mozversion application_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 11:12:47 INFO - mozversion application_display_name: Firefox 11:12:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:47 INFO - mozversion application_name: Firefox 11:12:47 INFO - mozversion application_remotingname: firefox 11:12:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:47 INFO - mozversion application_vendor: Mozilla 11:12:47 INFO - mozversion application_version: 48.0 11:12:47 INFO - mozversion platform_buildid: 20160718082851 11:12:47 INFO - mozversion platform_changeset: 0f4257230dffa106e90cf736df9dbe9859ac5274 11:12:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:12:47 INFO - mozversion platform_version: 48.0 11:12:47 INFO - using testdate: 1468865567 11:12:47 INFO - actual date: 1468865567 11:12:47 INFO - starting webserver on 'localhost:52197' 11:12:47 INFO - SUITE-START | Running 2 tests 11:12:47 INFO - TEST-START | dromaeo_css 11:12:47 INFO - operating with platform_type : mac_ 11:12:47 INFO - Initialising browser for dromaeo_css test... 11:12:47 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpH10GKo/profile http://localhost:52197/getInfo.html) 11:12:50 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 11:12:50 INFO - PROCESS | 1933 | colorDepth:24 11:12:50 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 11:12:50 INFO - PROCESS | 1933 | __metrics 11:12:50 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:12:50 INFO - TEST-INFO | 1933: exit 0 11:12:50 INFO - Browser initialized. 11:12:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:50 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpH10GKo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:02 INFO - PROCESS | 1937 | RSS: Main: 171151360 11:13:02 INFO - PROCESS | 1937 | 11:13:52 INFO - PROCESS | 1937 | 1468865632427 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] 11:16:02 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52197/tests/dromaeo/cssquery-ext.html) 11:16:03 INFO - PROCESS | 1937 | RSS: Main: 183214080 11:16:03 INFO - PROCESS | 1937 | 11:19:05 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-ext.html (next: http://localhost:52197/tests/dromaeo/cssquery-jquery.html) 11:19:06 INFO - PROCESS | 1937 | RSS: Main: 192786432 11:19:06 INFO - PROCESS | 1937 | 11:22:08 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52197/tests/dromaeo/cssquery-mootools.html) 11:22:08 INFO - PROCESS | 1937 | RSS: Main: 194875392 11:22:08 INFO - PROCESS | 1937 | 11:25:10 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52197/tests/dromaeo/cssquery-prototype.html) 11:25:11 INFO - PROCESS | 1937 | RSS: Main: 198610944 11:25:11 INFO - PROCESS | 1937 | 11:28:13 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52197/tests/dromaeo/cssquery-yui.html) 11:28:14 INFO - PROCESS | 1937 | RSS: Main: 197763072 11:28:14 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52197/tests/dromaeo/cssquery-yui.html (next: http://localhost:52197/tests/dromaeo/cssquery-dojo.html) 11:31:16 INFO - PROCESS | 1937 | RSS: Main: 203362304 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | __start_tp_report 11:31:16 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 11:31:16 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 11:31:16 INFO - PROCESS | 1937 | |i|pagename|runs| 11:31:16 INFO - PROCESS | 1937 | |0;dojo.html;3617.5297211362517;3652.214773823627;3669.1560940983563;3688.317661232672;3717.572479164897;6014.278286605602;6050.485708714759;6065.909011364833;6076.027835546313;6102.786402475915;6040.57715959883;6062.120992456103;6062.151298818169;6105.084237364397;6112.938870611292;5403.945960540394;5433.212184233284;5474.589405794562;5545.306836645419;5602.327720673505;3994.320965435883;4566.885827854297;5505.981393442226;5515.090010148341;5531.889362212753;5474.260974768415;5482.835514934558;5501.119820828668;5568.470995255444;5615.241942337793;4505.36924830524;5545.390007099236;5595.580331475156;5599.916001259984;5609.251466781288;4010.8997275068064;5433.212184233304;5438.972805135989;5507.091329930557;5532.28080349556;5674.347450043257;5682.6306290091015;5870.765169393219;6008.639481631072;6050.273967123973;5118.872028199287;5996.2504686914135;6149.723262453201;6198.659073750942;6272.6236425814595;4776.8566942991765;5408.8377348679205;6226.034964580497;6391.904121438182;6412;6021.916055110079;6130.203073600448;6160.291566469824;6183.103449999815;6200.224971878515;6602.636854972927;6611.140551728245;6659.733610655617;6669.299723529057;6672.499562532732;6222.875542489125;6277.811665650038;6299.590526615755;6347.270063942613;6348.682565871688;6395.712192951329;6457.806265812033;6482.67586620667;6487.870242595121;6490.091387205795;6347.1114044033875;6367.777127800598;6381.712822922979;6392.904106438407;6396.136521569621;6211.192544969215;6283.08895210192;6356.650384228912;6395.840103997437;6398.264199617103;5068.974655126774;5135.435102138762;5155.200943853709;5163;5188.92216616751;4626.976865115653;4633.027064316464;4662.184117779443;4664.79008444614;4665.440147182359;6040.848978775566;6122.479589234876;6146.754129834757;6194.0708893666315;6218.502519798405;6409.391107844747;6433.324500927335;6545.541812073205;6569.638669873203;6577.112089867902;6195.96902015487;6199.411055949678;6212.689365531795;6214.316425193225;6225.906611400833;5579.944200558024;5653.265075540154;5743.8564035899435;5745.626534275259;5747.626404283708;6662.967240077795;6731;6737.124173857564;6746.0892779475125;6761.72953081881;6517.9348206517325;6534.019897015486;6550.213974323112;6576.44100251484;6592.868142637216;6529.934700652932;6608.240052393844;6673.632950187592;6719.4624430044505;6719.899201511884;6356.68216589178;6392.840178995562;6412.807615771534;6420.518461115528;6432.807015789534;6454.903176452451;6520.445762110274;6531.934680653323;6533.575317604341;6539.738410463528;6092.543059270661;6241.095041219089;6242.750289988349;6303.149074874833;6339.904901426575;6275.152854364603;6305.306416294112;6316.84207894788;6333.303336633059;6356.396142366468;5829.6793676346515;6000.279966404059;6221.844453888689;6230.034344676583;6253.906191407042;6222.12890195364;6257.624542527281;6265.592736472115;6299.96850015747;6324.367563243639;5146.433892271922;6159.19930409044;6186.845328866814;6217.844553886189;6219.471344935731 11:31:16 INFO - PROCESS | 1937 | |1;ext.html;539.7625044980208;543.5841581190389;548.8106603221888;556.4713522153954;614.9108379285001;39447.21105577887;40145.99635009126;40245.798771006106;40246.99382515435;40288.59711402885;34308.65691343086;41471;41979.79010104945;42013.159736805246;42115.9471013224;8330.541820199887;9618.711438656852;9813.950930245375;9841.803163936753;9861.063198996084;9028.368014239006;9834.803303933917;9897.208223342152;9927.702168934944;9968.501574921262;9854.40873547586;9954.60181592739;9976.700698979006;9981.30130890838;9985.850212246785;9874.901250987507;9949.204063674888;9971.252156088321;9972.750681232954;9984.750381240454;9769.413835169842;9895.901040989569;9901.257405694601;9903.504824758806;9926.751831204205;40162.598374016474;40516;40539.797301013605;40815.387769183486;41073.38389924153;3365.6634336566394;3549.804760738158;3877.8836634901;3916.4516967624554;4047.352423612208;27138;27627.03305384322;28069.85965070182;28635.427291454052;29150.85424572885;2500.8874600642835;2750.147454289177;2779.12457575865;2788.1635509347316;2812.0439050722853;308087;308904;311037;311085;311554.44222778967;37862.62137378646;63651;64192.67903660452;64217.35782642207;64223;36405.45391819125;36536.634633653324;36542.08644783848;36847.4472882907;36934.8153259232;16165.595860103356;16481.25834337458;16519;16541.25564349607;16549.58626034359;13625.454981800814;13870.306484675726;13987.160770353812;14016.229107399191;14073.577792666236;8229.218224268685;8255.215754503313;8357.247847693616;8413.200745929127;8594.398392112616;3098.5816914716224;3116.4546204414137;3579.069441945061;3618.945715814265;3642.8542858285373;1041.3543602966058;1066.2802608239563;1087.6791346552786;1119.9496022679;1246.4328730427633;30865.537016944763;30929.381412372077;30985;31482.212944676106;31727.68272317247;1067.236925598201;1132.9407004450866;1228.7419641875128;1234.8888600025862;1266.474413118564;14549.854501455062;14651.681348678458;15904;15978.755992282038;16043.117628530543;656794.7160264169;658242;666221;669027;669485;62440.37559624436;62888.68555657192;64165.03752443717;64246.71506569842;64359.03461448082;1538.692261547695;1538.8230353509266;1546.5592306192682;1548.783170356151;1552.8757699384023;26094;26149.73850261549;29760.255993600334;30673.53989690201;31312.373752525276;53630;53966.73016634892;54104.72947635237;54178.45821541734;54364;578392;581088;583381;584306;585155;27175.320616984733;27404;27776.16671499858;27900;28225.576616351183;46963.530364695915;47556.7622161887;47763.28355074607;48284;48725;35359.292814144086;36247.63752362443;38926.4161037579;39267.018324542114;39984;37678.24643507169;38500.80749596234;38714.4192837102;38818;39080.804595976835;33917;38070.61929380671;38935.80532097322;39565.2086958265;39723;31886.681133188373;33589.66410335963;33883;34058.65941340654;34115.488267676505;25628.487430251662;25748.8712556436;25785.097521586653;25845;25958.09146679857 11:31:16 INFO - PROCESS | 1937 | |2;jquery.html;364.6408287836482;414.2295330684926;417.5782459715686;418.58978201362663;424.6560286168204;15213.315400806963;20156.89921550392;20205.797942020574;20227.190912363505;20468.69296960547;17111.486655400357;20539.383818485432;20720.585588288224;20869.895650521725;21703.674444883338;5756.481916627492;5798.62308949919;6024.337322894478;6060.545459090564;6064.9090263646085;5444.863878403032;5936.079907614305;5984.611000284989;6048;6067.18093057436;5790.7683692652245;5897.41025897409;6018.458338749511;6054.909176362358;6062.848428789272;5877.500412464946;5917.9408205918035;5934.762609495615;5952.494038006775;5995.6702381369005;5262.105442074818;5263.973680131613;5265.86835329116;5607.971960140214;5939.376365481606;14022.368993395321;14034.578962631138;14280.785788213185;14465.20441375724;19370.70943935842;2230.8996095175758;2354.5644055849552;2422.1522467136538;2726.127639155471;2758.2828464599147;9935.850962235572;10036.799264014679;10260.02529759679;10355.689329320132;10422.739431514197;1712.3578658003248;1790.3912669692236;1804.5127815489743;1851.7685289338833;1890.735297058413;120952;122061;123858.14212786815;126189;126305.10542341872;11753.4710938008;12028.097892658086;12098.63704088861;12180.147389682637;12276.44755985965;15586.986845854983;15626.531204063896;15666.686666266838;15676.92161539185;15716.842831571767;9341.626334946526;9348.1119293667;9378.062193780568;9423.340366174301;9462.432254064779;7137.536060156073;7800.609969501502;9406.153446189875;9473.810523789485;9535.046495350549;4022.91954160921;4842.903141937141;4872.926906096412;4890.706557606555;4897.8285759998225;1789.973150402745;2026.493376655836;2074.6576814825385;2086.9895650521953;2095.302804728175;915.8900931888217;951.6859436385976;1042.3902017319801;1053.5680371047833;1063.4416931111073;20017.59964800696;20558.79441205569;20818.375448736562;21004.054817533248;21196.57606847885;926.6617684545092;964.6141543382703;981.4111533080095;998.9012086704712;1075.800976819291;9411.43531388119;11079.446027698745;11091.55633774656;11126.49930753102;11163.218574699855;513146;520963;521184;610308;661604;75958;77025.61487192528;129654;132755.33622331827;137006.31496842453;1041.8333066709442;1060.6552870317178;1075.6826736112866;1082.6481393547128;1083;18311;18560.628787423906;18837;18841.15214815364;18894.811051889305;51833.48166518437;52120;54609.18086228789;57311.56721082006;57415;79044.60477697574;82887.34225315339;83812;84061.15938840777;84156.31687366097;8314.87527687073;8528.74413767588;8534.658613655385;8645.654173832976;8910.930688317443;9710.951445242728;13220.669483262995;13234.933825330812;13320.467181313026;13670.589882303548;11330.150238731963;11451.770964580495;11485.942570287096;11556.537738490366;11860.644180674593;10861.131109511061;10891.346519208873;11127.332360058423;11370.31778093317;11419.657410277705;11385.487653055798;11642.185047046964;11944.343061131374;12002.519899204284;12004;8359.414840961317;8486.957565212135;8623.396362254582;8661.52361620117;8799.560021999003;10946.452677366258;11156.721081973015;11243.49404276826;11357.943210283896;11596.76806463849 11:31:16 INFO - PROCESS | 1937 | |3;mootools.html;1602.7115119278528;1615.6687878984806;1877.8216069473394;1976.4268362174978;2031.705402716607;8208.958955205215;8896.332775041881;9143.45139291643;9352.906470935288;9353.345265831385;9048.321375896801;9119.817603647924;9210;9220.031896650855;9268.49023303718;2360.3509035015336;2374.3707917401903;2392.1149174805346;2403.555342261687;2405.0379848060743;2533.100749234023;2543.9491210175784;2545.8217924745277;2576.6521519594894;2579.3551612096976;2545.0583284184786;2564.948701025978;2565.576679847823;2566.602176662611;2571.048711976562;2546.0834099723993;2555.8338707984017;2562.5643640581147;2570.434504409027;2601.6877974642975;2550.795936325108;2582.8708564571884;2585.7026441959038;2586.3921978335075;2600.9479810403877;9390.436573805593;9402.529873506297;9411.529423528864;9437.245020398352;9472.479013654247;4876.853939324256;5673.26247587815;5697.03150464422;5805.564582656318;5824.776796872619;3236.951445728316;3697.950893123855;3786.8863934081746;3845.6346647068485;3858.3633700439395;1062.5696592879897;1081.259337353915;1082.1991726122692;1083.6099004358425;1086.6522712731928;10662.413567253798;12266.570670026505;12669.74660506794;12698.873011269861;12705.745885082246;4330.848420305274;4986.227134794112;5039.370078740158;5112.335396398519;5121.923171152435;9098;10416.479176041168;10701.357918524758;10715.732106697395;10725.195610329256;5644.6330988485615;5689.061304884648;5767.653940763567;5831.941680583224;5902.58681892272;4639.536046395401;5103.948960510422;5139.640225184201;5215.269862219292;5232.529072383504;3700.666939975415;4128.339465685536;4152.96175956011;4160.315072395684;4252.425922500484;1408.0425310788557;1419.22652154576;1421.8435972043067;1426.3082405033551;1437.5112461763051;969.3650658818485;978.9070038346346;980.6910823090703;996.1681995533665;1014.8224060789332;6111.908321375183;6133.723982420802;6164.506839452833;6244;6266.811995640047;473.4768081270147;486.46488862251243;496.63249195595;499.9325091112726;501.4308759557928;4082.857100001486;4118.279301122351;4141.213169497786;4149.398337241083;4149.481314835645;10759;11169.329840209613;11216.439178041066;11236.820133885987;11285;10925.399103049409;10960.835587466194;10994.835077473845;11037.613683521038;11088.611898583511;8630.395872289006;8668.046514883357;8692.695755648521;8726.781830454163;8746.56267186638;5735.627184233178;5936.079907614327;5978.880422391615;5985.25184351956;6086.269647642312;9710.902890971283;9711.56297966579;9770.609175632895;9798.216142708423;9899.505024748878;9489.525523723649;10116.89883101189;10219.080282774587;10264.538095785558;10393.9480302598;6848.383645471931;7677.347425468898;7697.692092316244;7698.8845167321415;7728;8609.612567434606;8629.784255393666;8649.740507784776;8650.351223658377;8655;7561.6597253122645;7631.847363052597;7709.845803084019;7735.419843511647;7797.142314345531;7409.333160015624;7422.66598003102;7458.216887226763;7486;7635.961820190863;7194.712211511481;7199.1361036675935;7229.638518074181;7258.237885021997;7261.128664560287;4523.773811309487;4536.047430039728;5020.874478138076;5200.323957885602;5205.817796377109;4424.579664931826;5175.120229561059;5209.869753256199;5233.921491177712;5260.736963151904 11:31:16 INFO - PROCESS | 1937 | |4;prototype.html;319.9392115498055;331.9593075707656;334.1712552868885;342.13439996808074;343.33050551424714;5912.231409916711;6788.049673045777;6807.625580593065;6903.758368457099;6925.203601585819;6719.160104986877;6783.6269005204695;6800.183977922644;6828.351306625875;6872.656367181646;5093.108705976458;5117.385913690362;5117.872053198663;5123.590112790967;5126.71803050832;4120.402541631462;5112.130937740574;5120.257562653413;5120.334356533645;5128.769205385748;4056.817443215062;5080.568151707109;5091.312672789181;5092.210707340369;5113.130767769489;4242.681798865097;4399.076193999264;4525.751083690396;4972.925406118911;5123.5901127909865;3881.8548528184256;4106.7125301228925;4354.390385346054;4364.345348197764;4365.80353884076;5265.921011184835;6583.506237032242;6590.34096590342;6612.669366531654;6645.435138013275;5976.790812321591;5995.730192141364;5997.22036135304;6000.909986350208;6010.75956961721;7306.164263761514;7315.670794814193;7339.192688804227;7350.264973502661;7352.595607241599;4703.294505824119;4862.975685121587;4864.659473836833;4892.192788189945;4893.608511319086;6877.4841886858685;7687.923120768776;7711.460197786158;7774.455788094836;7779;4611.723296602215;4960.759810047488;4963.6277279204205;4964.081644895706;4968.751562421864;5066.265391518209;5070.239464080344;5073.909109541466;5075.441701412841;5099.974500127476;5945.762169513171;5968.253968253968;5970.134330522137;5975.7609695612555;5991.221141251609;7107.324804143598;7360.521566098187;7362.889556656654;7415.439504704568;7417.629118544051;1737;1755.6313174233298;1764.80587135415;1774.5208793625907;1777.7244527098321;1051.8632577764995;1104.8729396119388;1121.3272036777869;1148.4257871064467;1150.2810743285447;6776.93223067763;6910.689018994158;6933.653317334113;6959.791206263821;6962.825929351706;7635.465517413839;7653.387728981668;7664.961675191588;7697.769066928001;7724.764037753933;6884.139482564679;6898.965505172442;6902.413294869892;6905.965470172617;6915.688794004182;3896.5518965318784;4033.6369726724733;4078.7552746835286;4084.5302790178916;4091.6112969268465;7970.840583188304;8011.198880111942;8036.517808931366;8045.718399855977;8054.919450805534;7868.488548244461;7917.049954005441;7953.244441778022;7955.761327160194;7965.641546130438;7272.727272727251;7660.770176894702;7977.162397948248;8027.6788928443375;8056.436049476481;7504.549727016397;7676.424268179797;7741.496802707806;7745.148033716399;7788.649510772142;7564.357029652541;7583.090029196532;7610.374420824806;7611.885821712568;7626.466147369631;6605.867882642417;7895.6841726332605;8048.315893149148;8070.83858322842;8098.271155596025;4739.099571081483;4774.641901857305;4784.612462386009;4792.137415265286;4795.472498025284;7495.887561686688;7555.848883022199;7664.156942736183;7730.304272615266;7757.961210193913;7358.300961408871;7402.9629851850395;7412.221716719667;7419.591922444318;7462.328390444886;7397.297256760599;7407.074115735533;7416.7774966751085;7427.925720742724;7434.553926764412;7005.754798582026;7214.639268036683;7227.205007449282;7231.819204519929;7263;7413.036305280279;7416.998705174949;7418.888716669362;7434.145073316421;7440.962795186206;6295.527835412271;6855.800234958962;6947.652617369213;7049.859002820018;7268.600226987355 11:31:16 INFO - PROCESS | 1937 | |5;yui.html;714.1608609883385;747.6373958630063;750.3546949623319;769.361430013089;782.3311069035973;15327.003744756597;15679.29443175057;15684.215789210522;15716.607084822885;15726.135062571553;14451.710965780678;14458;14538.491152809655;14570.12579245246;14570.490032848853;769.20387399042;940.0505489455664;948.4641177734593;961.2694352292273;971.3249291742242;960.4237457525498;963.3930623707055;964.3924327673591;970.6020531582053;970.8834939807198;1030.0832259289239;1031.8813336466328;1036.0675392147052;1036.1762398892897;1039.0544604409988;1002.2182697495929;1023.1661196125172;1025.9179265658804;1028.9588416463332;1032.1072272484323;752.4168769203856;759.1459607941066;761.3072104384983;762.4853224073784;763.6601712238056;15017.399304027826;15156.848431515655;15303.46437874669;15352.385904563804;15416.3833446662;11914.940425297904;12877.67805804853;13073.411696473586;13113;13247.73504529904;9210.907890921071;9416.869975602904;10071.143952764023;10149.64476243328;10416.32293900894;3579.069441945113;3605.4591811228524;3632.673059424638;3668.5047518584915;3825.08198032473;86138;86379.56810215971;89726;90619.64070538947;91052.08947910502;9549.809003819884;9624.66313679018;9733.853992190123;9736.464494452874;10072.043155900177;21866.562668746537;22140.55718885613;22150.33548993533;22192;22203.333899983027;7490.625468726542;7545.320921117016;7589.5066820657585;7616.885746713804;7700.499467534592;4039.535453422894;4063.2889244382113;4081.7959102045374;4089.2230476209425;4101.507819061672;3650.452432135201;3658.213484100878;3681.3189559931498;3684.9631503685155;3739.8317075731657;601.9097135429633;602.4758460139707;615.3385111005687;615.5352708704988;627.1470799712388;499.6951859365784;565.1438071321951;613.1477246627192;618.6473709985355;627.4133685004444;7771.911932329478;7838.176991415819;8433.493990360597;8509.276711479593;8661.437006594551;605.6214865708932;616.3435940723116;625.7497001199556;626.0952923026183;647.1102234427661;3523.5419395478425;3832.80835958201;3893.766374017568;3982.9601703983167;4010.939835902464;96146.51926740322;96470.51764741131;97361.05277894544;99581.50209248907;99743;77467.61266193633;78954;79850.6007469959;80486.39027219423;84810.15189848146;55253.723731381084;71398.2860171402;71978.64010679912;73264.26735732575;74325;6813.659317034228;6897.379235868796;7783.571903545359;7978.84042319162;8000.319972802377;50923.47229583118;50991.49008510016;51203.231951520014;51959;53272.46727532675;57726.7113664429;66470.33824154435;70188.59622807617;70629;71272.64363678149;10204.38773673582;10396;10440.843387349349;10451.634192803216;10519.579216831547;10893;11052.944735276273;11214.775704486028;11275.267107637977;11284.21010529255;8808.471491710518;10343.431111288952;10484.528196231035;10543.57825686964;10833.133349332193;9560.952195238979;10112.393256404639;10197.74505637365;10604.8939510607;10700.464976751287;9969.30214884951;10386.844197337197;10497.947510262706;10562.947185264025;10654.307470014424;8909.688160914337;8951.328650351119;9102.772430689021;9159.450432974043;9319.813603728024;9016.143466370684;9078.04680508537;9171.266298695955;9180.495072771062;9327.067293270618 11:31:16 INFO - PROCESS | 1937 | __end_tp_report 11:31:16 INFO - PROCESS | 1937 | __start_cc_report 11:31:16 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,395 11:31:16 INFO - PROCESS | 1937 | __end_cc_report 11:31:16 INFO - PROCESS | 1937 | __startTimestamp1468866676549__endTimestamp 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | ------- Summary: start ------- 11:31:16 INFO - PROCESS | 1937 | Number of tests: 6 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5952.49 Median:6200.22 stddev:690.27 (11.1%) stddev-sans-first:667.64 11:31:16 INFO - PROCESS | 1937 | Values: 3617.5 3652.2 3669.2 3688.3 3717.6 6014.3 6050.5 6065.9 6076.0 6102.8 6040.6 6062.1 6062.2 6105.1 6112.9 5403.9 5433.2 5474.6 5545.3 5602.3 3994.3 4566.9 5506.0 5515.1 5531.9 5474.3 5482.8 5501.1 5568.5 5615.2 4505.4 5545.4 5595.6 5599.9 5609.3 4010.9 5433.2 5439.0 5507.1 5532.3 5674.3 5682.6 5870.8 6008.6 6050.3 5118.9 5996.3 6149.7 6198.7 6272.6 4776.9 5408.8 6226.0 6391.9 6412.0 6021.9 6130.2 6160.3 6183.1 6200.2 6602.6 6611.1 6659.7 6669.3 6672.5 6222.9 6277.8 6299.6 6347.3 6348.7 6395.7 6457.8 6482.7 6487.9 6490.1 6347.1 6367.8 6381.7 6392.9 6396.1 6211.2 6283.1 6356.7 6395.8 6398.3 5069.0 5135.4 5155.2 5163.0 5188.9 4627.0 4633.0 4662.2 4664.8 4665.4 6040.8 6122.5 6146.8 6194.1 6218.5 6409.4 6433.3 6545.5 6569.6 6577.1 6196.0 6199.4 6212.7 6214.3 6225.9 5579.9 5653.3 5743.9 5745.6 5747.6 6663.0 6731.0 6737.1 6746.1 6761.7 6517.9 6534.0 6550.2 6576.4 6592.9 6529.9 6608.2 6673.6 6719.5 6719.9 6356.7 6392.8 6412.8 6420.5 6432.8 6454.9 6520.4 6531.9 6533.6 6539.7 6092.5 6241.1 6242.8 6303.1 6339.9 6275.2 6305.3 6316.8 6333.3 6356.4 5829.7 6000.3 6221.8 6230.0 6253.9 6222.1 6257.6 6265.6 6300.0 6324.4 5146.4 6159.2 6186.8 6217.8 6219.5 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:65160.25 Median:21296.15 stddev:145064.93 (681.2%) stddev-sans-first:145390.74 11:31:16 INFO - PROCESS | 1937 | Values: 539.8 543.6 548.8 556.5 614.9 39447.2 40146.0 40245.8 40247.0 40288.6 34308.7 41471.0 41979.8 42013.2 42115.9 8330.5 9618.7 9814.0 9841.8 9861.1 9028.4 9834.8 9897.2 9927.7 9968.5 9854.4 9954.6 9976.7 9981.3 9985.9 9874.9 9949.2 9971.3 9972.8 9984.8 9769.4 9895.9 9901.3 9903.5 9926.8 40162.6 40516.0 40539.8 40815.4 41073.4 3365.7 3549.8 3877.9 3916.5 4047.4 27138.0 27627.0 28069.9 28635.4 29150.9 2500.9 2750.1 2779.1 2788.2 2812.0 308087.0 308904.0 311037.0 311085.0 311554.4 37862.6 63651.0 64192.7 64217.4 64223.0 36405.5 36536.6 36542.1 36847.4 36934.8 16165.6 16481.3 16519.0 16541.3 16549.6 13625.5 13870.3 13987.2 14016.2 14073.6 8229.2 8255.2 8357.2 8413.2 8594.4 3098.6 3116.5 3579.1 3618.9 3642.9 1041.4 1066.3 1087.7 1119.9 1246.4 30865.5 30929.4 30985.0 31482.2 31727.7 1067.2 1132.9 1228.7 1234.9 1266.5 14549.9 14651.7 15904.0 15978.8 16043.1 656794.7 658242.0 666221.0 669027.0 669485.0 62440.4 62888.7 64165.0 64246.7 64359.0 1538.7 1538.8 1546.6 1548.8 1552.9 26094.0 26149.7 29760.3 30673.5 31312.4 53630.0 53966.7 54104.7 54178.5 54364.0 578392.0 581088.0 583381.0 584306.0 585155.0 27175.3 27404.0 27776.2 27900.0 28225.6 46963.5 47556.8 47763.3 48284.0 48725.0 35359.3 36247.6 38926.4 39267.0 39984.0 37678.2 38500.8 38714.4 38818.0 39080.8 33917.0 38070.6 38935.8 39565.2 39723.0 31886.7 33589.7 33883.0 34058.7 34115.5 25628.5 25748.9 25785.1 25845.0 25958.1 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:33814.65 Median:11549.68 stddev:95125.19 (823.6%) stddev-sans-first:95358.88 11:31:16 INFO - PROCESS | 1937 | Values: 364.6 414.2 417.6 418.6 424.7 15213.3 20156.9 20205.8 20227.2 20468.7 17111.5 20539.4 20720.6 20869.9 21703.7 5756.5 5798.6 6024.3 6060.5 6064.9 5444.9 5936.1 5984.6 6048.0 6067.2 5790.8 5897.4 6018.5 6054.9 6062.8 5877.5 5917.9 5934.8 5952.5 5995.7 5262.1 5264.0 5265.9 5608.0 5939.4 14022.4 14034.6 14280.8 14465.2 19370.7 2230.9 2354.6 2422.2 2726.1 2758.3 9935.9 10036.8 10260.0 10355.7 10422.7 1712.4 1790.4 1804.5 1851.8 1890.7 120952.0 122061.0 123858.1 126189.0 126305.1 11753.5 12028.1 12098.6 12180.1 12276.4 15587.0 15626.5 15666.7 15676.9 15716.8 9341.6 9348.1 9378.1 9423.3 9462.4 7137.5 7800.6 9406.2 9473.8 9535.0 4022.9 4842.9 4872.9 4890.7 4897.8 1790.0 2026.5 2074.7 2087.0 2095.3 915.9 951.7 1042.4 1053.6 1063.4 20017.6 20558.8 20818.4 21004.1 21196.6 926.7 964.6 981.4 998.9 1075.8 9411.4 11079.4 11091.6 11126.5 11163.2 513146.0 520963.0 521184.0 610308.0 661604.0 75958.0 77025.6 129654.0 132755.3 137006.3 1041.8 1060.7 1075.7 1082.6 1083.0 18311.0 18560.6 18837.0 18841.2 18894.8 51833.5 52120.0 54609.2 57311.6 57415.0 79044.6 82887.3 83812.0 84061.2 84156.3 8314.9 8528.7 8534.7 8645.7 8910.9 9711.0 13220.7 13234.9 13320.5 13670.6 11330.2 11451.8 11485.9 11556.5 11860.6 10861.1 10891.3 11127.3 11370.3 11419.7 11385.5 11642.2 11944.3 12002.5 12004.0 8359.4 8487.0 8623.4 8661.5 8799.6 10946.5 11156.7 11243.5 11357.9 11596.8 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5920.88 Median:2761.15 stddev:3303.11 (119.6%) stddev-sans-first:3296.44 11:31:16 INFO - PROCESS | 1937 | Values: 1602.7 1615.7 1877.8 1976.4 2031.7 8209.0 8896.3 9143.5 9352.9 9353.3 9048.3 9119.8 9210.0 9220.0 9268.5 2360.4 2374.4 2392.1 2403.6 2405.0 2533.1 2543.9 2545.8 2576.7 2579.4 2545.1 2564.9 2565.6 2566.6 2571.0 2546.1 2555.8 2562.6 2570.4 2601.7 2550.8 2582.9 2585.7 2586.4 2600.9 9390.4 9402.5 9411.5 9437.2 9472.5 4876.9 5673.3 5697.0 5805.6 5824.8 3237.0 3698.0 3786.9 3845.6 3858.4 1062.6 1081.3 1082.2 1083.6 1086.7 10662.4 12266.6 12669.7 12698.9 12705.7 4330.8 4986.2 5039.4 5112.3 5121.9 9098.0 10416.5 10701.4 10715.7 10725.2 5644.6 5689.1 5767.7 5831.9 5902.6 4639.5 5103.9 5139.6 5215.3 5232.5 3700.7 4128.3 4153.0 4160.3 4252.4 1408.0 1419.2 1421.8 1426.3 1437.5 969.4 978.9 980.7 996.2 1014.8 6111.9 6133.7 6164.5 6244.0 6266.8 473.5 486.5 496.6 499.9 501.4 4082.9 4118.3 4141.2 4149.4 4149.5 10759.0 11169.3 11216.4 11236.8 11285.0 10925.4 10960.8 10994.8 11037.6 11088.6 8630.4 8668.0 8692.7 8726.8 8746.6 5735.6 5936.1 5978.9 5985.3 6086.3 9710.9 9711.6 9770.6 9798.2 9899.5 9489.5 10116.9 10219.1 10264.5 10393.9 6848.4 7677.3 7697.7 7698.9 7728.0 8609.6 8629.8 8649.7 8650.4 8655.0 7561.7 7631.8 7709.8 7735.4 7797.1 7409.3 7422.7 7458.2 7486.0 7636.0 7194.7 7199.1 7229.6 7258.2 7261.1 4523.8 4536.0 5020.9 5200.3 5205.8 4424.6 5175.1 5209.9 5233.9 5260.7 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:6024.34 Median:6864.23 stddev:1938.94 (28.2%) stddev-sans-first:1896.52 11:31:16 INFO - PROCESS | 1937 | Values: 319.9 332.0 334.2 342.1 343.3 5912.2 6788.0 6807.6 6903.8 6925.2 6719.2 6783.6 6800.2 6828.4 6872.7 5093.1 5117.4 5117.9 5123.6 5126.7 4120.4 5112.1 5120.3 5120.3 5128.8 4056.8 5080.6 5091.3 5092.2 5113.1 4242.7 4399.1 4525.8 4972.9 5123.6 3881.9 4106.7 4354.4 4364.3 4365.8 5265.9 6583.5 6590.3 6612.7 6645.4 5976.8 5995.7 5997.2 6000.9 6010.8 7306.2 7315.7 7339.2 7350.3 7352.6 4703.3 4863.0 4864.7 4892.2 4893.6 6877.5 7687.9 7711.5 7774.5 7779.0 4611.7 4960.8 4963.6 4964.1 4968.8 5066.3 5070.2 5073.9 5075.4 5100.0 5945.8 5968.3 5970.1 5975.8 5991.2 7107.3 7360.5 7362.9 7415.4 7417.6 1737.0 1755.6 1764.8 1774.5 1777.7 1051.9 1104.9 1121.3 1148.4 1150.3 6776.9 6910.7 6933.7 6959.8 6962.8 7635.5 7653.4 7665.0 7697.8 7724.8 6884.1 6899.0 6902.4 6906.0 6915.7 3896.6 4033.6 4078.8 4084.5 4091.6 7970.8 8011.2 8036.5 8045.7 8054.9 7868.5 7917.0 7953.2 7955.8 7965.6 7272.7 7660.8 7977.2 8027.7 8056.4 7504.5 7676.4 7741.5 7745.1 7788.6 7564.4 7583.1 7610.4 7611.9 7626.5 6605.9 7895.7 8048.3 8070.8 8098.3 4739.1 4774.6 4784.6 4792.1 4795.5 7495.9 7555.8 7664.2 7730.3 7758.0 7358.3 7403.0 7412.2 7419.6 7462.3 7397.3 7407.1 7416.8 7427.9 7434.6 7005.8 7214.6 7227.2 7231.8 7263.0 7413.0 7417.0 7418.9 7434.1 7441.0 6295.5 6855.8 6947.7 7049.9 7268.6 11:31:16 INFO - PROCESS | 1937 | 11:31:16 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:18655.19 Median:602.19 stddev:26926.11 (4471.3%) stddev-sans-first:26967.95 11:31:16 INFO - PROCESS | 1937 | Values: 714.2 747.6 750.4 769.4 782.3 15327.0 15679.3 15684.2 15716.6 15726.1 14451.7 14458.0 14538.5 14570.1 14570.5 769.2 940.1 948.5 961.3 971.3 960.4 963.4 964.4 970.6 970.9 1030.1 1031.9 1036.1 1036.2 1039.1 1002.2 1023.2 1025.9 1029.0 1032.1 752.4 759.1 761.3 762.5 763.7 15017.4 15156.8 15303.5 15352.4 15416.4 11914.9 12877.7 13073.4 13113.0 13247.7 9210.9 9416.9 10071.1 10149.6 10416.3 3579.1 3605.5 3632.7 3668.5 3825.1 86138.0 86379.6 89726.0 90619.6 91052.1 9549.8 9624.7 9733.9 9736.5 10072.0 21866.6 22140.6 22150.3 22192.0 22203.3 7490.6 7545.3 7589.5 7616.9 7700.5 4039.5 4063.3 4081.8 4089.2 4101.5 3650.5 3658.2 3681.3 3685.0 3739.8 601.9 602.5 615.3 615.5 627.1 499.7 565.1 613.1 618.6 627.4 7771.9 7838.2 8433.5 8509.3 8661.4 605.6 616.3 625.7 626.1 647.1 3523.5 3832.8 3893.8 3983.0 4010.9 96146.5 96470.5 97361.1 99581.5 99743.0 77467.6 78954.0 79850.6 80486.4 84810.2 55253.7 71398.3 71978.6 73264.3 74325.0 6813.7 6897.4 7783.6 7978.8 8000.3 50923.5 50991.5 51203.2 51959.0 53272.5 57726.7 66470.3 70188.6 70629.0 71272.6 10204.4 10396.0 10440.8 10451.6 10519.6 10893.0 11052.9 11214.8 11275.3 11284.2 8808.5 10343.4 10484.5 10543.6 10833.1 9561.0 10112.4 10197.7 10604.9 10700.5 9969.3 10386.8 10497.9 10562.9 10654.3 8909.7 8951.3 9102.8 9159.5 9319.8 9016.1 9078.0 9171.3 9180.5 9327.1 11:31:16 INFO - PROCESS | 1937 | -------- Summary: end -------- 11:31:16 INFO - PROCESS | 1937 | 11:31:17 INFO - TEST-INFO | 1937: exit 0 11:31:17 INFO - TEST-OK | dromaeo_css | took 1109986ms 11:31:17 INFO - TEST-START | kraken 11:31:17 INFO - operating with platform_type : mac_ 11:31:17 INFO - Initialising browser for kraken test... 11:31:17 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpSNiS20/profile http://localhost:52197/getInfo.html) 11:31:19 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 11:31:19 INFO - PROCESS | 1943 | colorDepth:24 11:31:19 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 11:31:19 INFO - PROCESS | 1943 | __metrics 11:31:19 ERROR - PROCESS | 1943 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:31:20 INFO - TEST-INFO | 1943: exit 0 11:31:20 INFO - Browser initialized. 11:31:20 INFO - Running cycle 1/1 for kraken test... 11:31:20 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpSNiS20/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:32 INFO - PROCESS | 1947 | RSS: Main: 171483136 11:31:32 INFO - PROCESS | 1947 | 11:31:34 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52197/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:35 INFO - PROCESS | 1947 | RSS: Main: 183607296 11:31:35 INFO - PROCESS | 1947 | 11:31:38 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52197/tests/kraken/driver.html?testName=audio-dft) 11:31:39 INFO - PROCESS | 1947 | RSS: Main: 192282624 11:31:39 INFO - PROCESS | 1947 | 11:31:42 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52197/tests/kraken/driver.html?testName=audio-fft) 11:31:43 INFO - PROCESS | 1947 | RSS: Main: 195973120 11:31:43 INFO - PROCESS | 1947 | 11:31:45 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52197/tests/kraken/driver.html?testName=audio-oscillator) 11:31:45 INFO - PROCESS | 1947 | RSS: Main: 196132864 11:31:45 INFO - PROCESS | 1947 | 11:31:47 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:48 INFO - PROCESS | 1947 | RSS: Main: 197652480 11:31:48 INFO - PROCESS | 1947 | 11:31:51 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52197/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:51 INFO - PROCESS | 1947 | RSS: Main: 198201344 11:31:51 INFO - PROCESS | 1947 | 11:31:54 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52197/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:55 INFO - PROCESS | 1947 | RSS: Main: 198242304 11:31:55 INFO - PROCESS | 1947 | 11:31:58 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52197/tests/kraken/driver.html?testName=json-parse-financial) 11:31:58 INFO - PROCESS | 1947 | RSS: Main: 198275072 11:31:58 INFO - PROCESS | 1947 | 11:32:00 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:00 INFO - PROCESS | 1947 | RSS: Main: 197726208 11:32:00 INFO - PROCESS | 1947 | 11:32:02 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:03 INFO - PROCESS | 1947 | RSS: Main: 197705728 11:32:03 INFO - PROCESS | 1947 | 11:32:05 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:06 INFO - PROCESS | 1947 | RSS: Main: 198025216 11:32:06 INFO - PROCESS | 1947 | 11:32:09 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:09 INFO - PROCESS | 1947 | RSS: Main: 198144000 11:32:09 INFO - PROCESS | 1947 | 11:32:12 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:13 INFO - PROCESS | 1947 | RSS: Main: 198021120 11:32:13 INFO - PROCESS | 1947 | 11:32:14 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52197/tests/kraken/driver.html?testName=ai-astar) 11:32:15 INFO - PROCESS | 1947 | RSS: Main: 199987200 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | __start_tp_report 11:32:15 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 11:32:15 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 11:32:15 INFO - PROCESS | 1947 | |i|pagename|runs| 11:32:15 INFO - PROCESS | 1947 | |0;ai-astar;116;110;116;114;117;150;155;115;115;113 11:32:15 INFO - PROCESS | 1947 | |1;audio-beat-detection;163;108;181;193;128;169;169;123;170;120 11:32:15 INFO - PROCESS | 1947 | |2;audio-dft;197;197;192;197;204;279;252;193;198;197 11:32:15 INFO - PROCESS | 1947 | |3;audio-fft;66;76;80;146;57;57;60;70;130;65 11:32:15 INFO - PROCESS | 1947 | |4;audio-oscillator;80;80;169;111;116;88;124;78;77;126 11:32:15 INFO - PROCESS | 1947 | |5;imaging-gaussian-blur;88;88;89;87;111;86;89;87;90;86 11:32:15 INFO - PROCESS | 1947 | |6;imaging-darkroom;94;95;95;96;96;95;96;95;95;113 11:32:15 INFO - PROCESS | 1947 | |7;imaging-desaturate;88;90;91;91;100;90;89;125;115;90 11:32:15 INFO - PROCESS | 1947 | |8;json-parse-financial;57;64;63;64;66;67;68;82;63;62 11:32:15 INFO - PROCESS | 1947 | |9;json-stringify-tinderbox;59;91;100;95;97;75;69;66;67;65 11:32:15 INFO - PROCESS | 1947 | |10;stanford-crypto-aes;80;79;82;103;105;102;106;79;82;81 11:32:15 INFO - PROCESS | 1947 | |11;stanford-crypto-ccm;128;124;127;125;132;135;128;124;149;164 11:32:15 INFO - PROCESS | 1947 | |12;stanford-crypto-pbkdf2;169;165;165;168;160;170;167;160;165;163 11:32:15 INFO - PROCESS | 1947 | |13;stanford-crypto-sha256-iterative;66;74;69;66;70;65;68;67;68;67 11:32:15 INFO - PROCESS | 1947 | __end_tp_report 11:32:15 INFO - PROCESS | 1947 | __start_cc_report 11:32:15 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1040 11:32:15 INFO - PROCESS | 1947 | __end_cc_report 11:32:15 INFO - PROCESS | 1947 | __startTimestamp1468866735079__endTimestamp 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | ------- Summary: start ------- 11:32:15 INFO - PROCESS | 1947 | Number of tests: 14 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#0] ai-astar Cycles:10 Average:122.10 Median:116.00 stddev:16.18 (14.0%) stddev-sans-first:17.01 11:32:15 INFO - PROCESS | 1947 | Values: 116.0 110.0 116.0 114.0 117.0 150.0 155.0 115.0 115.0 113.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:169.00 stddev:29.67 (17.6%) stddev-sans-first:31.22 11:32:15 INFO - PROCESS | 1947 | Values: 163.0 108.0 181.0 193.0 128.0 169.0 169.0 123.0 170.0 120.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#2] audio-dft Cycles:10 Average:210.60 Median:197.50 stddev:29.80 (15.1%) stddev-sans-first:31.19 11:32:15 INFO - PROCESS | 1947 | Values: 197.0 197.0 192.0 197.0 204.0 279.0 252.0 193.0 198.0 197.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#3] audio-fft Cycles:10 Average:80.70 Median:65.50 stddev:31.35 (47.9%) stddev-sans-first:32.80 11:32:15 INFO - PROCESS | 1947 | Values: 66.0 76.0 80.0 146.0 57.0 57.0 60.0 70.0 130.0 65.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:77.50 stddev:30.01 (38.7%) stddev-sans-first:30.45 11:32:15 INFO - PROCESS | 1947 | Values: 80.0 80.0 169.0 111.0 116.0 88.0 124.0 78.0 77.0 126.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:88.00 stddev:7.46 (8.5%) stddev-sans-first:7.87 11:32:15 INFO - PROCESS | 1947 | Values: 88.0 88.0 89.0 87.0 111.0 86.0 89.0 87.0 90.0 86.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:95.00 stddev:5.66 (6.0%) stddev-sans-first:5.89 11:32:15 INFO - PROCESS | 1947 | Values: 94.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 113.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:90.00 stddev:12.83 (14.3%) stddev-sans-first:13.20 11:32:15 INFO - PROCESS | 1947 | Values: 88.0 90.0 91.0 91.0 100.0 90.0 89.0 125.0 115.0 90.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:6.52 (10.0%) stddev-sans-first:6.13 11:32:15 INFO - PROCESS | 1947 | Values: 57.0 64.0 63.0 64.0 66.0 67.0 68.0 82.0 63.0 62.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:72.00 stddev:15.59 (21.6%) stddev-sans-first:14.87 11:32:15 INFO - PROCESS | 1947 | Values: 59.0 91.0 100.0 95.0 97.0 75.0 69.0 66.0 67.0 65.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:79.50 stddev:12.22 (15.4%) stddev-sans-first:12.43 11:32:15 INFO - PROCESS | 1947 | Values: 80.0 79.0 82.0 103.0 105.0 102.0 106.0 79.0 82.0 81.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:130.00 stddev:13.04 (10.0%) stddev-sans-first:13.67 11:32:15 INFO - PROCESS | 1947 | Values: 128.0 124.0 127.0 125.0 132.0 135.0 128.0 124.0 149.0 164.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:3.46 (2.1%) stddev-sans-first:3.38 11:32:15 INFO - PROCESS | 1947 | Values: 169.0 165.0 165.0 168.0 160.0 170.0 167.0 160.0 165.0 163.0 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - PROCESS | 1947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.58 (3.8%) stddev-sans-first:2.64 11:32:15 INFO - PROCESS | 1947 | Values: 66.0 74.0 69.0 66.0 70.0 65.0 68.0 67.0 68.0 67.0 11:32:15 INFO - PROCESS | 1947 | -------- Summary: end -------- 11:32:15 INFO - PROCESS | 1947 | 11:32:15 INFO - TEST-INFO | 1947: exit 0 11:32:15 INFO - TEST-OK | kraken | took 58888ms 11:32:15 INFO - SUITE-END | took 1168s 11:32:16 INFO - Completed test suite (00:19:29) 11:32:16 INFO - javascript benchmark 11:32:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3617.5297211362517, 3652.214773823627, 3669.1560940983563, 3688.317661232672, 3717.572479164897, 6014.278286605602, 6050.485708714759, 6065.909011364833, 6076.027835546313, 6102.786402475915, 6040.57715959883, 6062.120992456103, 6062.151298818169, 6105.084237364397, 6112.938870611292, 5403.945960540394, 5433.212184233284, 5474.589405794562, 5545.306836645419, 5602.327720673505, 3994.320965435883, 4566.885827854297, 5505.981393442226, 5515.090010148341, 5531.889362212753, 5474.260974768415, 5482.835514934558, 5501.119820828668, 5568.470995255444, 5615.241942337793, 4505.36924830524, 5545.390007099236, 5595.580331475156, 5599.916001259984, 5609.251466781288, 4010.8997275068064, 5433.212184233304, 5438.972805135989, 5507.091329930557, 5532.28080349556, 5674.347450043257, 5682.6306290091015, 5870.765169393219, 6008.639481631072, 6050.273967123973, 5118.872028199287, 5996.2504686914135, 6149.723262453201, 6198.659073750942, 6272.6236425814595, 4776.8566942991765, 5408.8377348679205, 6226.034964580497, 6391.904121438182, 6412.0, 6021.916055110079, 6130.203073600448, 6160.291566469824, 6183.103449999815, 6200.224971878515, 6602.636854972927, 6611.140551728245, 6659.733610655617, 6669.299723529057, 6672.499562532732, 6222.875542489125, 6277.811665650038, 6299.590526615755, 6347.270063942613, 6348.682565871688, 6395.712192951329, 6457.806265812033, 6482.67586620667, 6487.870242595121, 6490.091387205795, 6347.1114044033875, 6367.777127800598, 6381.712822922979, 6392.904106438407, 6396.136521569621, 6211.192544969215, 6283.08895210192, 6356.650384228912, 6395.840103997437, 6398.264199617103, 5068.974655126774, 5135.435102138762, 5155.200943853709, 5163.0, 5188.92216616751, 4626.976865115653, 4633.027064316464, 4662.184117779443, 4664.79008444614, 4665.440147182359, 6040.848978775566, 6122.479589234876, 6146.754129834757, 6194.0708893666315, 6218.502519798405, 6409.391107844747, 6433.324500927335, 6545.541812073205, 6569.638669873203, 6577.112089867902, 6195.96902015487, 6199.411055949678, 6212.689365531795, 6214.316425193225, 6225.906611400833, 5579.944200558024, 5653.265075540154, 5743.8564035899435, 5745.626534275259, 5747.626404283708, 6662.967240077795, 6731.0, 6737.124173857564, 6746.0892779475125, 6761.72953081881, 6517.9348206517325, 6534.019897015486, 6550.213974323112, 6576.44100251484, 6592.868142637216, 6529.934700652932, 6608.240052393844, 6673.632950187592, 6719.4624430044505, 6719.899201511884, 6356.68216589178, 6392.840178995562, 6412.807615771534, 6420.518461115528, 6432.807015789534, 6454.903176452451, 6520.445762110274, 6531.934680653323, 6533.575317604341, 6539.738410463528, 6092.543059270661, 6241.095041219089, 6242.750289988349, 6303.149074874833, 6339.904901426575, 6275.152854364603, 6305.306416294112, 6316.84207894788, 6333.303336633059, 6356.396142366468, 5829.6793676346515, 6000.279966404059, 6221.844453888689, 6230.034344676583, 6253.906191407042, 6222.12890195364, 6257.624542527281, 6265.592736472115, 6299.96850015747, 6324.367563243639, 5146.433892271922, 6159.19930409044, 6186.845328866814, 6217.844553886189, 6219.471344935731], "value": 5911.825605590035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.7625044980208, 543.5841581190389, 548.8106603221888, 556.4713522153954, 614.9108379285001, 39447.21105577887, 40145.99635009126, 40245.798771006106, 40246.99382515435, 40288.59711402885, 34308.65691343086, 41471.0, 41979.79010104945, 42013.159736805246, 42115.9471013224, 8330.541820199887, 9618.711438656852, 9813.950930245375, 9841.803163936753, 9861.063198996084, 9028.368014239006, 9834.803303933917, 9897.208223342152, 9927.702168934944, 9968.501574921262, 9854.40873547586, 9954.60181592739, 9976.700698979006, 9981.30130890838, 9985.850212246785, 9874.901250987507, 9949.204063674888, 9971.252156088321, 9972.750681232954, 9984.750381240454, 9769.413835169842, 9895.901040989569, 9901.257405694601, 9903.504824758806, 9926.751831204205, 40162.598374016474, 40516.0, 40539.797301013605, 40815.387769183486, 41073.38389924153, 3365.6634336566394, 3549.804760738158, 3877.8836634901, 3916.4516967624554, 4047.352423612208, 27138.0, 27627.03305384322, 28069.85965070182, 28635.427291454052, 29150.85424572885, 2500.8874600642835, 2750.147454289177, 2779.12457575865, 2788.1635509347316, 2812.0439050722853, 308087.0, 308904.0, 311037.0, 311085.0, 311554.44222778967, 37862.62137378646, 63651.0, 64192.67903660452, 64217.35782642207, 64223.0, 36405.45391819125, 36536.634633653324, 36542.08644783848, 36847.4472882907, 36934.8153259232, 16165.595860103356, 16481.25834337458, 16519.0, 16541.25564349607, 16549.58626034359, 13625.454981800814, 13870.306484675726, 13987.160770353812, 14016.229107399191, 14073.577792666236, 8229.218224268685, 8255.215754503313, 8357.247847693616, 8413.200745929127, 8594.398392112616, 3098.5816914716224, 3116.4546204414137, 3579.069441945061, 3618.945715814265, 3642.8542858285373, 1041.3543602966058, 1066.2802608239563, 1087.6791346552786, 1119.9496022679, 1246.4328730427633, 30865.537016944763, 30929.381412372077, 30985.0, 31482.212944676106, 31727.68272317247, 1067.236925598201, 1132.9407004450866, 1228.7419641875128, 1234.8888600025862, 1266.474413118564, 14549.854501455062, 14651.681348678458, 15904.0, 15978.755992282038, 16043.117628530543, 656794.7160264169, 658242.0, 666221.0, 669027.0, 669485.0, 62440.37559624436, 62888.68555657192, 64165.03752443717, 64246.71506569842, 64359.03461448082, 1538.692261547695, 1538.8230353509266, 1546.5592306192682, 1548.783170356151, 1552.8757699384023, 26094.0, 26149.73850261549, 29760.255993600334, 30673.53989690201, 31312.373752525276, 53630.0, 53966.73016634892, 54104.72947635237, 54178.45821541734, 54364.0, 578392.0, 581088.0, 583381.0, 584306.0, 585155.0, 27175.320616984733, 27404.0, 27776.16671499858, 27900.0, 28225.576616351183, 46963.530364695915, 47556.7622161887, 47763.28355074607, 48284.0, 48725.0, 35359.292814144086, 36247.63752362443, 38926.4161037579, 39267.018324542114, 39984.0, 37678.24643507169, 38500.80749596234, 38714.4192837102, 38818.0, 39080.804595976835, 33917.0, 38070.61929380671, 38935.80532097322, 39565.2086958265, 39723.0, 31886.681133188373, 33589.66410335963, 33883.0, 34058.65941340654, 34115.488267676505, 25628.487430251662, 25748.8712556436, 25785.097521586653, 25845.0, 25958.09146679857], "value": 18961.417497187373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6408287836482, 414.2295330684926, 417.5782459715686, 418.58978201362663, 424.6560286168204, 15213.315400806963, 20156.89921550392, 20205.797942020574, 20227.190912363505, 20468.69296960547, 17111.486655400357, 20539.383818485432, 20720.585588288224, 20869.895650521725, 21703.674444883338, 5756.481916627492, 5798.62308949919, 6024.337322894478, 6060.545459090564, 6064.9090263646085, 5444.863878403032, 5936.079907614305, 5984.611000284989, 6048.0, 6067.18093057436, 5790.7683692652245, 5897.41025897409, 6018.458338749511, 6054.909176362358, 6062.848428789272, 5877.500412464946, 5917.9408205918035, 5934.762609495615, 5952.494038006775, 5995.6702381369005, 5262.105442074818, 5263.973680131613, 5265.86835329116, 5607.971960140214, 5939.376365481606, 14022.368993395321, 14034.578962631138, 14280.785788213185, 14465.20441375724, 19370.70943935842, 2230.8996095175758, 2354.5644055849552, 2422.1522467136538, 2726.127639155471, 2758.2828464599147, 9935.850962235572, 10036.799264014679, 10260.02529759679, 10355.689329320132, 10422.739431514197, 1712.3578658003248, 1790.3912669692236, 1804.5127815489743, 1851.7685289338833, 1890.735297058413, 120952.0, 122061.0, 123858.14212786815, 126189.0, 126305.10542341872, 11753.4710938008, 12028.097892658086, 12098.63704088861, 12180.147389682637, 12276.44755985965, 15586.986845854983, 15626.531204063896, 15666.686666266838, 15676.92161539185, 15716.842831571767, 9341.626334946526, 9348.1119293667, 9378.062193780568, 9423.340366174301, 9462.432254064779, 7137.536060156073, 7800.609969501502, 9406.153446189875, 9473.810523789485, 9535.046495350549, 4022.91954160921, 4842.903141937141, 4872.926906096412, 4890.706557606555, 4897.8285759998225, 1789.973150402745, 2026.493376655836, 2074.6576814825385, 2086.9895650521953, 2095.302804728175, 915.8900931888217, 951.6859436385976, 1042.3902017319801, 1053.5680371047833, 1063.4416931111073, 20017.59964800696, 20558.79441205569, 20818.375448736562, 21004.054817533248, 21196.57606847885, 926.6617684545092, 964.6141543382703, 981.4111533080095, 998.9012086704712, 1075.800976819291, 9411.43531388119, 11079.446027698745, 11091.55633774656, 11126.49930753102, 11163.218574699855, 513146.0, 520963.0, 521184.0, 610308.0, 661604.0, 75958.0, 77025.61487192528, 129654.0, 132755.33622331827, 137006.31496842453, 1041.8333066709442, 1060.6552870317178, 1075.6826736112866, 1082.6481393547128, 1083.0, 18311.0, 18560.628787423906, 18837.0, 18841.15214815364, 18894.811051889305, 51833.48166518437, 52120.0, 54609.18086228789, 57311.56721082006, 57415.0, 79044.60477697574, 82887.34225315339, 83812.0, 84061.15938840777, 84156.31687366097, 8314.87527687073, 8528.74413767588, 8534.658613655385, 8645.654173832976, 8910.930688317443, 9710.951445242728, 13220.669483262995, 13234.933825330812, 13320.467181313026, 13670.589882303548, 11330.150238731963, 11451.770964580495, 11485.942570287096, 11556.537738490366, 11860.644180674593, 10861.131109511061, 10891.346519208873, 11127.332360058423, 11370.31778093317, 11419.657410277705, 11385.487653055798, 11642.185047046964, 11944.343061131374, 12002.519899204284, 12004.0, 8359.414840961317, 8486.957565212135, 8623.396362254582, 8661.52361620117, 8799.560021999003, 10946.452677366258, 11156.721081973015, 11243.49404276826, 11357.943210283896, 11596.76806463849], "value": 9646.361950149105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1602.7115119278528, 1615.6687878984806, 1877.8216069473394, 1976.4268362174978, 2031.705402716607, 8208.958955205215, 8896.332775041881, 9143.45139291643, 9352.906470935288, 9353.345265831385, 9048.321375896801, 9119.817603647924, 9210.0, 9220.031896650855, 9268.49023303718, 2360.3509035015336, 2374.3707917401903, 2392.1149174805346, 2403.555342261687, 2405.0379848060743, 2533.100749234023, 2543.9491210175784, 2545.8217924745277, 2576.6521519594894, 2579.3551612096976, 2545.0583284184786, 2564.948701025978, 2565.576679847823, 2566.602176662611, 2571.048711976562, 2546.0834099723993, 2555.8338707984017, 2562.5643640581147, 2570.434504409027, 2601.6877974642975, 2550.795936325108, 2582.8708564571884, 2585.7026441959038, 2586.3921978335075, 2600.9479810403877, 9390.436573805593, 9402.529873506297, 9411.529423528864, 9437.245020398352, 9472.479013654247, 4876.853939324256, 5673.26247587815, 5697.03150464422, 5805.564582656318, 5824.776796872619, 3236.951445728316, 3697.950893123855, 3786.8863934081746, 3845.6346647068485, 3858.3633700439395, 1062.5696592879897, 1081.259337353915, 1082.1991726122692, 1083.6099004358425, 1086.6522712731928, 10662.413567253798, 12266.570670026505, 12669.74660506794, 12698.873011269861, 12705.745885082246, 4330.848420305274, 4986.227134794112, 5039.370078740158, 5112.335396398519, 5121.923171152435, 9098.0, 10416.479176041168, 10701.357918524758, 10715.732106697395, 10725.195610329256, 5644.6330988485615, 5689.061304884648, 5767.653940763567, 5831.941680583224, 5902.58681892272, 4639.536046395401, 5103.948960510422, 5139.640225184201, 5215.269862219292, 5232.529072383504, 3700.666939975415, 4128.339465685536, 4152.96175956011, 4160.315072395684, 4252.425922500484, 1408.0425310788557, 1419.22652154576, 1421.8435972043067, 1426.3082405033551, 1437.5112461763051, 969.3650658818485, 978.9070038346346, 980.6910823090703, 996.1681995533665, 1014.8224060789332, 6111.908321375183, 6133.723982420802, 6164.506839452833, 6244.0, 6266.811995640047, 473.4768081270147, 486.46488862251243, 496.63249195595, 499.9325091112726, 501.4308759557928, 4082.857100001486, 4118.279301122351, 4141.213169497786, 4149.398337241083, 4149.481314835645, 10759.0, 11169.329840209613, 11216.439178041066, 11236.820133885987, 11285.0, 10925.399103049409, 10960.835587466194, 10994.835077473845, 11037.613683521038, 11088.611898583511, 8630.395872289006, 8668.046514883357, 8692.695755648521, 8726.781830454163, 8746.56267186638, 5735.627184233178, 5936.079907614327, 5978.880422391615, 5985.25184351956, 6086.269647642312, 9710.902890971283, 9711.56297966579, 9770.609175632895, 9798.216142708423, 9899.505024748878, 9489.525523723649, 10116.89883101189, 10219.080282774587, 10264.538095785558, 10393.9480302598, 6848.383645471931, 7677.347425468898, 7697.692092316244, 7698.8845167321415, 7728.0, 8609.612567434606, 8629.784255393666, 8649.740507784776, 8650.351223658377, 8655.0, 7561.6597253122645, 7631.847363052597, 7709.845803084019, 7735.419843511647, 7797.142314345531, 7409.333160015624, 7422.66598003102, 7458.216887226763, 7486.0, 7635.961820190863, 7194.712211511481, 7199.1361036675935, 7229.638518074181, 7258.237885021997, 7261.128664560287, 4523.773811309487, 4536.047430039728, 5020.874478138076, 5200.323957885602, 5205.817796377109, 4424.579664931826, 5175.120229561059, 5209.869753256199, 5233.921491177712, 5260.736963151904], "value": 4716.610042648307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.9392115498055, 331.9593075707656, 334.1712552868885, 342.13439996808074, 343.33050551424714, 5912.231409916711, 6788.049673045777, 6807.625580593065, 6903.758368457099, 6925.203601585819, 6719.160104986877, 6783.6269005204695, 6800.183977922644, 6828.351306625875, 6872.656367181646, 5093.108705976458, 5117.385913690362, 5117.872053198663, 5123.590112790967, 5126.71803050832, 4120.402541631462, 5112.130937740574, 5120.257562653413, 5120.334356533645, 5128.769205385748, 4056.817443215062, 5080.568151707109, 5091.312672789181, 5092.210707340369, 5113.130767769489, 4242.681798865097, 4399.076193999264, 4525.751083690396, 4972.925406118911, 5123.5901127909865, 3881.8548528184256, 4106.7125301228925, 4354.390385346054, 4364.345348197764, 4365.80353884076, 5265.921011184835, 6583.506237032242, 6590.34096590342, 6612.669366531654, 6645.435138013275, 5976.790812321591, 5995.730192141364, 5997.22036135304, 6000.909986350208, 6010.75956961721, 7306.164263761514, 7315.670794814193, 7339.192688804227, 7350.264973502661, 7352.595607241599, 4703.294505824119, 4862.975685121587, 4864.659473836833, 4892.192788189945, 4893.608511319086, 6877.4841886858685, 7687.923120768776, 7711.460197786158, 7774.455788094836, 7779.0, 4611.723296602215, 4960.759810047488, 4963.6277279204205, 4964.081644895706, 4968.751562421864, 5066.265391518209, 5070.239464080344, 5073.909109541466, 5075.441701412841, 5099.974500127476, 5945.762169513171, 5968.253968253968, 5970.134330522137, 5975.7609695612555, 5991.221141251609, 7107.324804143598, 7360.521566098187, 7362.889556656654, 7415.439504704568, 7417.629118544051, 1737.0, 1755.6313174233298, 1764.80587135415, 1774.5208793625907, 1777.7244527098321, 1051.8632577764995, 1104.8729396119388, 1121.3272036777869, 1148.4257871064467, 1150.2810743285447, 6776.93223067763, 6910.689018994158, 6933.653317334113, 6959.791206263821, 6962.825929351706, 7635.465517413839, 7653.387728981668, 7664.961675191588, 7697.769066928001, 7724.764037753933, 6884.139482564679, 6898.965505172442, 6902.413294869892, 6905.965470172617, 6915.688794004182, 3896.5518965318784, 4033.6369726724733, 4078.7552746835286, 4084.5302790178916, 4091.6112969268465, 7970.840583188304, 8011.198880111942, 8036.517808931366, 8045.718399855977, 8054.919450805534, 7868.488548244461, 7917.049954005441, 7953.244441778022, 7955.761327160194, 7965.641546130438, 7272.727272727251, 7660.770176894702, 7977.162397948248, 8027.6788928443375, 8056.436049476481, 7504.549727016397, 7676.424268179797, 7741.496802707806, 7745.148033716399, 7788.649510772142, 7564.357029652541, 7583.090029196532, 7610.374420824806, 7611.885821712568, 7626.466147369631, 6605.867882642417, 7895.6841726332605, 8048.315893149148, 8070.83858322842, 8098.271155596025, 4739.099571081483, 4774.641901857305, 4784.612462386009, 4792.137415265286, 4795.472498025284, 7495.887561686688, 7555.848883022199, 7664.156942736183, 7730.304272615266, 7757.961210193913, 7358.300961408871, 7402.9629851850395, 7412.221716719667, 7419.591922444318, 7462.328390444886, 7397.297256760599, 7407.074115735533, 7416.7774966751085, 7427.925720742724, 7434.553926764412, 7005.754798582026, 7214.639268036683, 7227.205007449282, 7231.819204519929, 7263.0, 7413.036305280279, 7416.998705174949, 7418.888716669362, 7434.145073316421, 7440.962795186206, 6295.527835412271, 6855.800234958962, 6947.652617369213, 7049.859002820018, 7268.600226987355], "value": 5374.480067022293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.1608609883385, 747.6373958630063, 750.3546949623319, 769.361430013089, 782.3311069035973, 15327.003744756597, 15679.29443175057, 15684.215789210522, 15716.607084822885, 15726.135062571553, 14451.710965780678, 14458.0, 14538.491152809655, 14570.12579245246, 14570.490032848853, 769.20387399042, 940.0505489455664, 948.4641177734593, 961.2694352292273, 971.3249291742242, 960.4237457525498, 963.3930623707055, 964.3924327673591, 970.6020531582053, 970.8834939807198, 1030.0832259289239, 1031.8813336466328, 1036.0675392147052, 1036.1762398892897, 1039.0544604409988, 1002.2182697495929, 1023.1661196125172, 1025.9179265658804, 1028.9588416463332, 1032.1072272484323, 752.4168769203856, 759.1459607941066, 761.3072104384983, 762.4853224073784, 763.6601712238056, 15017.399304027826, 15156.848431515655, 15303.46437874669, 15352.385904563804, 15416.3833446662, 11914.940425297904, 12877.67805804853, 13073.411696473586, 13113.0, 13247.73504529904, 9210.907890921071, 9416.869975602904, 10071.143952764023, 10149.64476243328, 10416.32293900894, 3579.069441945113, 3605.4591811228524, 3632.673059424638, 3668.5047518584915, 3825.08198032473, 86138.0, 86379.56810215971, 89726.0, 90619.64070538947, 91052.08947910502, 9549.809003819884, 9624.66313679018, 9733.853992190123, 9736.464494452874, 10072.043155900177, 21866.562668746537, 22140.55718885613, 22150.33548993533, 22192.0, 22203.333899983027, 7490.625468726542, 7545.320921117016, 7589.5066820657585, 7616.885746713804, 7700.499467534592, 4039.535453422894, 4063.2889244382113, 4081.7959102045374, 4089.2230476209425, 4101.507819061672, 3650.452432135201, 3658.213484100878, 3681.3189559931498, 3684.9631503685155, 3739.8317075731657, 601.9097135429633, 602.4758460139707, 615.3385111005687, 615.5352708704988, 627.1470799712388, 499.6951859365784, 565.1438071321951, 613.1477246627192, 618.6473709985355, 627.4133685004444, 7771.911932329478, 7838.176991415819, 8433.493990360597, 8509.276711479593, 8661.437006594551, 605.6214865708932, 616.3435940723116, 625.7497001199556, 626.0952923026183, 647.1102234427661, 3523.5419395478425, 3832.80835958201, 3893.766374017568, 3982.9601703983167, 4010.939835902464, 96146.51926740322, 96470.51764741131, 97361.05277894544, 99581.50209248907, 99743.0, 77467.61266193633, 78954.0, 79850.6007469959, 80486.39027219423, 84810.15189848146, 55253.723731381084, 71398.2860171402, 71978.64010679912, 73264.26735732575, 74325.0, 6813.659317034228, 6897.379235868796, 7783.571903545359, 7978.84042319162, 8000.319972802377, 50923.47229583118, 50991.49008510016, 51203.231951520014, 51959.0, 53272.46727532675, 57726.7113664429, 66470.33824154435, 70188.59622807617, 70629.0, 71272.64363678149, 10204.38773673582, 10396.0, 10440.843387349349, 10451.634192803216, 10519.579216831547, 10893.0, 11052.944735276273, 11214.775704486028, 11275.267107637977, 11284.21010529255, 8808.471491710518, 10343.431111288952, 10484.528196231035, 10543.57825686964, 10833.133349332193, 9560.952195238979, 10112.393256404639, 10197.74505637365, 10604.8939510607, 10700.464976751287, 9969.30214884951, 10386.844197337197, 10497.947510262706, 10562.947185264025, 10654.307470014424, 8909.688160914337, 8951.328650351119, 9102.772430689021, 9159.450432974043, 9319.813603728024, 9016.143466370684, 9078.04680508537, 9171.266298695955, 9180.495072771062, 9327.067293270618], "value": 6944.876809910081, "unit": "score"}], "name": "dromaeo_css", "value": 7584.670130245291, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 116.0, 114.0, 117.0, 150.0, 155.0, 115.0, 115.0, 113.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 108.0, 181.0, 193.0, 128.0, 169.0, 169.0, 123.0, 170.0, 120.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 192.0, 197.0, 204.0, 279.0, 252.0, 193.0, 198.0, 197.0], "value": 210.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 80.0, 146.0, 57.0, 57.0, 60.0, 70.0, 130.0, 65.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 169.0, 111.0, 116.0, 88.0, 124.0, 78.0, 77.0, 126.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 87.0, 111.0, 86.0, 89.0, 87.0, 90.0, 86.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 113.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 91.0, 91.0, 100.0, 90.0, 89.0, 125.0, 115.0, 90.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 63.0, 64.0, 66.0, 67.0, 68.0, 82.0, 63.0, 62.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 91.0, 100.0, 95.0, 97.0, 75.0, 69.0, 66.0, 67.0, 65.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 82.0, 103.0, 105.0, 102.0, 106.0, 79.0, 82.0, 81.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 127.0, 125.0, 132.0, 135.0, 128.0, 124.0, 149.0, 164.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 165.0, 168.0, 160.0, 170.0, 167.0, 160.0, 165.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 69.0, 66.0, 70.0, 65.0, 68.0, 67.0, 68.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1555.4, "alertThreshold": 2.0}]} 11:32:16 INFO - Return code: 0 11:32:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:16 ERROR - # TBPL SUCCESS # 11:32:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:16 INFO - 2016-07-18 11:32:16.394 screenresolution[1952:17679] starting screenresolution argv=screenresolution get 11:32:16 INFO - 2016-07-18 11:32:16.396 screenresolution[1952:17679] Display 0: 1600x1200x32@60 11:32:16 INFO - 2016-07-18 11:32:16.402 screenresolution[1953:17682] starting screenresolution argv=screenresolution list 11:32:16 INFO - Available Modes on Display 0 11:32:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:16 INFO - Intel Iris: 11:32:16 INFO - Chipset Model: Intel Iris 11:32:16 INFO - Type: GPU 11:32:16 INFO - Bus: Built-In 11:32:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:16 INFO - Vendor: Intel (0x8086) 11:32:16 INFO - Device ID: 0x0a2e 11:32:16 INFO - Revision ID: 0x0009 11:32:16 INFO - Displays: 11:32:16 INFO - Display: 11:32:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:16 INFO - Display Serial Number: 1600x1200 60 11:32:16 INFO - Main Display: Yes 11:32:16 INFO - Mirror: Off 11:32:16 INFO - Online: Yes 11:32:16 INFO - Rotation: Supported 11:32:16 INFO - Return code: 0 11:32:16 INFO - Running post-action listener: _resource_record_post_action 11:32:16 INFO - Running post-run listener: _resource_record_post_run 11:32:17 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 1130496; Write bytes: 496058368; Read time: 13; Write time: 1841 11:32:17 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186925568; Write bytes: 186120192; Read time: 17581; Write time: 363 11:32:17 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1130496; Write bytes: 299145216; Read time: 13; Write time: 1442 11:32:17 INFO - Running post-run listener: _upload_blobber_files 11:32:17 INFO - Blob upload gear active. 11:32:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:17 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 11:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:19 INFO - (blobuploader) - INFO - Done attempting. 11:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:22 INFO - (blobuploader) - INFO - Done attempting. 11:32:22 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:22 INFO - Return code: 0 11:32:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/016835420b5029ced088e27f12efba43cbac41cd2f867e84691ccabcf39a3632ada67c2c4d4e783e90f201c08e960a546543cc6f675e283258decf6ca1f44ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a59fb3ec856fdc4426f9ba2f6a991442b2b811da93b58f32e72403b4e3954e7d7b29aaa89a976abf0f80f9bcad55567a9be9cc83caa3793848ed1379d33af6c5"} 11:32:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:22 INFO - Contents: 11:32:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/016835420b5029ced088e27f12efba43cbac41cd2f867e84691ccabcf39a3632ada67c2c4d4e783e90f201c08e960a546543cc6f675e283258decf6ca1f44ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a59fb3ec856fdc4426f9ba2f6a991442b2b811da93b58f32e72403b4e3954e7d7b29aaa89a976abf0f80f9bcad55567a9be9cc83caa3793848ed1379d33af6c5"} 11:32:22 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:22 INFO - Copying logs to upload dir... 11:32:22 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.569685 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-18 11:32:23.061261) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:23.065234) ========= 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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/016835420b5029ced088e27f12efba43cbac41cd2f867e84691ccabcf39a3632ada67c2c4d4e783e90f201c08e960a546543cc6f675e283258decf6ca1f44ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a59fb3ec856fdc4426f9ba2f6a991442b2b811da93b58f32e72403b4e3954e7d7b29aaa89a976abf0f80f9bcad55567a9be9cc83caa3793848ed1379d33af6c5"} build_url:https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/MYI81tjVRRCr9uF6GfpUrg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/016835420b5029ced088e27f12efba43cbac41cd2f867e84691ccabcf39a3632ada67c2c4d4e783e90f201c08e960a546543cc6f675e283258decf6ca1f44ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a59fb3ec856fdc4426f9ba2f6a991442b2b811da93b58f32e72403b4e3954e7d7b29aaa89a976abf0f80f9bcad55567a9be9cc83caa3793848ed1379d33af6c5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:23.101646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:23.102363) ========= 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.7aBZ1K7rDo/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.ZgQjKqySdg/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005264 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 11:32:23.152469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:32:23.152828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 11:32:23.153149) ========= ========= Total master_lag: 0.47 =========