builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0314 starttime: 1465220240.82 results: success (0) buildid: 20160606010529 builduid: 78750d9664274d05bee96204469a3a74 revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.816771) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.817263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.817557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.839433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.839783) ========= 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.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-06 06:37:20-- 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% 62.3M=0s 2016-06-06 06:37:20 (62.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.990728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:20.991118) ========= 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.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.020027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.040958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.041308) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-06 06:37:21,121 truncating revision to first 12 chars 2016-06-06 06:37:21,122 Setting DEBUG logging. 2016-06-06 06:37:21,122 attempt 1/10 2016-06-06 06:37:21,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8adb38dd576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:37:21,792 unpacking tar archive at: mozilla-aurora-d8adb38dd576/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.991495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.991934) ========= script_repo_revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.992360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:21.992654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:37:22.009649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-06 06:37:22.009971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:22 INFO - MultiFileLogger online at 20160606 06:37:22 in /builds/slave/test 06:37:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:37:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:22 INFO - {'append_to_log': False, 06:37:22 INFO - 'base_work_dir': '/builds/slave/test', 06:37:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:37:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:22 INFO - 'branch': 'Mozilla-Aurora', 06:37:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:22 INFO - 'config_files': ('talos/mac_config.py',), 06:37:22 INFO - 'default_actions': ('clobber', 06:37:22 INFO - 'read-buildbot-config', 06:37:22 INFO - 'download-and-extract', 06:37:22 INFO - 'populate-webroot', 06:37:22 INFO - 'create-virtualenv', 06:37:22 INFO - 'install', 06:37:22 INFO - 'run-tests'), 06:37:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:22 INFO - 'download_minidump_stackwalk': True, 06:37:22 INFO - 'download_symbols': 'ondemand', 06:37:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:22 INFO - 'installer_path': 'installer.exe', 06:37:22 INFO - 'log_level': 'info', 06:37:22 INFO - 'log_name': 'talos', 06:37:22 INFO - 'log_to_console': True, 06:37:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:37:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:37:22 INFO - 'opt_config_files': (), 06:37:22 INFO - 'pip_index': False, 06:37:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:37:22 INFO - 'cmd': ('bash', 06:37:22 INFO - '-c', 06:37:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:37:22 INFO - 'enabled': True, 06:37:22 INFO - 'halt_on_failure': False, 06:37:22 INFO - 'name': 'check_screen_resolution'},), 06:37:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:37:22 INFO - 'cmd': ('bash', 06:37:22 INFO - '-c', 06:37:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:37:22 INFO - 'enabled': True, 06:37:22 INFO - 'halt_on_failure': False, 06:37:22 INFO - 'name': 'check_screen_resolution'},), 06:37:22 INFO - 'run_cmd_checks_enabled': True, 06:37:22 INFO - 'sps_profile': False, 06:37:22 INFO - 'sps_profile_interval': 0, 06:37:22 INFO - 'suite': 'dromaeojs-e10s', 06:37:22 INFO - 'system_bits': '32', 06:37:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:22 INFO - 'title': 't-yosemite-r7-0314', 06:37:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:22 INFO - 'use_talos_json': True, 06:37:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:22 INFO - 'work_dir': 'build'} 06:37:22 INFO - ##### 06:37:22 INFO - ##### Running clobber step. 06:37:22 INFO - ##### 06:37:22 INFO - Running pre-action listener: _resource_record_pre_action 06:37:22 INFO - Running main action method: clobber 06:37:22 INFO - rmtree: /builds/slave/test/build 06:37:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:23 INFO - Running post-action listener: _resource_record_post_action 06:37:23 INFO - ##### 06:37:23 INFO - ##### Running read-buildbot-config step. 06:37:23 INFO - ##### 06:37:23 INFO - Running pre-action listener: _resource_record_pre_action 06:37:23 INFO - Running main action method: read_buildbot_config 06:37:23 INFO - Using buildbot properties: 06:37:23 INFO - { 06:37:23 INFO - "project": "", 06:37:23 INFO - "product": "firefox", 06:37:23 INFO - "script_repo_revision": "production", 06:37:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:37:23 INFO - "repository": "", 06:37:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:37:23 INFO - "buildid": "20160606010529", 06:37:23 INFO - "pgo_build": "False", 06:37:23 INFO - "basedir": "/builds/slave/test", 06:37:23 INFO - "buildnumber": 24, 06:37:23 INFO - "slavename": "t-yosemite-r7-0314", 06:37:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:37:23 INFO - "platform": "yosemite_r7", 06:37:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:37:23 INFO - "branch": "mozilla-aurora", 06:37:23 INFO - "repo_path": "releases/mozilla-aurora", 06:37:23 INFO - "revision": "d8adb38dd576398dacbfb96d2c247f8e0158bdf1", 06:37:23 INFO - "stage_platform": "macosx64", 06:37:23 INFO - "builduid": "78750d9664274d05bee96204469a3a74", 06:37:23 INFO - "slavebuilddir": "test" 06:37:23 INFO - } 06:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 06:37:23 INFO - Running post-action listener: _resource_record_post_action 06:37:23 INFO - ##### 06:37:23 INFO - ##### Running download-and-extract step. 06:37:23 INFO - ##### 06:37:23 INFO - Running pre-action listener: _resource_record_pre_action 06:37:23 INFO - Running main action method: download_and_extract 06:37:23 INFO - mkdir: /builds/slave/test/build/tests 06:37:23 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')]} 06:37:23 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 06:37:24 INFO - Downloaded 1199 bytes. 06:37:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:37:24 INFO - Using the following test package requirements: 06:37:24 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:37:24 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 06:37:24 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 06:37:24 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'jsshell-mac.zip'], 06:37:24 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 06:37:24 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:37:24 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 06:37:24 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 06:37:24 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 06:37:24 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:37:24 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 06:37:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:24 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:37:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:37:25 INFO - Downloaded 18466859 bytes. 06:37:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:37:28 INFO - Return code: 0 06:37:28 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:28 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:37:29 INFO - Downloaded 18466859 bytes. 06:37:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:37:33 INFO - Return code: 0 06:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:33 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:37:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:37:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:37:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:37:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:37:34 INFO - Downloaded 10840145 bytes. 06:37:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:37:34 INFO - Return code: 0 06:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:34 INFO - https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 06:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 06:37:37 INFO - Downloaded 114179823 bytes. 06:37:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:37 INFO - mkdir: /builds/slave/test/properties 06:37:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:37 INFO - Contents: 06:37:37 INFO - build_url:https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:37:38 INFO - Running post-action listener: _resource_record_post_action 06:37:38 INFO - Running post-action listener: set_extra_try_arguments 06:37:38 INFO - ##### 06:37:38 INFO - ##### Running populate-webroot step. 06:37:38 INFO - ##### 06:37:38 INFO - Running pre-action listener: _resource_record_pre_action 06:37:38 INFO - Running main action method: populate_webroot 06:37:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:38 INFO - '--tppagecycles', 06:37:38 INFO - '7'], 06:37:38 INFO - 'tests': ['tsvgm']}}, 06:37:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['damp', 'tps']}, 06:37:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'tests': ['damp', 'tps']}, 06:37:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['dromaeo_dom']}, 06:37:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['a11yr', 06:37:38 INFO - 'ts_paint', 06:37:38 INFO - 'tpaint', 06:37:38 INFO - 'sessionrestore', 06:37:38 INFO - 'sessionrestore_no_auto_restore', 06:37:38 INFO - 'tabpaint']}, 06:37:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['tsvgx', 06:37:38 INFO - 'tsvgr_opacity', 06:37:38 INFO - 'tart', 06:37:38 INFO - 'tscrollx', 06:37:38 INFO - 'cart']}, 06:37:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:38 INFO - 'tsvgr_opacity', 06:37:38 INFO - 'tart', 06:37:38 INFO - 'tscrollx', 06:37:38 INFO - 'cart']}, 06:37:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'talos_options': ['--disable-e10s'], 06:37:38 INFO - 'tests': ['tp5o']}, 06:37:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'tests': ['tp5o']}, 06:37:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'talos_options': ['--disable-e10s', 06:37:38 INFO - '--xperf_path', 06:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:38 INFO - 'tests': ['tp5n']}, 06:37:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:38 INFO - 'talos_options': ['--xperf_path', 06:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:38 INFO - 'tests': ['tp5n']}}, 06:37:38 INFO - 'talos.zip': {'path': '', 06:37:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:38 INFO - Running post-action listener: _resource_record_post_action 06:37:38 INFO - ##### 06:37:38 INFO - ##### Running create-virtualenv step. 06:37:38 INFO - ##### 06:37:38 INFO - Running pre-action listener: _resource_record_pre_action 06:37:38 INFO - Running main action method: create_virtualenv 06:37:38 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:38 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 06:37:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:38 INFO - Using real prefix '/tools/python27' 06:37:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:41 INFO - Installing pip.................done. 06:37:41 INFO - Return code: 0 06:37:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:41 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')]} 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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')]} 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:41 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:41 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 06:37:41 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 06:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:41 INFO - 'HOME': '/Users/cltbld', 06:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:41 INFO - 'LOGNAME': 'cltbld', 06:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:41 INFO - 'MOZ_NO_REMOTE': '1', 06:37:41 INFO - 'NO_EM_RESTART': '1', 06:37:41 INFO - 'PAGER': '/bin/cat', 06:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:41 INFO - 'PWD': '/builds/slave/test', 06:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:41 INFO - 'SHELL': '/bin/bash', 06:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:41 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:41 INFO - 'USER': 'cltbld', 06:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:41 INFO - 'XPC_FLAGS': '0x0', 06:37:41 INFO - 'XPC_SERVICE_NAME': '0', 06:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:42 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 06:37:42 INFO - Cleaning up... 06:37:42 INFO - Return code: 0 06:37:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:37:42 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')]} 06:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:42 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')]} 06:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:42 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:42 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 06:37:42 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 06:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:42 INFO - 'HOME': '/Users/cltbld', 06:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:42 INFO - 'LOGNAME': 'cltbld', 06:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:42 INFO - 'MOZ_NO_REMOTE': '1', 06:37:42 INFO - 'NO_EM_RESTART': '1', 06:37:42 INFO - 'PAGER': '/bin/cat', 06:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:42 INFO - 'PWD': '/builds/slave/test', 06:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:42 INFO - 'SHELL': '/bin/bash', 06:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:42 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:42 INFO - 'USER': 'cltbld', 06:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:42 INFO - 'XPC_FLAGS': '0x0', 06:37:42 INFO - 'XPC_SERVICE_NAME': '0', 06:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:42 INFO - Downloading/unpacking psutil>=0.7.1 06:37:42 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 06:37:42 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 06:37:42 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 06:37:42 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 06:37:42 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 06:37:42 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 06:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:44 INFO - Installing collected packages: psutil 06:37:44 INFO - Running setup.py install for psutil 06:37:45 INFO - building 'psutil._psutil_osx' extension 06:37:45 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 06:37:45 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 06:37:45 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 06:37:45 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 06:37:45 INFO - building 'psutil._psutil_posix' extension 06:37:45 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 06:37:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:45 INFO - ^ 06:37:45 INFO - 1 warning generated. 06:37:45 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 06:37:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:45 INFO - Successfully installed psutil 06:37:45 INFO - Cleaning up... 06:37:45 INFO - Return code: 0 06:37:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:45 INFO - 'HOME': '/Users/cltbld', 06:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:45 INFO - 'LOGNAME': 'cltbld', 06:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:45 INFO - 'MOZ_NO_REMOTE': '1', 06:37:45 INFO - 'NO_EM_RESTART': '1', 06:37:45 INFO - 'PAGER': '/bin/cat', 06:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:45 INFO - 'PWD': '/builds/slave/test', 06:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:45 INFO - 'SHELL': '/bin/bash', 06:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:45 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:45 INFO - 'USER': 'cltbld', 06:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:45 INFO - 'XPC_FLAGS': '0x0', 06:37:45 INFO - 'XPC_SERVICE_NAME': '0', 06:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:46 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 06:37:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:37:48 INFO - Installing collected packages: mozsystemmonitor 06:37:48 INFO - Running setup.py install for mozsystemmonitor 06:37:48 INFO - Successfully installed mozsystemmonitor 06:37:48 INFO - Cleaning up... 06:37:48 INFO - Return code: 0 06:37:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:48 INFO - 'HOME': '/Users/cltbld', 06:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:48 INFO - 'LOGNAME': 'cltbld', 06:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:48 INFO - 'MOZ_NO_REMOTE': '1', 06:37:48 INFO - 'NO_EM_RESTART': '1', 06:37:48 INFO - 'PAGER': '/bin/cat', 06:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:48 INFO - 'PWD': '/builds/slave/test', 06:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:48 INFO - 'SHELL': '/bin/bash', 06:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:48 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:48 INFO - 'USER': 'cltbld', 06:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:48 INFO - 'XPC_FLAGS': '0x0', 06:37:48 INFO - 'XPC_SERVICE_NAME': '0', 06:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:49 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:49 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 06:37:49 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 06:37:49 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 06:37:49 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 06:37:49 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 06:37:49 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 06:37:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:52 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 06:37:52 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 06:37:52 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 06:37:52 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 06:37:52 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 06:37:52 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 06:37:52 INFO - Downloading docopt-0.6.1.tar.gz 06:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:52 INFO - Running setup.py install for blobuploader 06:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:52 INFO - Running setup.py install for requests 06:37:53 INFO - Running setup.py install for docopt 06:37:53 INFO - Successfully installed blobuploader requests docopt 06:37:53 INFO - Cleaning up... 06:37:53 INFO - Return code: 0 06:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:53 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:53 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 06:37:53 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 06:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:53 INFO - 'HOME': '/Users/cltbld', 06:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:53 INFO - 'LOGNAME': 'cltbld', 06:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:53 INFO - 'MOZ_NO_REMOTE': '1', 06:37:53 INFO - 'NO_EM_RESTART': '1', 06:37:53 INFO - 'PAGER': '/bin/cat', 06:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:53 INFO - 'PWD': '/builds/slave/test', 06:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:53 INFO - 'SHELL': '/bin/bash', 06:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:53 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:53 INFO - 'USER': 'cltbld', 06:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:53 INFO - 'XPC_FLAGS': '0x0', 06:37:53 INFO - 'XPC_SERVICE_NAME': '0', 06:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:53 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8oUa5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-8CDcSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-P3E9ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-gLFqCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vzLp_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PPOpk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-eAElKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Zv32uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DmGCRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-izJcI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:54 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-zfJ7SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IYTxvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-7oe7e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-c0VLa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-qfPF2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-vmvJzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:55 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-RsInss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:55 INFO - Running setup.py install for manifestparser 06:37:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:55 INFO - Running setup.py install for mozcrash 06:37:56 INFO - Running setup.py install for mozdebug 06:37:56 INFO - Running setup.py install for mozdevice 06:37:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozfile 06:37:56 INFO - Running setup.py install for mozhttpd 06:37:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozinfo 06:37:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozInstall 06:37:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozleak 06:37:57 INFO - Running setup.py install for mozlog 06:37:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for moznetwork 06:37:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for mozprocess 06:37:57 INFO - Running setup.py install for mozprofile 06:37:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for mozrunner 06:37:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for mozscreenshot 06:37:58 INFO - Running setup.py install for moztest 06:37:58 INFO - Running setup.py install for mozversion 06:37:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:58 INFO - Cleaning up... 06:37:58 INFO - Return code: 0 06:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:58 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:37:58 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 06:37:58 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 06:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:58 INFO - 'HOME': '/Users/cltbld', 06:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:58 INFO - 'LOGNAME': 'cltbld', 06:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:58 INFO - 'MOZ_NO_REMOTE': '1', 06:37:58 INFO - 'NO_EM_RESTART': '1', 06:37:58 INFO - 'PAGER': '/bin/cat', 06:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:58 INFO - 'PWD': '/builds/slave/test', 06:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:58 INFO - 'SHELL': '/bin/bash', 06:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:37:58 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:58 INFO - 'USER': 'cltbld', 06:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:58 INFO - 'XPC_FLAGS': '0x0', 06:37:58 INFO - 'XPC_SERVICE_NAME': '0', 06:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:58 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-AVXR09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:58 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-08IM3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:58 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DOC0o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:58 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-3Q5PuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-XEb5rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-mWeh2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-mmwpmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-kZLeb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-k9LTxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-DWK12r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZlPvTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-5yzt6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-5uh2K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:59 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-SmrPWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:00 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)) 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:00 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-LUDG9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:00 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)) 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:00 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-FPpqv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:00 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)) 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:00 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-w5zRzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:00 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)) 06:38:00 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)) 06:38:00 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)) 06:38:00 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)) 06:38:00 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)) 06:38:00 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)) 06:38:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:02 INFO - Downloading blessings-1.6.tar.gz 06:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:02 INFO - Installing collected packages: blessings 06:38:02 INFO - Running setup.py install for blessings 06:38:03 INFO - Successfully installed blessings 06:38:03 INFO - Cleaning up... 06:38:03 INFO - Return code: 0 06:38:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:03 INFO - Reading from file tmpfile_stdout 06:38:03 INFO - Current package versions: 06:38:03 INFO - blessings == 1.6 06:38:03 INFO - blobuploader == 1.2.4 06:38:03 INFO - docopt == 0.6.1 06:38:03 INFO - manifestparser == 1.1 06:38:03 INFO - mozInstall == 1.12 06:38:03 INFO - mozcrash == 0.17 06:38:03 INFO - mozdebug == 0.1 06:38:03 INFO - mozdevice == 0.48 06:38:03 INFO - mozfile == 1.2 06:38:03 INFO - mozhttpd == 0.7 06:38:03 INFO - mozinfo == 0.9 06:38:03 INFO - mozleak == 0.1 06:38:03 INFO - mozlog == 3.1 06:38:03 INFO - moznetwork == 0.27 06:38:03 INFO - mozprocess == 0.22 06:38:03 INFO - mozprofile == 0.28 06:38:03 INFO - mozrunner == 6.11 06:38:03 INFO - mozscreenshot == 0.1 06:38:03 INFO - mozsystemmonitor == 0.0 06:38:03 INFO - moztest == 0.7 06:38:03 INFO - mozversion == 1.4 06:38:03 INFO - psutil == 3.1.1 06:38:03 INFO - requests == 1.2.3 06:38:03 INFO - wsgiref == 0.1.2 06:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:03 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')]} 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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')]} 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:38:03 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 06:38:03 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 06:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:03 INFO - 'HOME': '/Users/cltbld', 06:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:03 INFO - 'LOGNAME': 'cltbld', 06:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:03 INFO - 'MOZ_NO_REMOTE': '1', 06:38:03 INFO - 'NO_EM_RESTART': '1', 06:38:03 INFO - 'PAGER': '/bin/cat', 06:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:03 INFO - 'PWD': '/builds/slave/test', 06:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:03 INFO - 'SHELL': '/bin/bash', 06:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:38:03 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:03 INFO - 'USER': 'cltbld', 06:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:03 INFO - 'XPC_FLAGS': '0x0', 06:38:03 INFO - 'XPC_SERVICE_NAME': '0', 06:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 INFO - Cleaning up... 06:38:03 INFO - Return code: 0 06:38:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:03 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')]} 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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')]} 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:38:03 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 06:38:03 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 06:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:03 INFO - 'HOME': '/Users/cltbld', 06:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:03 INFO - 'LOGNAME': 'cltbld', 06:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:03 INFO - 'MOZ_NO_REMOTE': '1', 06:38:03 INFO - 'NO_EM_RESTART': '1', 06:38:03 INFO - 'PAGER': '/bin/cat', 06:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:03 INFO - 'PWD': '/builds/slave/test', 06:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:03 INFO - 'SHELL': '/bin/bash', 06:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:38:03 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:03 INFO - 'USER': 'cltbld', 06:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:03 INFO - 'XPC_FLAGS': '0x0', 06:38:03 INFO - 'XPC_SERVICE_NAME': '0', 06:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:03 INFO - Downloading/unpacking jsonschema 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:06 INFO - Downloading/unpacking functools32 (from jsonschema) 06:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:06 INFO - warning: no files found matching '*.txt' 06:38:06 INFO - no previously-included directories found matching 'build' 06:38:06 INFO - no previously-included directories found matching 'dist' 06:38:06 INFO - no previously-included directories found matching '.git*' 06:38:06 INFO - Installing collected packages: jsonschema, functools32 06:38:06 INFO - Running setup.py install for functools32 06:38:06 INFO - warning: no files found matching '*.txt' 06:38:06 INFO - no previously-included directories found matching 'build' 06:38:06 INFO - no previously-included directories found matching 'dist' 06:38:06 INFO - no previously-included directories found matching '.git*' 06:38:07 INFO - Successfully installed jsonschema functools32 06:38:07 INFO - Cleaning up... 06:38:07 INFO - Return code: 0 06:38:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:07 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 0x10d1a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe99bd9a2b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, '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.bEK34jwFHw/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.H8GliXw0cx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 06:38:07 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 06:38:07 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 06:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:07 INFO - 'HOME': '/Users/cltbld', 06:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:07 INFO - 'LOGNAME': 'cltbld', 06:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:07 INFO - 'MOZ_NO_REMOTE': '1', 06:38:07 INFO - 'NO_EM_RESTART': '1', 06:38:07 INFO - 'PAGER': '/bin/cat', 06:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:07 INFO - 'PWD': '/builds/slave/test', 06:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:07 INFO - 'SHELL': '/bin/bash', 06:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:38:07 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:07 INFO - 'USER': 'cltbld', 06:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:07 INFO - 'XPC_FLAGS': '0x0', 06:38:07 INFO - 'XPC_SERVICE_NAME': '0', 06:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:07 INFO - Downloading/unpacking flake8 06:38:07 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 06:38:07 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 06:38:07 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 06:38:07 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 06:38:07 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 06:38:07 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 06:38:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:38:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:38:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:10 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 06:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:11 INFO - no previously-included directories found matching 'docs/_build' 06:38:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:38:11 INFO - Running setup.py install for pep8 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:11 INFO - no previously-included directories found matching 'docs/_build' 06:38:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:38:11 INFO - Cleaning up... 06:38:11 INFO - Return code: 0 06:38:11 INFO - Running post-action listener: _resource_record_post_action 06:38:11 INFO - Running post-action listener: _start_resource_monitoring 06:38:11 INFO - Starting resource monitoring. 06:38:11 INFO - ##### 06:38:11 INFO - ##### Running install step. 06:38:11 INFO - ##### 06:38:11 INFO - Running pre-action listener: _resource_record_pre_action 06:38:11 INFO - Running main action method: install 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:11 INFO - Reading from file tmpfile_stdout 06:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:11 INFO - Reading from file tmpfile_stdout 06:38:11 INFO - Output received: 06:38:11 INFO - Usage: mozinstall [options] installer 06:38:11 INFO - Options: 06:38:11 INFO - -h, --help show this help message and exit 06:38:11 INFO - -d DEST, --destination=DEST 06:38:11 INFO - Directory to install application into. [default: 06:38:11 INFO - "/builds/slave/test"] 06:38:11 INFO - --app=APP Application being installed. [default: firefox] 06:38:11 INFO - mkdir: /builds/slave/test/build/application 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:38:42 INFO - Reading from file tmpfile_stdout 06:38:42 INFO - Output received: 06:38:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:38:42 INFO - Running post-action listener: _resource_record_post_action 06:38:42 INFO - ##### 06:38:42 INFO - ##### Running run-tests step. 06:38:42 INFO - ##### 06:38:42 INFO - Running pre-action listener: _resource_record_pre_action 06:38:42 INFO - Running main action method: run_tests 06:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:42 INFO - 2016-06-06 06:38:42.970 screenresolution[2682:19481] starting screenresolution argv=screenresolution get 06:38:42 INFO - 2016-06-06 06:38:42.973 screenresolution[2682:19481] Display 0: 1600x1200x32@60 06:38:42 INFO - 2016-06-06 06:38:42.978 screenresolution[2683:19484] starting screenresolution argv=screenresolution list 06:38:42 INFO - Available Modes on Display 0 06:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:43 INFO - Intel Iris: 06:38:43 INFO - Chipset Model: Intel Iris 06:38:43 INFO - Type: GPU 06:38:43 INFO - Bus: Built-In 06:38:43 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:43 INFO - Vendor: Intel (0x8086) 06:38:43 INFO - Device ID: 0x0a2e 06:38:43 INFO - Revision ID: 0x0009 06:38:43 INFO - Displays: 06:38:43 INFO - Display: 06:38:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:43 INFO - Display Serial Number: 1600x1200 60 06:38:43 INFO - Main Display: Yes 06:38:43 INFO - Mirror: Off 06:38:43 INFO - Online: Yes 06:38:43 INFO - Rotation: Supported 06:38:43 INFO - Return code: 0 06:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:43 INFO - Python 2.7.3 06:38:43 INFO - Return code: 0 06:38:43 INFO - grabbing minidump binary from tooltool 06:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:43 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 0x10d046e00>, '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 0x10ceafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d041b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:43 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 06:38:43 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 06:38:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:43 INFO - Return code: 0 06:38:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:38:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:38:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:38:44 INFO - Return code: 0 06:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 06:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --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 06:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bEK34jwFHw/Render', 06:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:44 INFO - 'HOME': '/Users/cltbld', 06:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:44 INFO - 'LOGNAME': 'cltbld', 06:38:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:44 INFO - 'MOZ_NO_REMOTE': '1', 06:38:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:44 INFO - 'NO_EM_RESTART': '1', 06:38:44 INFO - 'PAGER': '/bin/cat', 06:38:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:44 INFO - 'PWD': '/builds/slave/test', 06:38:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:44 INFO - 'SHELL': '/bin/bash', 06:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H8GliXw0cx/Listeners', 06:38:44 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 06:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:44 INFO - 'USER': 'cltbld', 06:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:44 INFO - 'XPC_FLAGS': '0x0', 06:38:44 INFO - 'XPC_SERVICE_NAME': '0', 06:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--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 06:38:44 INFO - mozversion application_buildid: 20160606010529 06:38:44 INFO - mozversion application_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 06:38:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:38:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:44 INFO - mozversion application_name: Firefox 06:38:44 INFO - mozversion application_remotingname: firefox-dev 06:38:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:38:44 INFO - mozversion application_vendor: Mozilla 06:38:44 INFO - mozversion application_version: 48.0a2 06:38:44 INFO - mozversion platform_buildid: 20160606010529 06:38:44 INFO - mozversion platform_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 06:38:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:38:44 INFO - mozversion platform_version: 48.0a2 06:38:44 INFO - using testdate: 1465220324 06:38:44 INFO - actual date: 1465220324 06:38:44 INFO - starting webserver on 'localhost:53176' 06:38:44 INFO - SUITE-START | Running 2 tests 06:38:44 INFO - TEST-START | dromaeo_css 06:38:44 INFO - operating with platform_type : mac_ 06:38:44 INFO - Initialising browser for dromaeo_css test... 06:38:44 INFO - TEST-INFO | started process 2702 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpsMXTYg/profile http://localhost:53176/getInfo.html) 06:38:47 INFO - PROCESS | 2702 | __metrics Screen width/height:1600/1200 06:38:47 INFO - PROCESS | 2702 | colorDepth:24 06:38:47 INFO - PROCESS | 2702 | Browser inner width/height: 1024/689 06:38:47 INFO - PROCESS | 2702 | __metrics 06:38:47 ERROR - PROCESS | 2702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:38:48 INFO - TEST-INFO | 2702: exit 0 06:38:48 INFO - Browser initialized. 06:38:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:48 INFO - TEST-INFO | started process 2705 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpsMXTYg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:59 INFO - PROCESS | 2705 | RSS: Main: 221106176 06:38:59 INFO - PROCESS | 2705 | 06:39:49 INFO - PROCESS | 2705 | 1465220389567 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] 06:42:00 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53176/tests/dromaeo/cssquery-ext.html) 06:42:02 INFO - PROCESS | 2705 | RSS: Main: 231440384 06:42:02 INFO - PROCESS | 2705 | 06:45:04 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-ext.html (next: http://localhost:53176/tests/dromaeo/cssquery-jquery.html) 06:45:04 INFO - PROCESS | 2705 | RSS: Main: 243789824 06:45:04 INFO - PROCESS | 2705 | 06:48:06 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53176/tests/dromaeo/cssquery-mootools.html) 06:48:07 INFO - PROCESS | 2705 | RSS: Main: 245186560 06:48:07 INFO - PROCESS | 2705 | 06:51:08 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53176/tests/dromaeo/cssquery-prototype.html) 06:51:09 INFO - PROCESS | 2705 | RSS: Main: 247218176 06:51:09 INFO - PROCESS | 2705 | 06:54:12 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53176/tests/dromaeo/cssquery-yui.html) 06:54:12 INFO - PROCESS | 2705 | RSS: Main: 250068992 06:54:12 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | Cycle 1(1): loaded http://localhost:53176/tests/dromaeo/cssquery-yui.html (next: http://localhost:53176/tests/dromaeo/cssquery-dojo.html) 06:57:15 INFO - PROCESS | 2705 | RSS: Main: 251408384 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | __start_tp_report 06:57:15 INFO - PROCESS | 2705 | _x_x_mozilla_page_load 06:57:15 INFO - PROCESS | 2705 | _x_x_mozilla_page_load_details 06:57:15 INFO - PROCESS | 2705 | |i|pagename|runs| 06:57:15 INFO - PROCESS | 2705 | |0;dojo.html;3327.401067807795;3451.137215696076;3481.7562770606037;3495.8951231463066;3510.526078979337;5746.396628354026;5768.365479797224;5781.971090144549;5829.183914252008;5884.764609415629;4071.6131967463043;4231.534531201573;4517.299818528133;4824.782884770185;5144.279800827878;4260.403543503912;5261.421243663194;5313.8937221255555;5353.57171426285;5383.380911195204;5170.457102004292;5299.284596579451;5304.92042619361;5330.546903513206;5345.518903298703;5308.601854860882;5353.5984801139875;5353.652012619187;5356.598255130862;5369.19462080689;4320;4381.737095774248;4477.619402350804;5176.301199338116;5290.312259406272;4226.260404429243;5160.380754309469;5216.347956505437;5278.4721527846905;5323.148296272578;5729.083346664555;5778.24882765242;5790.71046447676;5798.768049278066;5800.4489573490455;6122.142899994004;6166.784162554289;6185.969070154621;6204.906926396107;6240;6240.219972503437;6267.3105958345;6278.277998030239;6281.7173227204885;6282.717277722513;5862.50168735658;5903.35063143054;5924.881502369928;5946.078357854496;5983.192269043667;6204.720787564571;6243.812685619348;6292.150559674477;6316.242050953915;6331.176946996861;6181.165542651775;6203.16257305267;6210.130581718563;6228.03465462854;6228.6574238416415;6264.21697287839;6270.028145637433;6273.937260627426;6278.4035516625845;6283.057541368831;6128.19758601264;6182.938170618237;6194.690265486708;6250.374962503804;6259.280182778948;5191.740412979336;6257.2491301044165;6260.718267677966;6264.310925798159;6279.434850863444;4873.147199240118;4873.244647079709;4980.77586508608;4982.626303027288;4986.077575648516;4404.933925991113;4411.7573533455325;4434.26834572292;4485.416895803524;4509.661775366861;5817.331006934257;5818.8254352369495;5872.58891877573;5896.997510423238;5922.703864806743;6138.32709113608;6195.504359651217;6256.74973001084;6275.964465863172;6301.275353334334;5673.375928647845;5832.912506312408;5902.321233058167;5918.7928422505;5951.672658003851;5394.32570928634;5416.10634245353;5443.346798384219;5466.753996070107;5471.562275017989;5403.432639572946;5489.87457571197;6234.407731265523;6309.558330916791;6333.524985626004;6247.406496382836;6256.906146407899;6274.278457977391;6278.780242691667;6291.96854015727;6333.461655759128;6336.778212762531;6344.777932772331;6355.046742988588;6363.936360636334;6118.479929206067;6135.293912123373;6182.319944805978;6221.782237621662;6248;6229.875402492015;6251.437370636664;6276.058591211355;6286.779962701284;6296.716647750954;6159.6612186330185;6159.692015399301;6186.412290832363;6207.751689932352;6214.036824292242;5032.572231360376;5715.742536641932;5997.430244126801;6115.694215289307;6189.319174890668;5161.638685291993;5361.624686271924;5991.910121348096;6011.7595296187665;6031.215941927521;6016.578839481369;6114.449699527064;6155.599886007395;6167.105769663463;6169.598976066542;4742.857714268577;5608.130739735185;5680.77276908919;5693.202951586698;5715.771369145187 06:57:15 INFO - PROCESS | 2705 | |1;ext.html;503.77330201409353;510.50481033397614;514.8635611562935;529.6027979015738;575.9632661209821;33401.83299083504;39537;39655.60344396555;39747.40378894312;39755.602443975586;39771;40416.19167616646;40871.386929196015;40880.59119408813;41125;9439.71680849574;9690.27322950778;9693.709188724315;9701.029897010312;9728.978457261956;9576.281778866613;9830.21358291335;9840.458774767385;9858.852117218248;9869.309148359618;9712.902870971306;9837.262205334593;9841.90158098417;9851.211903047775;9858.901410985905;8181.509109453422;9845.163161131313;9846.9507652462;9867.851982220272;9884.110430061257;9643.180329671986;9717.368371055858;9778.462184579845;9787.314887957846;9791.265655075898;39328.410073848914;39526.40710389346;39881.800590996856;39984.80007599943;40049.79975100135;3294.407006738786;3378.273671160712;3421.26442814796;3549.2546565221332;3621.963780362189;23161.3051608452;28924.71075289262;29037.709622903712;29188.416231675248;29333.70666293331;2733.180045986196;2765.6681198256338;2788.1496143676172;2806.354538456146;2811.9578206326923;448389;451258;452260;458122;458663;59115.113273300936;59247.11129332977;59549.70225148847;59557.40442595519;59561.70219148877;61802;62392;69355.65322173356;70100;70832.64583677049;17468.213930373164;17534.210960506807;17707.29170833178;17745.911270443565;17767.378141764977;13282.136661116996;13409.731805363837;13433.395497202453;13433.798493022612;13439.932800335935;19193.074971394402;19514.25869705879;19577.512640646106;19581.51046223827;19586.06764260477;7002.194747603989;7973.561454120079;7989.681702519136;8108;8204.917950820534;895.7805337692307;938.3150300280834;943.7782121201512;1020.806046851096;1043.7912417516375;30364.54453183204;30516.954695934375;30633.846830765702;30681.539776903363;31021.68978310233;1084.4577711144427;1123.2979387882574;1128.6839684888243;1176.564671071692;1216.4525963316544;15171.848281517265;15551.922240388725;15615.60960975962;15770;15944.2825072872;640159;652238;656537;665844;665939;60598.69700651469;60984.69507652433;61440.07839882405;61551;61682;1491.3214487408204;1503.7819516170093;1514.8333683294609;1522.6726253855475;1526.4962562354397;29716;30015.54976675308;30039.84980075173;30447.54328685116;30587.847060765445;52039.479605203465;52254;52775.47224527859;52812;52958;582773;585938.1406186054;589223;592305;594642;27117.457650846478;27153.86423067872;27205.455890882466;27537.586936195574;27554;46671.29993050175;46919.82700432516;47020.60442289658;47511.28733069076;47689.33087341926;30999.69000309968;38865.02837429087;38882.2223555533;39185;39229.80385098056;37836.204889983164;37907;38000;38628.22743545169;38993.80503097466;37639;37870.24259514739;38154.80922595369;38234.42648360221;38265.80867095758;27160.864195678896;27336.863315683295;32151.28369191424;33392.83303583564;34149.65850341465;25196.49607007886;25556;25716.228513144637;25741.485170296113;25935.870320648275 06:57:15 INFO - PROCESS | 2705 | |2;jquery.html;399.45075521158407;401.09953155166653;403.36872794077266;404.3247776213724;416.5210008490236;16533.834661653378;19793.505162370948;21179.364619061453;21209.57580848382;21726.456838579023;20862;21016.36950891472;21219.68170477444;21882.23412180574;21935.561288774214;5587.441255874421;5840.269966254218;5920.526357891358;5936.198613187229;5954.434328738785;5583.804566840161;5860.208871802295;5936.495397891163;5946.494547963428;6011.819645410645;5810.854728631797;5876.11858221266;5907.734151963172;5925.4370834770625;5940.316863560703;5706.971465142689;6006.759729610811;6087.573869829136;6093.695315234243;6101.511879049665;4543.8182472701055;5092.9236061459105;5100;5882.764689412418;5886.05823068307;15992.680146397122;20176.49558761028;24943.251702448957;25119.87440062788;25212.117575884757;1867.785204701463;2078.272604588397;2088.3421722157473;2247.5954328220914;2292.9656055159185;9665.130138287588;9852;10007.299489035697;10136.543855526445;10172.287939844215;1775.2810111904698;1786.499780061585;1834.8348648621554;1844.3544759334259;1945.2316335047576;108382;109774;114700;120115.3994230032;121466;11452.828207576893;11636.301821890544;11815;11852.525898964117;12027.398630068461;13683.726325473435;14285.500007499895;15005.17471539054;15129.39482420713;15363;7140.607266600283;8776.561171941505;8842.955785221162;8991.685291014783;9009.324300677476;8002.559859207683;8245.051819040887;9000.324975626854;9070.86393704095;9122.498262595622;4629.768511574408;4637.466691330473;4668.603168730628;4673.556012178838;4734.455537613218;1765.8809428685372;1982.464734521671;2022.3719905476232;2065.872151683768;2074.6058248932654;928.6285485805731;931.3387494878576;958.2860768727343;980.9950950245346;1058.655936820521;18759.531011724543;20534.281300154424;21107.68338474924;21291.36125916225;21455;985.2561316206219;1003.9297249192632;1044.9425281609433;1056.9471526423802;1071.8177909755361;10293.919138490352;10325.84511232332;11132;11348.175171568313;11442.828357574643;608234;628197;636003;654548;655839;110126;128835;129874;132586;134307;1025.9435731034864;1037.486444210121;1047.2459828923163;1061.2995423020768;1066.6106870992187;18361.265549377877;18449.800762950366;18585.628287434447;18656.813431865507;18889.338873139375;35038.47442288317;49401.75299123625;51302.486975129774;52835.735821320646;53418;59082.40917590769;72958;76196;77100;78723.21276787388;6956.652167391509;8003.75988720316;8126.390520711088;8210.63052162642;8273.131321211185;12167.209131406431;12258.26450412978;12322.568710095104;12549.184303020274;12695.047871409497;10895.891041089804;11045.779084418427;11223.494942727433;11257.099432045581;11258.549658013588;5863.120531920075;8289.4197406181;10572.471376430994;10902.945485272523;10946.507407166537;10269.229807764597;10471.842922356323;11190.888091118984;11313.321200727984;11529.135314851252;7755.379569634303;8176.46852954556;8184.2224988625985;8433.409661323894;8527.701530446404;8846.867296990422;9730;10561;10722.981316774894;11364.090872730327 06:57:15 INFO - PROCESS | 2705 | |3;mootools.html;1570.5052908333873;1586.524042787164;1822.8723989320754;1902;1965.616704742574;7061.470389720778;7805.4536182467255;8620.913790862089;8835.955820220897;8836.204741573249;8496.192861678132;8529.530875801844;8631.964164300278;8635.568221588912;8637.481751094923;2020.2827996061371;2487.601983682602;2490.3649569359786;2490.6762120924254;2496.787773039294;2461.064795377754;2480.454300053985;2513.0450428837016;2513.5852584323566;2514.396544829246;2442.9633555496594;2462.642916777066;2470.9011639534488;2474.7277799442045;2480.702315722107;2460.889259983296;2480.851148931061;2491.813114016447;2499.212747984379;2499.3751562109474;2506.248125562324;2524.873756312177;2538.0989748639336;2540.9237722868343;2545.592705167183;8786.253168480624;8852.51311177885;8862.379633425662;8866.645334186625;8890.644374225023;5399.433059528771;5426.810061647863;5488.313960754906;5535.612507124503;5560.8331750047155;3430.803493580321;3510.912227194315;3542.220711443478;3573.928521429557;3579.7649810815487;1064.882862885082;1083.7236504691252;1084.5119696136692;1085.5060947268973;1092.1099304067238;11797.705057373549;11920.344381059038;12028.759424811542;12037.398130093461;12067.155299128977;4835.395575553056;4858.7570621468785;4890.437599676083;4939.1109600271575;4951.9752401237765;8637.395382323177;10218.540165692562;10258.230632702576;10286.382817030852;10332.483375831178;5438.755256013489;5456.645318054393;5470.91793623096;5476;5483.7806487740845;3854.402567602026;4126.690498212646;4408.713433626804;4503.234450143484;4900.485449027872;3883.359245724424;4076.6127217914845;4158.563350848118;4180.728252663567;4184.937225941613;1364.2837510307168;1391.8956078294168;1392.693607406369;1393.4008376398247;1400.8319001719656;795.4590878202878;801.7714951238869;886.5434301334818;952.6951375559893;965.8358079126565;5165.457626949192;5918.437748413894;5925.259342582177;5981.790637327673;6009.699515024231;801.7434420985229;819.5492479136451;846.3821410370341;988.9109980101681;1001.9699409017741;3686.2627474505207;3926.5877082906454;3955.7033222508426;3979.263836190314;4025.5370632377067;10440.63457778974;10612.151027917747;10697.518611662494;10738.409387483607;10742.624008159833;10623.150147988143;10628.46857657114;10631.308964917256;10639.89360106389;10690.037896589345;8346.914901062944;8368.83262334762;8419.49483031008;8443.986721593325;8454.365922555833;5619.662820230636;5663.575231857545;5773.162891380643;5798.739056742541;5865.648061116347;9647.035296470296;9674.516274186122;9703.175230105238;9704.660336888175;9783.804323913624;8466.915330846612;9799.461029643153;9834.557444914853;10021.599136034769;10157.746056348651;6388.616682999035;6773.458123350219;7024.719011239493;7069.045678833291;7171.067761191011;8214.58927053657;8232.053313868983;8264.628091736007;8272.586370681562;8273.586320683822;6168.629882207082;7066.893996590158;7393.8890916637365;7486.139094004259;7529.322360987538;6973.965130174317;7101.431885449048;7245.239249878687;7264.455165862687;7328.96335518319;6856.897146542706;6968.407685346802;6968.5122041458635;6975.3024697529845;6996.930030699627;4813.253945638432;4813.9037219254715;4830.396200474941;4948.109340318633;4989.501049894981;4292.549282325311;4735.33705281254;4867.099586576494;4875.1712208923855;4950.851474455772 06:57:15 INFO - PROCESS | 2705 | |4;prototype.html;328.96381398046213;329.99010029699105;332.6008789452657;337.98141102239384;341.94528875379945;5744.281964754406;6433.09936608874;6694.1297631307925;6723.798286051427;6745.763898263555;6656.739686600579;6687.56530825496;6705.161854768154;6717.227518835335;6720.966395168018;4767.523247675222;4842.806287748486;4944.9258261126115;4957.5042495750495;4967;4920.114379411704;4950.752462376885;4957.529034741694;4968.925466117993;4980.6015518758595;4891.070696567658;4899.363082799231;4909.631777616675;4928.334674818907;4939.234418665094;4905.23968784839;4914.582260507861;4918.655694101414;4942.629302802305;5001.949980500185;4264.253755592759;4277.764722940237;4280.764557949312;4284.121755040209;4293.055527783882;6265.310815810257;6448.387403196689;6453.548251622388;6500;6531.412172904414;5868.706564671749;5898.675572843492;5942.61373010753;5943.04911214208;5945.821625351203;5857.589968702193;7182.138143422771;7198.920161975693;7200.135983681992;7215.927840721631;4767.642426818003;4770.0698363819065;4784.784684689197;4788.209945359012;4789.730721358843;7426.851462970764;7680.001599791991;7681.539107653559;7688.461807673465;7693.422993275471;4869.415670119537;4870.342503761947;4879.536444037811;4887.120318342732;4900.093482705711;4931.334269873593;4964.429090654548;4965.882676397781;4968.105740966661;4976.2038073908725;5873.089671100986;5891;5899.262592175978;5903.734331955073;5917.437843404869;7249.093863267091;7255.673494692752;7281.526700764433;7282.563046217244;7290.635468226567;1554.2617256802928;1588.9830508474586;1685.6599003792014;1703.335699077361;1729.9481015569554;878.9165029322204;1013.3615822032073;1013.5793645637126;1055.6780182044397;1064.2869277583882;6522.5760325578685;6571.507136964747;6613.107230523914;6696.029075783984;6730.360615741497;7168.498205125591;7500.812479688051;7510.436717246228;7520.360769334668;7535.208803075599;4752.976235118871;5592;6747.797566073025;6799.388055075067;6842.213145488233;3295.6704329567333;3930.6462418382484;3977.343738283209;4001.379786133154;4010;7946.483478573874;7979;7979.122296547375;7981.72063977758;8019.518828870287;7184.748533801292;7767.145613982458;7789.298963093349;7876.606169691607;7885;7909.3277071449575;7953.363730901514;7966.0440747110715;7972.960135199287;7973.9202607973175;7536.547807131589;7549.433792465697;7560;7570.9242907570215;7588.772336829904;7420.109586849612;7433.851322973618;7436.96281518589;7458.993035940079;7471.813204669927;6363.395477429637;7645.350145237717;7872.488288261245;7969.282764551218;7974.920250797418;4667.836625718083;4692.41344831896;4745.217039188496;4746.264329029006;4746.311784791255;7600.885986710315;7601.581912994839;7612.429067819825;7626.847463050819;7648.34989025939;6295;6940.99355593426;7338.96330518344;7358.22738612438;7393.482456228227;7129.073220481304;7315.524490908074;7344.045274114331;7373.5575865448245;7379.9262007381385;6121.989871671124;6161.675239823459;6496.317886622026;7156.463265255023;7159.498835081495;5626.324841019104;7267.382272506896;7324.157721862054;7325.120985481776;7348.669309880961;6316.463100636313;6700.530962832555;7105.2894710528535;7173.354398104196;7190.676419561028 06:57:15 INFO - PROCESS | 2705 | |5;yui.html;701.6737217194005;732.4689600039972;757.0725860820496;760.623491371771;783.9176886426925;13854.861451385483;14059.297035148253;14826.258687065643;14995.925020374883;15232.619184520392;13902.791458128137;13910.582682519514;13920.58238252854;13925.37335819888;13992.65018374541;771.7453240430644;942.2038377570941;956.3783540698532;982.1013772398283;985.2462865907586;954.6467806911453;961.0917682789767;968.7239136846;979.2655508368723;981.7103954333453;1014.0974532665933;1015.0661391519783;1025.0671888581392;1026.5944951744057;1028.670825335893;948.3740731117498;984.7390441532999;1009.4195837393492;1020.5917632946806;1021.1218352217124;707.4906067631297;763.3816608547095;763.4503157726483;763.6220071064803;768.9154193038761;14464.349104290332;14540;14680.339384727713;14737;14792.704145917021;12670.986321094382;12706.809397859039;12882.677933051655;12931.806022909665;12982.545610903668;9888.258380621483;10101.747456313578;10145.797084058351;10209.591616335338;10236.488175591265;3505.8422370993367;3506.4915587239707;3647.0699971507097;3728.478013078144;3781.3193625147464;77750.61124694397;77909.61045194737;78838;79075;80279.5986020072;9291.256699464027;9344.345895787366;9379.108984646447;9456.52717364129;9552.14030737223;20968.47578810542;20984.79015209859;20988.685169722467;21035.8948205258;21132;7432.739854105081;7450.403967682572;7455.888161677579;7456.96271518639;7472.065991751031;4021.5174179098694;4028.274910516135;4059.3910913363234;4073.9388909166387;4089.5910408958866;3377.2907689385015;3746.138388170736;3748.568914574859;3757.774533527997;3764.887053388403;655.8425977765302;670.580886945659;674.1068084787676;675.0279597379757;676.3507033248137;562.6905202138807;609.5732986909093;615.53527087049;626.5707990026846;638.1034646321925;8127.882933036439;8315.459495132796;8399.11809260031;8714.95642521796;8796.736097917073;603.1706403694919;605.4883623338272;606.8422210225373;625.3027873920546;641.7593402474072;3768.9623103768613;3957.940630890539;3988.3419235825763;3994.580569040267;4113.344151791287;97874;99030;101534.98465015255;101706.98293017123;101790;80539.59730201312;80544;80625;82081;84638;55370.21948744669;70035.64982175057;71571;72106.19734506679;72807.63596181985;7805.375569954504;7889.3294070004695;8005.879911801444;8175.672973081248;8221.917780822116;41368.1726365477;45870;48821.511784881695;49603.25595116004;50102.49897500978;65409.34590654032;68749.93750187503;69030;69822;69906;9569.75593172883;9986.168878489372;10113.69658910234;10191.847122293024;10373.118284945864;8922.55387230623;8992.46045237288;9618;10832.241743078224;11469.197156198987;10513.264071514921;10557.20820938448;10565.683029509128;10738.409387483764;11027.61403350879;8387.496750195009;9670.686571922386;9896.356736812084;9973.800523989625;10260.230482713678;10192.388456692623;10326.793464130826;10438.63464778729;10590.735231618963;10609.840852387066;8958.68644597436;8973.955130224307;9196.35625506208;9259.21296689762;9407.059294070537;9011.954940225258;9095.818083638422;9141;9170.724878253663;9197.632094716404 06:57:15 INFO - PROCESS | 2705 | __end_tp_report 06:57:15 INFO - PROCESS | 2705 | __start_cc_report 06:57:15 INFO - PROCESS | 2705 | _x_x_mozilla_cycle_collect,418 06:57:15 INFO - PROCESS | 2705 | __end_cc_report 06:57:15 INFO - PROCESS | 2705 | __startTimestamp1465221435444__endTimestamp 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | ------- Summary: start ------- 06:57:15 INFO - PROCESS | 2705 | Number of tests: 6 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#0] dojo.html Cycles:165 Average:5685.81 Median:5922.70 stddev:702.91 (11.9%) stddev-sans-first:680.28 06:57:15 INFO - PROCESS | 2705 | Values: 3327.4 3451.1 3481.8 3495.9 3510.5 5746.4 5768.4 5782.0 5829.2 5884.8 4071.6 4231.5 4517.3 4824.8 5144.3 4260.4 5261.4 5313.9 5353.6 5383.4 5170.5 5299.3 5304.9 5330.5 5345.5 5308.6 5353.6 5353.7 5356.6 5369.2 4320.0 4381.7 4477.6 5176.3 5290.3 4226.3 5160.4 5216.3 5278.5 5323.1 5729.1 5778.2 5790.7 5798.8 5800.4 6122.1 6166.8 6186.0 6204.9 6240.0 6240.2 6267.3 6278.3 6281.7 6282.7 5862.5 5903.4 5924.9 5946.1 5983.2 6204.7 6243.8 6292.2 6316.2 6331.2 6181.2 6203.2 6210.1 6228.0 6228.7 6264.2 6270.0 6273.9 6278.4 6283.1 6128.2 6182.9 6194.7 6250.4 6259.3 5191.7 6257.2 6260.7 6264.3 6279.4 4873.1 4873.2 4980.8 4982.6 4986.1 4404.9 4411.8 4434.3 4485.4 4509.7 5817.3 5818.8 5872.6 5897.0 5922.7 6138.3 6195.5 6256.7 6276.0 6301.3 5673.4 5832.9 5902.3 5918.8 5951.7 5394.3 5416.1 5443.3 5466.8 5471.6 5403.4 5489.9 6234.4 6309.6 6333.5 6247.4 6256.9 6274.3 6278.8 6292.0 6333.5 6336.8 6344.8 6355.0 6363.9 6118.5 6135.3 6182.3 6221.8 6248.0 6229.9 6251.4 6276.1 6286.8 6296.7 6159.7 6159.7 6186.4 6207.8 6214.0 5032.6 5715.7 5997.4 6115.7 6189.3 5161.6 5361.6 5991.9 6011.8 6031.2 6016.6 6114.4 6155.6 6167.1 6169.6 4742.9 5608.1 5680.8 5693.2 5715.8 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#1] ext.html Cycles:180 Average:70114.05 Median:39596.30 stddev:153079.42 (386.6%) stddev-sans-first:153419.63 06:57:15 INFO - PROCESS | 2705 | Values: 503.8 510.5 514.9 529.6 576.0 33401.8 39537.0 39655.6 39747.4 39755.6 39771.0 40416.2 40871.4 40880.6 41125.0 9439.7 9690.3 9693.7 9701.0 9729.0 9576.3 9830.2 9840.5 9858.9 9869.3 9712.9 9837.3 9841.9 9851.2 9858.9 8181.5 9845.2 9847.0 9867.9 9884.1 9643.2 9717.4 9778.5 9787.3 9791.3 39328.4 39526.4 39881.8 39984.8 40049.8 3294.4 3378.3 3421.3 3549.3 3622.0 23161.3 28924.7 29037.7 29188.4 29333.7 2733.2 2765.7 2788.1 2806.4 2812.0 448389.0 451258.0 452260.0 458122.0 458663.0 59115.1 59247.1 59549.7 59557.4 59561.7 61802.0 62392.0 69355.7 70100.0 70832.6 17468.2 17534.2 17707.3 17745.9 17767.4 13282.1 13409.7 13433.4 13433.8 13439.9 19193.1 19514.3 19577.5 19581.5 19586.1 7002.2 7973.6 7989.7 8108.0 8204.9 895.8 938.3 943.8 1020.8 1043.8 30364.5 30517.0 30633.8 30681.5 31021.7 1084.5 1123.3 1128.7 1176.6 1216.5 15171.8 15551.9 15615.6 15770.0 15944.3 640159.0 652238.0 656537.0 665844.0 665939.0 60598.7 60984.7 61440.1 61551.0 61682.0 1491.3 1503.8 1514.8 1522.7 1526.5 29716.0 30015.5 30039.8 30447.5 30587.8 52039.5 52254.0 52775.5 52812.0 52958.0 582773.0 585938.1 589223.0 592305.0 594642.0 27117.5 27153.9 27205.5 27537.6 27554.0 46671.3 46919.8 47020.6 47511.3 47689.3 30999.7 38865.0 38882.2 39185.0 39229.8 37836.2 37907.0 38000.0 38628.2 38993.8 37639.0 37870.2 38154.8 38234.4 38265.8 27160.9 27336.9 32151.3 33392.8 34149.7 25196.5 25556.0 25716.2 25741.5 25935.9 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#2] jquery.html Cycles:180 Average:35569.45 Median:21590.73 stddev:105834.06 (490.2%) stddev-sans-first:106098.01 06:57:15 INFO - PROCESS | 2705 | Values: 399.5 401.1 403.4 404.3 416.5 16533.8 19793.5 21179.4 21209.6 21726.5 20862.0 21016.4 21219.7 21882.2 21935.6 5587.4 5840.3 5920.5 5936.2 5954.4 5583.8 5860.2 5936.5 5946.5 6011.8 5810.9 5876.1 5907.7 5925.4 5940.3 5707.0 6006.8 6087.6 6093.7 6101.5 4543.8 5092.9 5100.0 5882.8 5886.1 15992.7 20176.5 24943.3 25119.9 25212.1 1867.8 2078.3 2088.3 2247.6 2293.0 9665.1 9852.0 10007.3 10136.5 10172.3 1775.3 1786.5 1834.8 1844.4 1945.2 108382.0 109774.0 114700.0 120115.4 121466.0 11452.8 11636.3 11815.0 11852.5 12027.4 13683.7 14285.5 15005.2 15129.4 15363.0 7140.6 8776.6 8843.0 8991.7 9009.3 8002.6 8245.1 9000.3 9070.9 9122.5 4629.8 4637.5 4668.6 4673.6 4734.5 1765.9 1982.5 2022.4 2065.9 2074.6 928.6 931.3 958.3 981.0 1058.7 18759.5 20534.3 21107.7 21291.4 21455.0 985.3 1003.9 1044.9 1056.9 1071.8 10293.9 10325.8 11132.0 11348.2 11442.8 608234.0 628197.0 636003.0 654548.0 655839.0 110126.0 128835.0 129874.0 132586.0 134307.0 1025.9 1037.5 1047.2 1061.3 1066.6 18361.3 18449.8 18585.6 18656.8 18889.3 35038.5 49401.8 51302.5 52835.7 53418.0 59082.4 72958.0 76196.0 77100.0 78723.2 6956.7 8003.8 8126.4 8210.6 8273.1 12167.2 12258.3 12322.6 12549.2 12695.0 10895.9 11045.8 11223.5 11257.1 11258.5 5863.1 8289.4 10572.5 10902.9 10946.5 10269.2 10471.8 11190.9 11313.3 11529.1 7755.4 8176.5 8184.2 8433.4 8527.7 8846.9 9730.0 10561.0 10723.0 11364.1 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#3] mootools.html Cycles:180 Average:5676.13 Median:4895.46 stddev:3144.72 (64.2%) stddev-sans-first:3138.41 06:57:15 INFO - PROCESS | 2705 | Values: 1570.5 1586.5 1822.9 1902.0 1965.6 7061.5 7805.5 8620.9 8836.0 8836.2 8496.2 8529.5 8632.0 8635.6 8637.5 2020.3 2487.6 2490.4 2490.7 2496.8 2461.1 2480.5 2513.0 2513.6 2514.4 2443.0 2462.6 2470.9 2474.7 2480.7 2460.9 2480.9 2491.8 2499.2 2499.4 2506.2 2524.9 2538.1 2540.9 2545.6 8786.3 8852.5 8862.4 8866.6 8890.6 5399.4 5426.8 5488.3 5535.6 5560.8 3430.8 3510.9 3542.2 3573.9 3579.8 1064.9 1083.7 1084.5 1085.5 1092.1 11797.7 11920.3 12028.8 12037.4 12067.2 4835.4 4858.8 4890.4 4939.1 4952.0 8637.4 10218.5 10258.2 10286.4 10332.5 5438.8 5456.6 5470.9 5476.0 5483.8 3854.4 4126.7 4408.7 4503.2 4900.5 3883.4 4076.6 4158.6 4180.7 4184.9 1364.3 1391.9 1392.7 1393.4 1400.8 795.5 801.8 886.5 952.7 965.8 5165.5 5918.4 5925.3 5981.8 6009.7 801.7 819.5 846.4 988.9 1002.0 3686.3 3926.6 3955.7 3979.3 4025.5 10440.6 10612.2 10697.5 10738.4 10742.6 10623.2 10628.5 10631.3 10639.9 10690.0 8346.9 8368.8 8419.5 8444.0 8454.4 5619.7 5663.6 5773.2 5798.7 5865.6 9647.0 9674.5 9703.2 9704.7 9783.8 8466.9 9799.5 9834.6 10021.6 10157.7 6388.6 6773.5 7024.7 7069.0 7171.1 8214.6 8232.1 8264.6 8272.6 8273.6 6168.6 7066.9 7393.9 7486.1 7529.3 6974.0 7101.4 7245.2 7264.5 7329.0 6856.9 6968.4 6968.5 6975.3 6996.9 4813.3 4813.9 4830.4 4948.1 4989.5 4292.5 4735.3 4867.1 4875.2 4950.9 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#4] prototype.html Cycles:180 Average:5898.12 Median:6526.99 stddev:1903.83 (29.2%) stddev-sans-first:1862.72 06:57:15 INFO - PROCESS | 2705 | Values: 329.0 330.0 332.6 338.0 341.9 5744.3 6433.1 6694.1 6723.8 6745.8 6656.7 6687.6 6705.2 6717.2 6721.0 4767.5 4842.8 4944.9 4957.5 4967.0 4920.1 4950.8 4957.5 4968.9 4980.6 4891.1 4899.4 4909.6 4928.3 4939.2 4905.2 4914.6 4918.7 4942.6 5001.9 4264.3 4277.8 4280.8 4284.1 4293.1 6265.3 6448.4 6453.5 6500.0 6531.4 5868.7 5898.7 5942.6 5943.0 5945.8 5857.6 7182.1 7198.9 7200.1 7215.9 4767.6 4770.1 4784.8 4788.2 4789.7 7426.9 7680.0 7681.5 7688.5 7693.4 4869.4 4870.3 4879.5 4887.1 4900.1 4931.3 4964.4 4965.9 4968.1 4976.2 5873.1 5891.0 5899.3 5903.7 5917.4 7249.1 7255.7 7281.5 7282.6 7290.6 1554.3 1589.0 1685.7 1703.3 1729.9 878.9 1013.4 1013.6 1055.7 1064.3 6522.6 6571.5 6613.1 6696.0 6730.4 7168.5 7500.8 7510.4 7520.4 7535.2 4753.0 5592.0 6747.8 6799.4 6842.2 3295.7 3930.6 3977.3 4001.4 4010.0 7946.5 7979.0 7979.1 7981.7 8019.5 7184.7 7767.1 7789.3 7876.6 7885.0 7909.3 7953.4 7966.0 7973.0 7973.9 7536.5 7549.4 7560.0 7570.9 7588.8 7420.1 7433.9 7437.0 7459.0 7471.8 6363.4 7645.4 7872.5 7969.3 7974.9 4667.8 4692.4 4745.2 4746.3 4746.3 7600.9 7601.6 7612.4 7626.8 7648.3 6295.0 6941.0 7339.0 7358.2 7393.5 7129.1 7315.5 7344.0 7373.6 7379.9 6122.0 6161.7 6496.3 7156.5 7159.5 5626.3 7267.4 7324.2 7325.1 7348.7 6316.5 6700.5 7105.3 7173.4 7190.7 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - PROCESS | 2705 | [#5] yui.html Cycles:180 Average:18253.85 Median:639.93 stddev:26418.18 (4128.3%) stddev-sans-first:26459.41 06:57:15 INFO - PROCESS | 2705 | Values: 701.7 732.5 757.1 760.6 783.9 13854.9 14059.3 14826.3 14995.9 15232.6 13902.8 13910.6 13920.6 13925.4 13992.7 771.7 942.2 956.4 982.1 985.2 954.6 961.1 968.7 979.3 981.7 1014.1 1015.1 1025.1 1026.6 1028.7 948.4 984.7 1009.4 1020.6 1021.1 707.5 763.4 763.5 763.6 768.9 14464.3 14540.0 14680.3 14737.0 14792.7 12671.0 12706.8 12882.7 12931.8 12982.5 9888.3 10101.7 10145.8 10209.6 10236.5 3505.8 3506.5 3647.1 3728.5 3781.3 77750.6 77909.6 78838.0 79075.0 80279.6 9291.3 9344.3 9379.1 9456.5 9552.1 20968.5 20984.8 20988.7 21035.9 21132.0 7432.7 7450.4 7455.9 7457.0 7472.1 4021.5 4028.3 4059.4 4073.9 4089.6 3377.3 3746.1 3748.6 3757.8 3764.9 655.8 670.6 674.1 675.0 676.4 562.7 609.6 615.5 626.6 638.1 8127.9 8315.5 8399.1 8715.0 8796.7 603.2 605.5 606.8 625.3 641.8 3769.0 3957.9 3988.3 3994.6 4113.3 97874.0 99030.0 101535.0 101707.0 101790.0 80539.6 80544.0 80625.0 82081.0 84638.0 55370.2 70035.6 71571.0 72106.2 72807.6 7805.4 7889.3 8005.9 8175.7 8221.9 41368.2 45870.0 48821.5 49603.3 50102.5 65409.3 68749.9 69030.0 69822.0 69906.0 9569.8 9986.2 10113.7 10191.8 10373.1 8922.6 8992.5 9618.0 10832.2 11469.2 10513.3 10557.2 10565.7 10738.4 11027.6 8387.5 9670.7 9896.4 9973.8 10260.2 10192.4 10326.8 10438.6 10590.7 10609.8 8958.7 8974.0 9196.4 9259.2 9407.1 9012.0 9095.8 9141.0 9170.7 9197.6 06:57:15 INFO - PROCESS | 2705 | -------- Summary: end -------- 06:57:15 INFO - PROCESS | 2705 | 06:57:15 INFO - TEST-INFO | 2705: exit 0 06:57:16 INFO - TEST-OK | dromaeo_css | took 1111393ms 06:57:16 INFO - TEST-START | kraken 06:57:16 INFO - operating with platform_type : mac_ 06:57:16 INFO - Initialising browser for kraken test... 06:57:16 INFO - TEST-INFO | started process 2823 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpxHlrDp/profile http://localhost:53176/getInfo.html) 06:57:18 INFO - PROCESS | 2823 | __metrics Screen width/height:1600/1200 06:57:18 INFO - PROCESS | 2823 | colorDepth:24 06:57:18 INFO - PROCESS | 2823 | Browser inner width/height: 1024/689 06:57:18 INFO - PROCESS | 2823 | __metrics 06:57:18 ERROR - PROCESS | 2823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:57:19 INFO - TEST-INFO | 2823: exit 0 06:57:19 INFO - Browser initialized. 06:57:19 INFO - Running cycle 1/1 for kraken test... 06:57:19 INFO - TEST-INFO | started process 2826 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpxHlrDp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:31 INFO - PROCESS | 2826 | RSS: Main: 220700672 06:57:31 INFO - PROCESS | 2826 | 06:57:34 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53176/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:35 INFO - PROCESS | 2826 | RSS: Main: 233177088 06:57:35 INFO - PROCESS | 2826 | 06:57:37 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53176/tests/kraken/driver.html?testName=audio-dft) 06:57:38 INFO - PROCESS | 2826 | RSS: Main: 242020352 06:57:38 INFO - PROCESS | 2826 | 06:57:41 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53176/tests/kraken/driver.html?testName=audio-fft) 06:57:42 INFO - PROCESS | 2826 | RSS: Main: 245460992 06:57:42 INFO - PROCESS | 2826 | 06:57:44 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53176/tests/kraken/driver.html?testName=audio-oscillator) 06:57:45 INFO - PROCESS | 2826 | RSS: Main: 245911552 06:57:45 INFO - PROCESS | 2826 | 06:57:47 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53176/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:48 INFO - PROCESS | 2826 | RSS: Main: 247455744 06:57:48 INFO - PROCESS | 2826 | 06:57:50 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53176/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:51 INFO - PROCESS | 2826 | RSS: Main: 247869440 06:57:51 INFO - PROCESS | 2826 | 06:57:54 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53176/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:55 INFO - PROCESS | 2826 | RSS: Main: 247992320 06:57:55 INFO - PROCESS | 2826 | 06:57:57 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53176/tests/kraken/driver.html?testName=json-parse-financial) 06:57:58 INFO - PROCESS | 2826 | RSS: Main: 248008704 06:57:58 INFO - PROCESS | 2826 | 06:58:00 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53176/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:01 INFO - PROCESS | 2826 | RSS: Main: 247922688 06:58:01 INFO - PROCESS | 2826 | 06:58:02 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:03 INFO - PROCESS | 2826 | RSS: Main: 247496704 06:58:03 INFO - PROCESS | 2826 | 06:58:05 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:06 INFO - PROCESS | 2826 | RSS: Main: 247693312 06:58:06 INFO - PROCESS | 2826 | 06:58:09 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:10 INFO - PROCESS | 2826 | RSS: Main: 247713792 06:58:10 INFO - PROCESS | 2826 | 06:58:13 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:13 INFO - PROCESS | 2826 | RSS: Main: 247382016 06:58:13 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | Cycle 1(1): loaded http://localhost:53176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53176/tests/kraken/driver.html?testName=ai-astar) 06:58:15 INFO - PROCESS | 2826 | RSS: Main: 249397248 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | __start_tp_report 06:58:15 INFO - PROCESS | 2826 | _x_x_mozilla_page_load 06:58:15 INFO - PROCESS | 2826 | _x_x_mozilla_page_load_details 06:58:15 INFO - PROCESS | 2826 | |i|pagename|runs| 06:58:15 INFO - PROCESS | 2826 | |0;ai-astar;113;118;104;116;114;106;134;168;138;151 06:58:15 INFO - PROCESS | 2826 | |1;audio-beat-detection;163;132;146;160;120;137;107;187;177;154 06:58:15 INFO - PROCESS | 2826 | |2;audio-dft;196;197;199;206;198;197;199;200;197;194 06:58:15 INFO - PROCESS | 2826 | |3;audio-fft;66;67;104;136;70;85;82;82;124;57 06:58:15 INFO - PROCESS | 2826 | |4;audio-oscillator;77;84;129;63;93;120;164;121;79;121 06:58:15 INFO - PROCESS | 2826 | |5;imaging-gaussian-blur;88;86;107;113;90;81;136;132;89;85 06:58:15 INFO - PROCESS | 2826 | |6;imaging-darkroom;131;94;93;94;95;93;104;131;95;94 06:58:15 INFO - PROCESS | 2826 | |7;imaging-desaturate;143;139;91;90;92;91;90;119;118;94 06:58:15 INFO - PROCESS | 2826 | |8;json-parse-financial;51;73;103;102;103;95;81;85;66;52 06:58:15 INFO - PROCESS | 2826 | |9;json-stringify-tinderbox;67;70;74;68;71;80;97;60;66;83 06:58:15 INFO - PROCESS | 2826 | |10;stanford-crypto-aes;81;84;86;109;108;70;96;72;94;110 06:58:15 INFO - PROCESS | 2826 | |11;stanford-crypto-ccm;127;140;125;118;162;157;150;137;198;168 06:58:15 INFO - PROCESS | 2826 | |12;stanford-crypto-pbkdf2;169;167;168;205;221;164;219;179;223;200 06:58:15 INFO - PROCESS | 2826 | |13;stanford-crypto-sha256-iterative;70;70;69;67;82;94;100;66;65;96 06:58:15 INFO - PROCESS | 2826 | __end_tp_report 06:58:15 INFO - PROCESS | 2826 | __start_cc_report 06:58:15 INFO - PROCESS | 2826 | _x_x_mozilla_cycle_collect,1102 06:58:15 INFO - PROCESS | 2826 | __end_cc_report 06:58:15 INFO - PROCESS | 2826 | __startTimestamp1465221495759__endTimestamp 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | ------- Summary: start ------- 06:58:15 INFO - PROCESS | 2826 | Number of tests: 14 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#0] ai-astar Cycles:10 Average:126.20 Median:126.00 stddev:20.97 (16.6%) stddev-sans-first:21.69 06:58:15 INFO - PROCESS | 2826 | Values: 113.0 118.0 104.0 116.0 114.0 106.0 134.0 168.0 138.0 151.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:157.00 stddev:24.97 (15.9%) stddev-sans-first:25.91 06:58:15 INFO - PROCESS | 2826 | Values: 163.0 132.0 146.0 160.0 120.0 137.0 107.0 187.0 177.0 154.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#2] audio-dft Cycles:10 Average:198.30 Median:198.50 stddev:3.20 (1.6%) stddev-sans-first:3.28 06:58:15 INFO - PROCESS | 2826 | Values: 196.0 197.0 199.0 206.0 198.0 197.0 199.0 200.0 197.0 194.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#3] audio-fft Cycles:10 Average:87.30 Median:68.50 stddev:26.12 (38.1%) stddev-sans-first:26.55 06:58:15 INFO - PROCESS | 2826 | Values: 66.0 67.0 104.0 136.0 70.0 85.0 82.0 82.0 124.0 57.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:70.00 stddev:30.92 (44.2%) stddev-sans-first:31.08 06:58:15 INFO - PROCESS | 2826 | Values: 77.0 84.0 129.0 63.0 93.0 120.0 164.0 121.0 79.0 121.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:85.50 stddev:20.22 (23.7%) stddev-sans-first:20.92 06:58:15 INFO - PROCESS | 2826 | Values: 88.0 86.0 107.0 113.0 90.0 81.0 136.0 132.0 89.0 85.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:94.00 stddev:15.41 (16.4%) stddev-sans-first:12.39 06:58:15 INFO - PROCESS | 2826 | Values: 131.0 94.0 93.0 94.0 95.0 93.0 104.0 131.0 95.0 94.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#7] imaging-desaturate Cycles:10 Average:106.70 Median:90.50 stddev:21.26 (23.5%) stddev-sans-first:18.04 06:58:15 INFO - PROCESS | 2826 | Values: 143.0 139.0 91.0 90.0 92.0 91.0 90.0 119.0 118.0 94.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#8] json-parse-financial Cycles:10 Average:81.10 Median:69.50 stddev:20.14 (29.0%) stddev-sans-first:18.18 06:58:15 INFO - PROCESS | 2826 | Values: 51.0 73.0 103.0 102.0 103.0 95.0 81.0 85.0 66.0 52.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:72.50 stddev:10.62 (14.6%) stddev-sans-first:10.99 06:58:15 INFO - PROCESS | 2826 | Values: 67.0 70.0 74.0 68.0 71.0 80.0 97.0 60.0 66.0 83.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:82.50 stddev:14.85 (18.0%) stddev-sans-first:15.30 06:58:15 INFO - PROCESS | 2826 | Values: 81.0 84.0 86.0 109.0 108.0 70.0 96.0 72.0 94.0 110.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:153.50 stddev:24.12 (15.7%) stddev-sans-first:24.33 06:58:15 INFO - PROCESS | 2826 | Values: 127.0 140.0 125.0 118.0 162.0 157.0 150.0 137.0 198.0 168.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.50 Median:202.50 stddev:24.60 (12.1%) stddev-sans-first:24.70 06:58:15 INFO - PROCESS | 2826 | Values: 169.0 167.0 168.0 205.0 221.0 164.0 219.0 179.0 223.0 200.0 06:58:15 INFO - PROCESS | 2826 | 06:58:15 INFO - PROCESS | 2826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:70.00 stddev:13.84 (19.8%) stddev-sans-first:14.38 06:58:15 INFO - PROCESS | 2826 | Values: 70.0 70.0 69.0 67.0 82.0 94.0 100.0 66.0 65.0 96.0 06:58:15 INFO - PROCESS | 2826 | -------- Summary: end -------- 06:58:15 INFO - PROCESS | 2826 | 06:58:16 INFO - TEST-INFO | 2826: exit 0 06:58:16 INFO - TEST-OK | kraken | took 60516ms 06:58:16 INFO - SUITE-END | took 1171s 06:58:16 INFO - Completed test suite (00:19:32) 06:58:16 INFO - javascript benchmark 06:58:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.401067807795, 3451.137215696076, 3481.7562770606037, 3495.8951231463066, 3510.526078979337, 5746.396628354026, 5768.365479797224, 5781.971090144549, 5829.183914252008, 5884.764609415629, 4071.6131967463043, 4231.534531201573, 4517.299818528133, 4824.782884770185, 5144.279800827878, 4260.403543503912, 5261.421243663194, 5313.8937221255555, 5353.57171426285, 5383.380911195204, 5170.457102004292, 5299.284596579451, 5304.92042619361, 5330.546903513206, 5345.518903298703, 5308.601854860882, 5353.5984801139875, 5353.652012619187, 5356.598255130862, 5369.19462080689, 4320.0, 4381.737095774248, 4477.619402350804, 5176.301199338116, 5290.312259406272, 4226.260404429243, 5160.380754309469, 5216.347956505437, 5278.4721527846905, 5323.148296272578, 5729.083346664555, 5778.24882765242, 5790.71046447676, 5798.768049278066, 5800.4489573490455, 6122.142899994004, 6166.784162554289, 6185.969070154621, 6204.906926396107, 6240.0, 6240.219972503437, 6267.3105958345, 6278.277998030239, 6281.7173227204885, 6282.717277722513, 5862.50168735658, 5903.35063143054, 5924.881502369928, 5946.078357854496, 5983.192269043667, 6204.720787564571, 6243.812685619348, 6292.150559674477, 6316.242050953915, 6331.176946996861, 6181.165542651775, 6203.16257305267, 6210.130581718563, 6228.03465462854, 6228.6574238416415, 6264.21697287839, 6270.028145637433, 6273.937260627426, 6278.4035516625845, 6283.057541368831, 6128.19758601264, 6182.938170618237, 6194.690265486708, 6250.374962503804, 6259.280182778948, 5191.740412979336, 6257.2491301044165, 6260.718267677966, 6264.310925798159, 6279.434850863444, 4873.147199240118, 4873.244647079709, 4980.77586508608, 4982.626303027288, 4986.077575648516, 4404.933925991113, 4411.7573533455325, 4434.26834572292, 4485.416895803524, 4509.661775366861, 5817.331006934257, 5818.8254352369495, 5872.58891877573, 5896.997510423238, 5922.703864806743, 6138.32709113608, 6195.504359651217, 6256.74973001084, 6275.964465863172, 6301.275353334334, 5673.375928647845, 5832.912506312408, 5902.321233058167, 5918.7928422505, 5951.672658003851, 5394.32570928634, 5416.10634245353, 5443.346798384219, 5466.753996070107, 5471.562275017989, 5403.432639572946, 5489.87457571197, 6234.407731265523, 6309.558330916791, 6333.524985626004, 6247.406496382836, 6256.906146407899, 6274.278457977391, 6278.780242691667, 6291.96854015727, 6333.461655759128, 6336.778212762531, 6344.777932772331, 6355.046742988588, 6363.936360636334, 6118.479929206067, 6135.293912123373, 6182.319944805978, 6221.782237621662, 6248.0, 6229.875402492015, 6251.437370636664, 6276.058591211355, 6286.779962701284, 6296.716647750954, 6159.6612186330185, 6159.692015399301, 6186.412290832363, 6207.751689932352, 6214.036824292242, 5032.572231360376, 5715.742536641932, 5997.430244126801, 6115.694215289307, 6189.319174890668, 5161.638685291993, 5361.624686271924, 5991.910121348096, 6011.7595296187665, 6031.215941927521, 6016.578839481369, 6114.449699527064, 6155.599886007395, 6167.105769663463, 6169.598976066542, 4742.857714268577, 5608.130739735185, 5680.77276908919, 5693.202951586698, 5715.771369145187], "value": 5640.716213504723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.77330201409353, 510.50481033397614, 514.8635611562935, 529.6027979015738, 575.9632661209821, 33401.83299083504, 39537.0, 39655.60344396555, 39747.40378894312, 39755.602443975586, 39771.0, 40416.19167616646, 40871.386929196015, 40880.59119408813, 41125.0, 9439.71680849574, 9690.27322950778, 9693.709188724315, 9701.029897010312, 9728.978457261956, 9576.281778866613, 9830.21358291335, 9840.458774767385, 9858.852117218248, 9869.309148359618, 9712.902870971306, 9837.262205334593, 9841.90158098417, 9851.211903047775, 9858.901410985905, 8181.509109453422, 9845.163161131313, 9846.9507652462, 9867.851982220272, 9884.110430061257, 9643.180329671986, 9717.368371055858, 9778.462184579845, 9787.314887957846, 9791.265655075898, 39328.410073848914, 39526.40710389346, 39881.800590996856, 39984.80007599943, 40049.79975100135, 3294.407006738786, 3378.273671160712, 3421.26442814796, 3549.2546565221332, 3621.963780362189, 23161.3051608452, 28924.71075289262, 29037.709622903712, 29188.416231675248, 29333.70666293331, 2733.180045986196, 2765.6681198256338, 2788.1496143676172, 2806.354538456146, 2811.9578206326923, 448389.0, 451258.0, 452260.0, 458122.0, 458663.0, 59115.113273300936, 59247.11129332977, 59549.70225148847, 59557.40442595519, 59561.70219148877, 61802.0, 62392.0, 69355.65322173356, 70100.0, 70832.64583677049, 17468.213930373164, 17534.210960506807, 17707.29170833178, 17745.911270443565, 17767.378141764977, 13282.136661116996, 13409.731805363837, 13433.395497202453, 13433.798493022612, 13439.932800335935, 19193.074971394402, 19514.25869705879, 19577.512640646106, 19581.51046223827, 19586.06764260477, 7002.194747603989, 7973.561454120079, 7989.681702519136, 8108.0, 8204.917950820534, 895.7805337692307, 938.3150300280834, 943.7782121201512, 1020.806046851096, 1043.7912417516375, 30364.54453183204, 30516.954695934375, 30633.846830765702, 30681.539776903363, 31021.68978310233, 1084.4577711144427, 1123.2979387882574, 1128.6839684888243, 1176.564671071692, 1216.4525963316544, 15171.848281517265, 15551.922240388725, 15615.60960975962, 15770.0, 15944.2825072872, 640159.0, 652238.0, 656537.0, 665844.0, 665939.0, 60598.69700651469, 60984.69507652433, 61440.07839882405, 61551.0, 61682.0, 1491.3214487408204, 1503.7819516170093, 1514.8333683294609, 1522.6726253855475, 1526.4962562354397, 29716.0, 30015.54976675308, 30039.84980075173, 30447.54328685116, 30587.847060765445, 52039.479605203465, 52254.0, 52775.47224527859, 52812.0, 52958.0, 582773.0, 585938.1406186054, 589223.0, 592305.0, 594642.0, 27117.457650846478, 27153.86423067872, 27205.455890882466, 27537.586936195574, 27554.0, 46671.29993050175, 46919.82700432516, 47020.60442289658, 47511.28733069076, 47689.33087341926, 30999.69000309968, 38865.02837429087, 38882.2223555533, 39185.0, 39229.80385098056, 37836.204889983164, 37907.0, 38000.0, 38628.22743545169, 38993.80503097466, 37639.0, 37870.24259514739, 38154.80922595369, 38234.42648360221, 38265.80867095758, 27160.864195678896, 27336.863315683295, 32151.28369191424, 33392.83303583564, 34149.65850341465, 25196.49607007886, 25556.0, 25716.228513144637, 25741.485170296113, 25935.870320648275], "value": 20103.636317137145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.45075521158407, 401.09953155166653, 403.36872794077266, 404.3247776213724, 416.5210008490236, 16533.834661653378, 19793.505162370948, 21179.364619061453, 21209.57580848382, 21726.456838579023, 20862.0, 21016.36950891472, 21219.68170477444, 21882.23412180574, 21935.561288774214, 5587.441255874421, 5840.269966254218, 5920.526357891358, 5936.198613187229, 5954.434328738785, 5583.804566840161, 5860.208871802295, 5936.495397891163, 5946.494547963428, 6011.819645410645, 5810.854728631797, 5876.11858221266, 5907.734151963172, 5925.4370834770625, 5940.316863560703, 5706.971465142689, 6006.759729610811, 6087.573869829136, 6093.695315234243, 6101.511879049665, 4543.8182472701055, 5092.9236061459105, 5100.0, 5882.764689412418, 5886.05823068307, 15992.680146397122, 20176.49558761028, 24943.251702448957, 25119.87440062788, 25212.117575884757, 1867.785204701463, 2078.272604588397, 2088.3421722157473, 2247.5954328220914, 2292.9656055159185, 9665.130138287588, 9852.0, 10007.299489035697, 10136.543855526445, 10172.287939844215, 1775.2810111904698, 1786.499780061585, 1834.8348648621554, 1844.3544759334259, 1945.2316335047576, 108382.0, 109774.0, 114700.0, 120115.3994230032, 121466.0, 11452.828207576893, 11636.301821890544, 11815.0, 11852.525898964117, 12027.398630068461, 13683.726325473435, 14285.500007499895, 15005.17471539054, 15129.39482420713, 15363.0, 7140.607266600283, 8776.561171941505, 8842.955785221162, 8991.685291014783, 9009.324300677476, 8002.559859207683, 8245.051819040887, 9000.324975626854, 9070.86393704095, 9122.498262595622, 4629.768511574408, 4637.466691330473, 4668.603168730628, 4673.556012178838, 4734.455537613218, 1765.8809428685372, 1982.464734521671, 2022.3719905476232, 2065.872151683768, 2074.6058248932654, 928.6285485805731, 931.3387494878576, 958.2860768727343, 980.9950950245346, 1058.655936820521, 18759.531011724543, 20534.281300154424, 21107.68338474924, 21291.36125916225, 21455.0, 985.2561316206219, 1003.9297249192632, 1044.9425281609433, 1056.9471526423802, 1071.8177909755361, 10293.919138490352, 10325.84511232332, 11132.0, 11348.175171568313, 11442.828357574643, 608234.0, 628197.0, 636003.0, 654548.0, 655839.0, 110126.0, 128835.0, 129874.0, 132586.0, 134307.0, 1025.9435731034864, 1037.486444210121, 1047.2459828923163, 1061.2995423020768, 1066.6106870992187, 18361.265549377877, 18449.800762950366, 18585.628287434447, 18656.813431865507, 18889.338873139375, 35038.47442288317, 49401.75299123625, 51302.486975129774, 52835.735821320646, 53418.0, 59082.40917590769, 72958.0, 76196.0, 77100.0, 78723.21276787388, 6956.652167391509, 8003.75988720316, 8126.390520711088, 8210.63052162642, 8273.131321211185, 12167.209131406431, 12258.26450412978, 12322.568710095104, 12549.184303020274, 12695.047871409497, 10895.891041089804, 11045.779084418427, 11223.494942727433, 11257.099432045581, 11258.549658013588, 5863.120531920075, 8289.4197406181, 10572.471376430994, 10902.945485272523, 10946.507407166537, 10269.229807764597, 10471.842922356323, 11190.888091118984, 11313.321200727984, 11529.135314851252, 7755.379569634303, 8176.46852954556, 8184.2224988625985, 8433.409661323894, 8527.701530446404, 8846.867296990422, 9730.0, 10561.0, 10722.981316774894, 11364.090872730327], "value": 9496.984211097264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.5052908333873, 1586.524042787164, 1822.8723989320754, 1902.0, 1965.616704742574, 7061.470389720778, 7805.4536182467255, 8620.913790862089, 8835.955820220897, 8836.204741573249, 8496.192861678132, 8529.530875801844, 8631.964164300278, 8635.568221588912, 8637.481751094923, 2020.2827996061371, 2487.601983682602, 2490.3649569359786, 2490.6762120924254, 2496.787773039294, 2461.064795377754, 2480.454300053985, 2513.0450428837016, 2513.5852584323566, 2514.396544829246, 2442.9633555496594, 2462.642916777066, 2470.9011639534488, 2474.7277799442045, 2480.702315722107, 2460.889259983296, 2480.851148931061, 2491.813114016447, 2499.212747984379, 2499.3751562109474, 2506.248125562324, 2524.873756312177, 2538.0989748639336, 2540.9237722868343, 2545.592705167183, 8786.253168480624, 8852.51311177885, 8862.379633425662, 8866.645334186625, 8890.644374225023, 5399.433059528771, 5426.810061647863, 5488.313960754906, 5535.612507124503, 5560.8331750047155, 3430.803493580321, 3510.912227194315, 3542.220711443478, 3573.928521429557, 3579.7649810815487, 1064.882862885082, 1083.7236504691252, 1084.5119696136692, 1085.5060947268973, 1092.1099304067238, 11797.705057373549, 11920.344381059038, 12028.759424811542, 12037.398130093461, 12067.155299128977, 4835.395575553056, 4858.7570621468785, 4890.437599676083, 4939.1109600271575, 4951.9752401237765, 8637.395382323177, 10218.540165692562, 10258.230632702576, 10286.382817030852, 10332.483375831178, 5438.755256013489, 5456.645318054393, 5470.91793623096, 5476.0, 5483.7806487740845, 3854.402567602026, 4126.690498212646, 4408.713433626804, 4503.234450143484, 4900.485449027872, 3883.359245724424, 4076.6127217914845, 4158.563350848118, 4180.728252663567, 4184.937225941613, 1364.2837510307168, 1391.8956078294168, 1392.693607406369, 1393.4008376398247, 1400.8319001719656, 795.4590878202878, 801.7714951238869, 886.5434301334818, 952.6951375559893, 965.8358079126565, 5165.457626949192, 5918.437748413894, 5925.259342582177, 5981.790637327673, 6009.699515024231, 801.7434420985229, 819.5492479136451, 846.3821410370341, 988.9109980101681, 1001.9699409017741, 3686.2627474505207, 3926.5877082906454, 3955.7033222508426, 3979.263836190314, 4025.5370632377067, 10440.63457778974, 10612.151027917747, 10697.518611662494, 10738.409387483607, 10742.624008159833, 10623.150147988143, 10628.46857657114, 10631.308964917256, 10639.89360106389, 10690.037896589345, 8346.914901062944, 8368.83262334762, 8419.49483031008, 8443.986721593325, 8454.365922555833, 5619.662820230636, 5663.575231857545, 5773.162891380643, 5798.739056742541, 5865.648061116347, 9647.035296470296, 9674.516274186122, 9703.175230105238, 9704.660336888175, 9783.804323913624, 8466.915330846612, 9799.461029643153, 9834.557444914853, 10021.599136034769, 10157.746056348651, 6388.616682999035, 6773.458123350219, 7024.719011239493, 7069.045678833291, 7171.067761191011, 8214.58927053657, 8232.053313868983, 8264.628091736007, 8272.586370681562, 8273.586320683822, 6168.629882207082, 7066.893996590158, 7393.8890916637365, 7486.139094004259, 7529.322360987538, 6973.965130174317, 7101.431885449048, 7245.239249878687, 7264.455165862687, 7328.96335518319, 6856.897146542706, 6968.407685346802, 6968.5122041458635, 6975.3024697529845, 6996.930030699627, 4813.253945638432, 4813.9037219254715, 4830.396200474941, 4948.109340318633, 4989.501049894981, 4292.549282325311, 4735.33705281254, 4867.099586576494, 4875.1712208923855, 4950.851474455772], "value": 4601.072006354868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.96381398046213, 329.99010029699105, 332.6008789452657, 337.98141102239384, 341.94528875379945, 5744.281964754406, 6433.09936608874, 6694.1297631307925, 6723.798286051427, 6745.763898263555, 6656.739686600579, 6687.56530825496, 6705.161854768154, 6717.227518835335, 6720.966395168018, 4767.523247675222, 4842.806287748486, 4944.9258261126115, 4957.5042495750495, 4967.0, 4920.114379411704, 4950.752462376885, 4957.529034741694, 4968.925466117993, 4980.6015518758595, 4891.070696567658, 4899.363082799231, 4909.631777616675, 4928.334674818907, 4939.234418665094, 4905.23968784839, 4914.582260507861, 4918.655694101414, 4942.629302802305, 5001.949980500185, 4264.253755592759, 4277.764722940237, 4280.764557949312, 4284.121755040209, 4293.055527783882, 6265.310815810257, 6448.387403196689, 6453.548251622388, 6500.0, 6531.412172904414, 5868.706564671749, 5898.675572843492, 5942.61373010753, 5943.04911214208, 5945.821625351203, 5857.589968702193, 7182.138143422771, 7198.920161975693, 7200.135983681992, 7215.927840721631, 4767.642426818003, 4770.0698363819065, 4784.784684689197, 4788.209945359012, 4789.730721358843, 7426.851462970764, 7680.001599791991, 7681.539107653559, 7688.461807673465, 7693.422993275471, 4869.415670119537, 4870.342503761947, 4879.536444037811, 4887.120318342732, 4900.093482705711, 4931.334269873593, 4964.429090654548, 4965.882676397781, 4968.105740966661, 4976.2038073908725, 5873.089671100986, 5891.0, 5899.262592175978, 5903.734331955073, 5917.437843404869, 7249.093863267091, 7255.673494692752, 7281.526700764433, 7282.563046217244, 7290.635468226567, 1554.2617256802928, 1588.9830508474586, 1685.6599003792014, 1703.335699077361, 1729.9481015569554, 878.9165029322204, 1013.3615822032073, 1013.5793645637126, 1055.6780182044397, 1064.2869277583882, 6522.5760325578685, 6571.507136964747, 6613.107230523914, 6696.029075783984, 6730.360615741497, 7168.498205125591, 7500.812479688051, 7510.436717246228, 7520.360769334668, 7535.208803075599, 4752.976235118871, 5592.0, 6747.797566073025, 6799.388055075067, 6842.213145488233, 3295.6704329567333, 3930.6462418382484, 3977.343738283209, 4001.379786133154, 4010.0, 7946.483478573874, 7979.0, 7979.122296547375, 7981.72063977758, 8019.518828870287, 7184.748533801292, 7767.145613982458, 7789.298963093349, 7876.606169691607, 7885.0, 7909.3277071449575, 7953.363730901514, 7966.0440747110715, 7972.960135199287, 7973.9202607973175, 7536.547807131589, 7549.433792465697, 7560.0, 7570.9242907570215, 7588.772336829904, 7420.109586849612, 7433.851322973618, 7436.96281518589, 7458.993035940079, 7471.813204669927, 6363.395477429637, 7645.350145237717, 7872.488288261245, 7969.282764551218, 7974.920250797418, 4667.836625718083, 4692.41344831896, 4745.217039188496, 4746.264329029006, 4746.311784791255, 7600.885986710315, 7601.581912994839, 7612.429067819825, 7626.847463050819, 7648.34989025939, 6295.0, 6940.99355593426, 7338.96330518344, 7358.22738612438, 7393.482456228227, 7129.073220481304, 7315.524490908074, 7344.045274114331, 7373.5575865448245, 7379.9262007381385, 6121.989871671124, 6161.675239823459, 6496.317886622026, 7156.463265255023, 7159.498835081495, 5626.324841019104, 7267.382272506896, 7324.157721862054, 7325.120985481776, 7348.669309880961, 6316.463100636313, 6700.530962832555, 7105.2894710528535, 7173.354398104196, 7190.676419561028], "value": 5255.236318297116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.6737217194005, 732.4689600039972, 757.0725860820496, 760.623491371771, 783.9176886426925, 13854.861451385483, 14059.297035148253, 14826.258687065643, 14995.925020374883, 15232.619184520392, 13902.791458128137, 13910.582682519514, 13920.58238252854, 13925.37335819888, 13992.65018374541, 771.7453240430644, 942.2038377570941, 956.3783540698532, 982.1013772398283, 985.2462865907586, 954.6467806911453, 961.0917682789767, 968.7239136846, 979.2655508368723, 981.7103954333453, 1014.0974532665933, 1015.0661391519783, 1025.0671888581392, 1026.5944951744057, 1028.670825335893, 948.3740731117498, 984.7390441532999, 1009.4195837393492, 1020.5917632946806, 1021.1218352217124, 707.4906067631297, 763.3816608547095, 763.4503157726483, 763.6220071064803, 768.9154193038761, 14464.349104290332, 14540.0, 14680.339384727713, 14737.0, 14792.704145917021, 12670.986321094382, 12706.809397859039, 12882.677933051655, 12931.806022909665, 12982.545610903668, 9888.258380621483, 10101.747456313578, 10145.797084058351, 10209.591616335338, 10236.488175591265, 3505.8422370993367, 3506.4915587239707, 3647.0699971507097, 3728.478013078144, 3781.3193625147464, 77750.61124694397, 77909.61045194737, 78838.0, 79075.0, 80279.5986020072, 9291.256699464027, 9344.345895787366, 9379.108984646447, 9456.52717364129, 9552.14030737223, 20968.47578810542, 20984.79015209859, 20988.685169722467, 21035.8948205258, 21132.0, 7432.739854105081, 7450.403967682572, 7455.888161677579, 7456.96271518639, 7472.065991751031, 4021.5174179098694, 4028.274910516135, 4059.3910913363234, 4073.9388909166387, 4089.5910408958866, 3377.2907689385015, 3746.138388170736, 3748.568914574859, 3757.774533527997, 3764.887053388403, 655.8425977765302, 670.580886945659, 674.1068084787676, 675.0279597379757, 676.3507033248137, 562.6905202138807, 609.5732986909093, 615.53527087049, 626.5707990026846, 638.1034646321925, 8127.882933036439, 8315.459495132796, 8399.11809260031, 8714.95642521796, 8796.736097917073, 603.1706403694919, 605.4883623338272, 606.8422210225373, 625.3027873920546, 641.7593402474072, 3768.9623103768613, 3957.940630890539, 3988.3419235825763, 3994.580569040267, 4113.344151791287, 97874.0, 99030.0, 101534.98465015255, 101706.98293017123, 101790.0, 80539.59730201312, 80544.0, 80625.0, 82081.0, 84638.0, 55370.21948744669, 70035.64982175057, 71571.0, 72106.19734506679, 72807.63596181985, 7805.375569954504, 7889.3294070004695, 8005.879911801444, 8175.672973081248, 8221.917780822116, 41368.1726365477, 45870.0, 48821.511784881695, 49603.25595116004, 50102.49897500978, 65409.34590654032, 68749.93750187503, 69030.0, 69822.0, 69906.0, 9569.75593172883, 9986.168878489372, 10113.69658910234, 10191.847122293024, 10373.118284945864, 8922.55387230623, 8992.46045237288, 9618.0, 10832.241743078224, 11469.197156198987, 10513.264071514921, 10557.20820938448, 10565.683029509128, 10738.409387483764, 11027.61403350879, 8387.496750195009, 9670.686571922386, 9896.356736812084, 9973.800523989625, 10260.230482713678, 10192.388456692623, 10326.793464130826, 10438.63464778729, 10590.735231618963, 10609.840852387066, 8958.68644597436, 8973.955130224307, 9196.35625506208, 9259.21296689762, 9407.059294070537, 9011.954940225258, 9095.818083638422, 9141.0, 9170.724878253663, 9197.632094716404], "value": 6876.946158475028, "unit": "score"}], "name": "dromaeo_css", "value": 7507.807907752973, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 104.0, 116.0, 114.0, 106.0, 134.0, 168.0, 138.0, 151.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 146.0, 160.0, 120.0, 137.0, 107.0, 187.0, 177.0, 154.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 199.0, 206.0, 198.0, 197.0, 199.0, 200.0, 197.0, 194.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 104.0, 136.0, 70.0, 85.0, 82.0, 82.0, 124.0, 57.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 129.0, 63.0, 93.0, 120.0, 164.0, 121.0, 79.0, 121.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 107.0, 113.0, 90.0, 81.0, 136.0, 132.0, 89.0, 85.0], "value": 100.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 94.0, 93.0, 94.0, 95.0, 93.0, 104.0, 131.0, 95.0, 94.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 91.0, 90.0, 92.0, 91.0, 90.0, 119.0, 118.0, 94.0], "value": 106.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 73.0, 103.0, 102.0, 103.0, 95.0, 81.0, 85.0, 66.0, 52.0], "value": 81.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 68.0, 71.0, 80.0, 97.0, 60.0, 66.0, 83.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 86.0, 109.0, 108.0, 70.0, 96.0, 72.0, 94.0, 110.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 140.0, 125.0, 118.0, 162.0, 157.0, 150.0, 137.0, 198.0, 168.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 168.0, 205.0, 221.0, 164.0, 219.0, 179.0, 223.0, 200.0], "value": 191.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 67.0, 82.0, 94.0, 100.0, 66.0, 65.0, 96.0], "value": 77.9, "unit": "score"}], "name": "kraken", "value": 1638.3000000000002, "alertThreshold": 2.0}]} 06:58:16 INFO - Return code: 0 06:58:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:58:17 ERROR - # TBPL SUCCESS # 06:58:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:58:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:58:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:58:17 INFO - 2016-06-06 06:58:17.055 screenresolution[2837:22311] starting screenresolution argv=screenresolution get 06:58:17 INFO - 2016-06-06 06:58:17.057 screenresolution[2837:22311] Display 0: 1600x1200x32@60 06:58:17 INFO - 2016-06-06 06:58:17.063 screenresolution[2838:22314] starting screenresolution argv=screenresolution list 06:58:17 INFO - Available Modes on Display 0 06:58:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:58:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:58:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:58:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:58:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:58:17 INFO - Intel Iris: 06:58:17 INFO - Chipset Model: Intel Iris 06:58:17 INFO - Type: GPU 06:58:17 INFO - Bus: Built-In 06:58:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:58:17 INFO - Vendor: Intel (0x8086) 06:58:17 INFO - Device ID: 0x0a2e 06:58:17 INFO - Revision ID: 0x0009 06:58:17 INFO - Displays: 06:58:17 INFO - Display: 06:58:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:58:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:58:17 INFO - Display Serial Number: 1600x1200 60 06:58:17 INFO - Main Display: Yes 06:58:17 INFO - Mirror: Off 06:58:17 INFO - Online: Yes 06:58:17 INFO - Rotation: Supported 06:58:17 INFO - Return code: 0 06:58:17 INFO - Running post-action listener: _resource_record_post_action 06:58:17 INFO - Running post-run listener: _resource_record_post_run 06:58:18 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 753664; Write bytes: 658226176; Read time: 11; Write time: 1849 06:58:18 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 351027712; Write bytes: 346441728; Read time: 26651; Write time: 707 06:58:18 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 753664; Write bytes: 300987392; Read time: 11; Write time: 1108 06:58:18 INFO - Running post-run listener: _upload_blobber_files 06:58:18 INFO - Blob upload gear active. 06:58:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:18 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 06:58:18 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:58:18 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:58:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:58:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:19 INFO - (blobuploader) - INFO - Done attempting. 06:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:20 INFO - (blobuploader) - INFO - Done attempting. 06:58:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:20 INFO - Return code: 0 06:58:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c051da33b3c09fa9e92ad0478473a2d42a63d89c185186452a83a4c7ce11bdee8e6a38229733c8d77c1111814303c659b478ce81666d748e5a724c5088db821", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec85ee5d121473d35820b96dc3012ce840fd92240a9865952e28dae59a1860ca410e3b623eb938e1bc1d4489a6577f0ad115276698531f1903856df2fe4a933c"} 06:58:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:20 INFO - Contents: 06:58:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c051da33b3c09fa9e92ad0478473a2d42a63d89c185186452a83a4c7ce11bdee8e6a38229733c8d77c1111814303c659b478ce81666d748e5a724c5088db821", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec85ee5d121473d35820b96dc3012ce840fd92240a9865952e28dae59a1860ca410e3b623eb938e1bc1d4489a6577f0ad115276698531f1903856df2fe4a933c"} 06:58:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:20 INFO - Copying logs to upload dir... 06:58:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.613174 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-06 06:58:20.661124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:58:20.665160) ========= 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.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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-Aurora/sha512/4c051da33b3c09fa9e92ad0478473a2d42a63d89c185186452a83a4c7ce11bdee8e6a38229733c8d77c1111814303c659b478ce81666d748e5a724c5088db821", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec85ee5d121473d35820b96dc3012ce840fd92240a9865952e28dae59a1860ca410e3b623eb938e1bc1d4489a6577f0ad115276698531f1903856df2fe4a933c"} build_url:https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010870 build_url: 'https://queue.taskcluster.net/v1/task/CuA52A_4SlSbZdtsy9sFpA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c051da33b3c09fa9e92ad0478473a2d42a63d89c185186452a83a4c7ce11bdee8e6a38229733c8d77c1111814303c659b478ce81666d748e5a724c5088db821", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec85ee5d121473d35820b96dc3012ce840fd92240a9865952e28dae59a1860ca410e3b623eb938e1bc1d4489a6577f0ad115276698531f1903856df2fe4a933c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:58:20.700192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:58:20.700524) ========= 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.bEK34jwFHw/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.H8GliXw0cx/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005071 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:58:20.750891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:58:20.751219) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:58:20.751857) ========= ========= Total master_lag: 0.18 =========