builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1467321270.81 results: success (0) buildid: 20160630115927 builduid: 8f95a183e1694b9ab8d7f9f5101de05a revision: bcb69c8427d315b1d9c993493b2baf639761dd86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.814272) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.814674) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.814958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.839198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.839826) ========= 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.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-30 14:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-06-30 14:14:30 (15.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120864 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.989324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:30.990472) ========= 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.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.028948 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.040391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.040727) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcb69c8427d315b1d9c993493b2baf639761dd86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcb69c8427d315b1d9c993493b2baf639761dd86 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-30 14:14:31,112 truncating revision to first 12 chars 2016-06-30 14:14:31,112 Setting DEBUG logging. 2016-06-30 14:14:31,112 attempt 1/10 2016-06-30 14:14:31,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bcb69c8427d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 14:14:31,779 unpacking tar archive at: mozilla-beta-bcb69c8427d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.983618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.983966) ========= script_repo_revision: bcb69c8427d315b1d9c993493b2baf639761dd86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.984439) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:31.984743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 14:14:32.003494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-30 14:14:32.003907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:14:32 INFO - MultiFileLogger online at 20160630 14:14:32 in /builds/slave/test 14:14:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:14:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:32 INFO - {'append_to_log': False, 14:14:32 INFO - 'base_work_dir': '/builds/slave/test', 14:14:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:14:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:32 INFO - 'branch': 'Mozilla-Beta', 14:14:32 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:32 INFO - 'config_files': ('talos/mac_config.py',), 14:14:32 INFO - 'default_actions': ('clobber', 14:14:32 INFO - 'read-buildbot-config', 14:14:32 INFO - 'download-and-extract', 14:14:32 INFO - 'populate-webroot', 14:14:32 INFO - 'create-virtualenv', 14:14:32 INFO - 'install', 14:14:32 INFO - 'run-tests'), 14:14:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:32 INFO - 'download_minidump_stackwalk': True, 14:14:32 INFO - 'download_symbols': 'ondemand', 14:14:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:32 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:32 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:32 INFO - 'installer_path': 'installer.exe', 14:14:32 INFO - 'log_level': 'info', 14:14:32 INFO - 'log_name': 'talos', 14:14:32 INFO - 'log_to_console': True, 14:14:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:14:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:14:32 INFO - 'opt_config_files': (), 14:14:32 INFO - 'pip_index': False, 14:14:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:32 INFO - 'cmd': ('bash', 14:14:32 INFO - '-c', 14:14:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:32 INFO - 'enabled': True, 14:14:32 INFO - 'halt_on_failure': False, 14:14:32 INFO - 'name': 'check_screen_resolution'},), 14:14:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:14:32 INFO - 'cmd': ('bash', 14:14:32 INFO - '-c', 14:14:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:14:32 INFO - 'enabled': True, 14:14:32 INFO - 'halt_on_failure': False, 14:14:32 INFO - 'name': 'check_screen_resolution'},), 14:14:32 INFO - 'run_cmd_checks_enabled': True, 14:14:32 INFO - 'sps_profile': False, 14:14:32 INFO - 'sps_profile_interval': 0, 14:14:32 INFO - 'suite': 'dromaeojs', 14:14:32 INFO - 'system_bits': '32', 14:14:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:32 INFO - 'title': 't-yosemite-r7-0126', 14:14:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:32 INFO - 'use_talos_json': True, 14:14:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:32 INFO - 'work_dir': 'build'} 14:14:32 INFO - ##### 14:14:32 INFO - ##### Running clobber step. 14:14:32 INFO - ##### 14:14:32 INFO - Running pre-action listener: _resource_record_pre_action 14:14:32 INFO - Running main action method: clobber 14:14:32 INFO - rmtree: /builds/slave/test/build 14:14:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:34 INFO - Running post-action listener: _resource_record_post_action 14:14:34 INFO - ##### 14:14:34 INFO - ##### Running read-buildbot-config step. 14:14:34 INFO - ##### 14:14:34 INFO - Running pre-action listener: _resource_record_pre_action 14:14:34 INFO - Running main action method: read_buildbot_config 14:14:34 INFO - Using buildbot properties: 14:14:34 INFO - { 14:14:34 INFO - "project": "", 14:14:34 INFO - "product": "firefox", 14:14:34 INFO - "script_repo_revision": "production", 14:14:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:14:34 INFO - "repository": "", 14:14:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:14:34 INFO - "buildid": "20160630115927", 14:14:34 INFO - "pgo_build": "False", 14:14:34 INFO - "basedir": "/builds/slave/test", 14:14:34 INFO - "buildnumber": 49, 14:14:34 INFO - "slavename": "t-yosemite-r7-0126", 14:14:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:14:34 INFO - "platform": "yosemite_r7", 14:14:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:14:34 INFO - "branch": "mozilla-beta", 14:14:34 INFO - "repo_path": "releases/mozilla-beta", 14:14:34 INFO - "revision": "bcb69c8427d315b1d9c993493b2baf639761dd86", 14:14:34 INFO - "stage_platform": "macosx64", 14:14:34 INFO - "builduid": "8f95a183e1694b9ab8d7f9f5101de05a", 14:14:34 INFO - "slavebuilddir": "test" 14:14:34 INFO - } 14:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 14:14:34 INFO - Running post-action listener: _resource_record_post_action 14:14:34 INFO - ##### 14:14:34 INFO - ##### Running download-and-extract step. 14:14:34 INFO - ##### 14:14:34 INFO - Running pre-action listener: _resource_record_pre_action 14:14:34 INFO - Running main action method: download_and_extract 14:14:34 INFO - mkdir: /builds/slave/test/build/tests 14:14: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')]} 14:14:34 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 14:14:35 INFO - Downloaded 1165 bytes. 14:14:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:14:35 INFO - Using the following test package requirements: 14:14:35 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:14:35 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:14:35 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:14:35 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:14:35 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:14:35 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:14:35 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:14:35 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:14:35 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:14:35 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:14:35 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:14:35 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:35 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:14:36 INFO - Downloaded 18350407 bytes. 14:14:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:14:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:14:39 INFO - Return code: 0 14:14:39 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:39 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 14:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 14:14:40 INFO - Downloaded 18350407 bytes. 14:14:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:14:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:14:44 INFO - Return code: 0 14:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:44 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 14:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 14:14:45 INFO - Downloaded 10840145 bytes. 14:14:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:14:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:14:45 INFO - Return code: 0 14:14: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')]} 14:14:45 INFO - https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 14:14:47 INFO - Downloaded 86202402 bytes. 14:14:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:47 INFO - mkdir: /builds/slave/test/properties 14:14:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:47 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:47 INFO - Contents: 14:14:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - Running post-action listener: set_extra_try_arguments 14:14:48 INFO - ##### 14:14:48 INFO - ##### Running populate-webroot step. 14:14:48 INFO - ##### 14:14:48 INFO - Running pre-action listener: _resource_record_pre_action 14:14:48 INFO - Running main action method: populate_webroot 14:14:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:48 INFO - '--tppagecycles', 14:14:48 INFO - '7'], 14:14:48 INFO - 'tests': ['tsvgm']}}, 14:14:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:14:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:14:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['damp', 'tps']}, 14:14:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['damp', 'tps']}, 14:14:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['dromaeo_dom']}, 14:14:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore', 14:14:48 INFO - 'tabpaint']}, 14:14:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['tsvgx', 14:14:48 INFO - 'tsvgr_opacity', 14:14:48 INFO - 'tart', 14:14:48 INFO - 'tscrollx', 14:14:48 INFO - 'cart']}, 14:14:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:14:48 INFO - 'tsvgr_opacity', 14:14:48 INFO - 'tart', 14:14:48 INFO - 'tscrollx', 14:14:48 INFO - 'cart']}, 14:14:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--disable-e10s'], 14:14:48 INFO - 'tests': ['tp5o']}, 14:14:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['tp5o']}, 14:14:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--disable-e10s', 14:14:48 INFO - '--xperf_path', 14:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:48 INFO - 'tests': ['tp5n']}, 14:14:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--xperf_path', 14:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:48 INFO - 'tests': ['tp5n']}}, 14:14:48 INFO - 'talos.zip': {'path': '', 14:14:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - ##### 14:14:48 INFO - ##### Running create-virtualenv step. 14:14:48 INFO - ##### 14:14:48 INFO - Running pre-action listener: _resource_record_pre_action 14:14:48 INFO - Running main action method: create_virtualenv 14:14:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:48 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 14:14:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:49 INFO - Using real prefix '/tools/python27' 14:14:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:52 INFO - Installing pip.................done. 14:14:52 INFO - Return code: 0 14:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 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 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:14:52 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 14:14:52 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 14:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:52 INFO - 'HOME': '/Users/cltbld', 14:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:52 INFO - 'LOGNAME': 'cltbld', 14:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:52 INFO - 'MOZ_NO_REMOTE': '1', 14:14:52 INFO - 'NO_EM_RESTART': '1', 14:14:52 INFO - 'PAGER': '/bin/cat', 14:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:52 INFO - 'PWD': '/builds/slave/test', 14:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:52 INFO - 'SHELL': '/bin/bash', 14:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:14:52 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:52 INFO - 'USER': 'cltbld', 14:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:52 INFO - 'XPC_FLAGS': '0x0', 14:14:52 INFO - 'XPC_SERVICE_NAME': '0', 14:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:52 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 14:14:52 INFO - Cleaning up... 14:14:52 INFO - Return code: 0 14:14:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:52 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 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:14:52 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 14:14:52 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 14:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:52 INFO - 'HOME': '/Users/cltbld', 14:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:52 INFO - 'LOGNAME': 'cltbld', 14:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:52 INFO - 'MOZ_NO_REMOTE': '1', 14:14:52 INFO - 'NO_EM_RESTART': '1', 14:14:52 INFO - 'PAGER': '/bin/cat', 14:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:52 INFO - 'PWD': '/builds/slave/test', 14:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:52 INFO - 'SHELL': '/bin/bash', 14:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:14:52 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:52 INFO - 'USER': 'cltbld', 14:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:52 INFO - 'XPC_FLAGS': '0x0', 14:14:52 INFO - 'XPC_SERVICE_NAME': '0', 14:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:53 INFO - Downloading/unpacking psutil>=0.7.1 14:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:56 INFO - Installing collected packages: psutil 14:14:56 INFO - Running setup.py install for psutil 14:14:56 INFO - building 'psutil._psutil_osx' extension 14:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:14:57 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 14:14:57 INFO - building 'psutil._psutil_posix' extension 14:14:57 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 14:14:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:14:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:14:57 INFO - ^ 14:14:57 INFO - 1 warning generated. 14:14:57 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 14:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:57 INFO - Successfully installed psutil 14:14:57 INFO - Cleaning up... 14:14:57 INFO - Return code: 0 14:14:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:57 INFO - 'HOME': '/Users/cltbld', 14:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:57 INFO - 'LOGNAME': 'cltbld', 14:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:57 INFO - 'MOZ_NO_REMOTE': '1', 14:14:57 INFO - 'NO_EM_RESTART': '1', 14:14:57 INFO - 'PAGER': '/bin/cat', 14:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:57 INFO - 'PWD': '/builds/slave/test', 14:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:57 INFO - 'SHELL': '/bin/bash', 14:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:14:57 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:57 INFO - 'USER': 'cltbld', 14:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:57 INFO - 'XPC_FLAGS': '0x0', 14:14:57 INFO - 'XPC_SERVICE_NAME': '0', 14:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:15:00 INFO - Installing collected packages: mozsystemmonitor 14:15:00 INFO - Running setup.py install for mozsystemmonitor 14:15:00 INFO - Successfully installed mozsystemmonitor 14:15:00 INFO - Cleaning up... 14:15:00 INFO - Return code: 0 14:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:00 INFO - 'HOME': '/Users/cltbld', 14:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:00 INFO - 'LOGNAME': 'cltbld', 14:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:00 INFO - 'MOZ_NO_REMOTE': '1', 14:15:00 INFO - 'NO_EM_RESTART': '1', 14:15:00 INFO - 'PAGER': '/bin/cat', 14:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:00 INFO - 'PWD': '/builds/slave/test', 14:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:00 INFO - 'SHELL': '/bin/bash', 14:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:00 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:00 INFO - 'USER': 'cltbld', 14:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:00 INFO - 'XPC_FLAGS': '0x0', 14:15:00 INFO - 'XPC_SERVICE_NAME': '0', 14:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:04 INFO - Downloading docopt-0.6.1.tar.gz 14:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:04 INFO - Running setup.py install for blobuploader 14:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:04 INFO - Running setup.py install for requests 14:15:05 INFO - Running setup.py install for docopt 14:15:05 INFO - Successfully installed blobuploader requests docopt 14:15:05 INFO - Cleaning up... 14:15:05 INFO - Return code: 0 14:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:05 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 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:05 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 14:15:05 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 14:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:05 INFO - 'HOME': '/Users/cltbld', 14:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:05 INFO - 'LOGNAME': 'cltbld', 14:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:05 INFO - 'MOZ_NO_REMOTE': '1', 14:15:05 INFO - 'NO_EM_RESTART': '1', 14:15:05 INFO - 'PAGER': '/bin/cat', 14:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:05 INFO - 'PWD': '/builds/slave/test', 14:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:05 INFO - 'SHELL': '/bin/bash', 14:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:05 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:05 INFO - 'USER': 'cltbld', 14:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:05 INFO - 'XPC_FLAGS': '0x0', 14:15:05 INFO - 'XPC_SERVICE_NAME': '0', 14:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9Xdrbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-TaZNpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KG6Fso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-3xdOno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-i78n_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-eYV1q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VxQiCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-UDppyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VxjXIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-14eJ0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-QH5wPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KEqlo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-SeBpKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-chmjTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-98xEEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:07 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-c841PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:07 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-j6f2Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:07 INFO - Running setup.py install for manifestparser 14:15:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:07 INFO - Running setup.py install for mozcrash 14:15:07 INFO - Running setup.py install for mozdebug 14:15:07 INFO - Running setup.py install for mozdevice 14:15:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:07 INFO - Running setup.py install for mozfile 14:15:08 INFO - Running setup.py install for mozhttpd 14:15:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Running setup.py install for mozinfo 14:15:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Running setup.py install for mozInstall 14:15:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Running setup.py install for mozleak 14:15:08 INFO - Running setup.py install for mozlog 14:15:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Running setup.py install for moznetwork 14:15:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:08 INFO - Running setup.py install for mozprocess 14:15:09 INFO - Running setup.py install for mozprofile 14:15:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Running setup.py install for mozrunner 14:15:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Running setup.py install for mozscreenshot 14:15:09 INFO - Running setup.py install for moztest 14:15:09 INFO - Running setup.py install for mozversion 14:15:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:09 INFO - Cleaning up... 14:15:09 INFO - Return code: 0 14:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:09 INFO - 'HOME': '/Users/cltbld', 14:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:09 INFO - 'LOGNAME': 'cltbld', 14:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:09 INFO - 'MOZ_NO_REMOTE': '1', 14:15:09 INFO - 'NO_EM_RESTART': '1', 14:15:09 INFO - 'PAGER': '/bin/cat', 14:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:09 INFO - 'PWD': '/builds/slave/test', 14:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:09 INFO - 'SHELL': '/bin/bash', 14:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:09 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:09 INFO - 'USER': 'cltbld', 14:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:09 INFO - 'XPC_FLAGS': '0x0', 14:15:09 INFO - 'XPC_SERVICE_NAME': '0', 14:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-czKKsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:10 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)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-mIeczP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-WwVLHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IwzRpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BTS1Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jqhHUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-wKlRyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-dwyTCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-R2AUnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:11 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)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-3snzyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:11 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)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-aRlCjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-abea1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JCGU8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OC1Ovq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6Asmy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jnvTaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:11 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-tclrDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:14 INFO - Downloading blessings-1.6.tar.gz 14:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:14 INFO - Installing collected packages: blessings 14:15:14 INFO - Running setup.py install for blessings 14:15:14 INFO - Successfully installed blessings 14:15:14 INFO - Cleaning up... 14:15:14 INFO - Return code: 0 14:15:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:14 INFO - Reading from file tmpfile_stdout 14:15:14 INFO - Current package versions: 14:15:14 INFO - blessings == 1.6 14:15:14 INFO - blobuploader == 1.2.4 14:15:14 INFO - docopt == 0.6.1 14:15:14 INFO - manifestparser == 1.1 14:15:14 INFO - mozInstall == 1.12 14:15:14 INFO - mozcrash == 0.17 14:15:14 INFO - mozdebug == 0.1 14:15:14 INFO - mozdevice == 0.48 14:15:14 INFO - mozfile == 1.2 14:15:14 INFO - mozhttpd == 0.7 14:15:14 INFO - mozinfo == 0.9 14:15:14 INFO - mozleak == 0.1 14:15:14 INFO - mozlog == 3.1 14:15:14 INFO - moznetwork == 0.27 14:15:14 INFO - mozprocess == 0.22 14:15:14 INFO - mozprofile == 0.28 14:15:14 INFO - mozrunner == 6.11 14:15:14 INFO - mozscreenshot == 0.1 14:15:14 INFO - mozsystemmonitor == 0.0 14:15:14 INFO - moztest == 0.7 14:15:14 INFO - mozversion == 1.4 14:15:14 INFO - psutil == 3.1.1 14:15:14 INFO - requests == 1.2.3 14:15:14 INFO - wsgiref == 0.1.2 14:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:14 INFO - 'HOME': '/Users/cltbld', 14:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:14 INFO - 'LOGNAME': 'cltbld', 14:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:14 INFO - 'MOZ_NO_REMOTE': '1', 14:15:14 INFO - 'NO_EM_RESTART': '1', 14:15:14 INFO - 'PAGER': '/bin/cat', 14:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:14 INFO - 'PWD': '/builds/slave/test', 14:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:14 INFO - 'SHELL': '/bin/bash', 14:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:14 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:14 INFO - 'USER': 'cltbld', 14:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:14 INFO - 'XPC_FLAGS': '0x0', 14:15:14 INFO - 'XPC_SERVICE_NAME': '0', 14:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 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)) 14:15:15 INFO - Cleaning up... 14:15:15 INFO - Return code: 0 14:15:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:15 INFO - 'HOME': '/Users/cltbld', 14:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:15 INFO - 'LOGNAME': 'cltbld', 14:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:15 INFO - 'MOZ_NO_REMOTE': '1', 14:15:15 INFO - 'NO_EM_RESTART': '1', 14:15:15 INFO - 'PAGER': '/bin/cat', 14:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:15 INFO - 'PWD': '/builds/slave/test', 14:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:15 INFO - 'SHELL': '/bin/bash', 14:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:15 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:15 INFO - 'USER': 'cltbld', 14:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:15 INFO - 'XPC_FLAGS': '0x0', 14:15:15 INFO - 'XPC_SERVICE_NAME': '0', 14:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:15 INFO - Downloading/unpacking jsonschema 14:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:18 INFO - warning: no files found matching '*.txt' 14:15:18 INFO - no previously-included directories found matching 'build' 14:15:18 INFO - no previously-included directories found matching 'dist' 14:15:18 INFO - no previously-included directories found matching '.git*' 14:15:18 INFO - Installing collected packages: jsonschema, functools32 14:15:18 INFO - Running setup.py install for functools32 14:15:18 INFO - warning: no files found matching '*.txt' 14:15:18 INFO - no previously-included directories found matching 'build' 14:15:18 INFO - no previously-included directories found matching 'dist' 14:15:18 INFO - no previously-included directories found matching '.git*' 14:15:18 INFO - Successfully installed jsonschema functools32 14:15:18 INFO - Cleaning up... 14:15:18 INFO - Return code: 0 14:15:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012f2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde925a1ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, '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.1GvhUTNdX1/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.PH9javeCqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 14:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:18 INFO - 'HOME': '/Users/cltbld', 14:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:18 INFO - 'LOGNAME': 'cltbld', 14:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:18 INFO - 'MOZ_NO_REMOTE': '1', 14:15:18 INFO - 'NO_EM_RESTART': '1', 14:15:18 INFO - 'PAGER': '/bin/cat', 14:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:18 INFO - 'PWD': '/builds/slave/test', 14:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:18 INFO - 'SHELL': '/bin/bash', 14:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:18 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:18 INFO - 'USER': 'cltbld', 14:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:18 INFO - 'XPC_FLAGS': '0x0', 14:15:18 INFO - 'XPC_SERVICE_NAME': '0', 14:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:18 INFO - Downloading/unpacking flake8 14:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:22 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 14:15:22 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 14:15:22 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 14:15:22 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 14:15:22 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 14:15:22 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 14:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:22 INFO - no previously-included directories found matching 'docs/_build' 14:15:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:22 INFO - Running setup.py install for pep8 14:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:22 INFO - no previously-included directories found matching 'docs/_build' 14:15:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:15:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:15:22 INFO - Cleaning up... 14:15:22 INFO - Return code: 0 14:15:22 INFO - Running post-action listener: _resource_record_post_action 14:15:22 INFO - Running post-action listener: _start_resource_monitoring 14:15:22 INFO - Starting resource monitoring. 14:15:22 INFO - ##### 14:15:22 INFO - ##### Running install step. 14:15:22 INFO - ##### 14:15:22 INFO - Running pre-action listener: _resource_record_pre_action 14:15:22 INFO - Running main action method: install 14:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:23 INFO - Reading from file tmpfile_stdout 14:15:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:23 INFO - Reading from file tmpfile_stdout 14:15:23 INFO - Output received: 14:15:23 INFO - Usage: mozinstall [options] installer 14:15:23 INFO - Options: 14:15:23 INFO - -h, --help show this help message and exit 14:15:23 INFO - -d DEST, --destination=DEST 14:15:23 INFO - Directory to install application into. [default: 14:15:23 INFO - "/builds/slave/test"] 14:15:23 INFO - --app=APP Application being installed. [default: firefox] 14:15:23 INFO - mkdir: /builds/slave/test/build/application 14:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:15:45 INFO - Reading from file tmpfile_stdout 14:15:45 INFO - Output received: 14:15:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:15:45 INFO - Running post-action listener: _resource_record_post_action 14:15:45 INFO - ##### 14:15:45 INFO - ##### Running run-tests step. 14:15:45 INFO - ##### 14:15:45 INFO - Running pre-action listener: _resource_record_pre_action 14:15:45 INFO - Running main action method: run_tests 14:15:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:15:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:15:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:15:45 INFO - 2016-06-30 14:15:45.385 screenresolution[1637:7389] starting screenresolution argv=screenresolution get 14:15:45 INFO - 2016-06-30 14:15:45.387 screenresolution[1637:7389] Display 0: 1600x1200x32@60 14:15:45 INFO - 2016-06-30 14:15:45.393 screenresolution[1638:7391] starting screenresolution argv=screenresolution list 14:15:45 INFO - Available Modes on Display 0 14:15:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:15:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:15:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:15:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:15:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:15:45 INFO - Intel Iris: 14:15:45 INFO - Chipset Model: Intel Iris 14:15:45 INFO - Type: GPU 14:15:45 INFO - Bus: Built-In 14:15:45 INFO - VRAM (Dynamic, Max): 1536 MB 14:15:45 INFO - Vendor: Intel (0x8086) 14:15:45 INFO - Device ID: 0x0a2e 14:15:45 INFO - Revision ID: 0x0009 14:15:45 INFO - Displays: 14:15:45 INFO - Display: 14:15:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:15:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:15:45 INFO - Display Serial Number: 1600x1200 60 14:15:45 INFO - Main Display: Yes 14:15:45 INFO - Mirror: Off 14:15:45 INFO - Online: Yes 14:15:45 INFO - Rotation: Supported 14:15:45 INFO - Return code: 0 14:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:45 INFO - Python 2.7.3 14:15:45 INFO - Return code: 0 14:15:45 INFO - grabbing minidump binary from tooltool 14:15: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')]} 14:15:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101181e00>, '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 0x100feadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10117cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:15:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:15:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:45 INFO - Return code: 0 14:15:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:15:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:15:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:46 INFO - Return code: 0 14:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1GvhUTNdX1/Render', 14:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:46 INFO - 'HOME': '/Users/cltbld', 14:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:46 INFO - 'LOGNAME': 'cltbld', 14:15:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:46 INFO - 'MOZ_NO_REMOTE': '1', 14:15:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:46 INFO - 'NO_EM_RESTART': '1', 14:15:46 INFO - 'PAGER': '/bin/cat', 14:15:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:46 INFO - 'PWD': '/builds/slave/test', 14:15:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:46 INFO - 'SHELL': '/bin/bash', 14:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PH9javeCqG/Listeners', 14:15:46 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 14:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:46 INFO - 'USER': 'cltbld', 14:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:46 INFO - 'XPC_FLAGS': '0x0', 14:15:46 INFO - 'XPC_SERVICE_NAME': '0', 14:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:15:47 INFO - mozversion application_buildid: 20160630115927 14:15:47 INFO - mozversion application_changeset: bcb69c8427d315b1d9c993493b2baf639761dd86 14:15:47 INFO - mozversion application_display_name: Firefox 14:15:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:47 INFO - mozversion application_name: Firefox 14:15:47 INFO - mozversion application_remotingname: firefox 14:15:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:47 INFO - mozversion application_vendor: Mozilla 14:15:47 INFO - mozversion application_version: 48.0 14:15:47 INFO - mozversion platform_buildid: 20160630115927 14:15:47 INFO - mozversion platform_changeset: bcb69c8427d315b1d9c993493b2baf639761dd86 14:15:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:47 INFO - mozversion platform_version: 48.0 14:15:47 INFO - using testdate: 1467321347 14:15:47 INFO - actual date: 1467321347 14:15:47 INFO - starting webserver on 'localhost:49270' 14:15:47 INFO - SUITE-START | Running 2 tests 14:15:47 INFO - TEST-START | dromaeo_css 14:15:47 INFO - operating with platform_type : mac_ 14:15:47 INFO - Initialising browser for dromaeo_css test... 14:15:47 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpZG3TIf/profile http://localhost:49270/getInfo.html) 14:15:49 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:15:49 INFO - PROCESS | 1656 | colorDepth:24 14:15:49 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:15:49 INFO - PROCESS | 1656 | __metrics 14:15:49 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:15:49 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:15:49 INFO - TEST-INFO | 1656: exit 0 14:15:49 INFO - Browser initialized. 14:15:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:49 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpZG3TIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:01 INFO - PROCESS | 1659 | RSS: Main: 161910784 14:16:01 INFO - PROCESS | 1659 | 14:16:52 INFO - PROCESS | 1659 | 1467321412884 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] 14:19:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:19:04 INFO - PROCESS | 1659 | RSS: Main: 280064000 14:19:04 INFO - PROCESS | 1659 | 14:22:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:22:07 INFO - PROCESS | 1659 | RSS: Main: 302673920 14:22:07 INFO - PROCESS | 1659 | 14:25:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:25:10 INFO - PROCESS | 1659 | RSS: Main: 301031424 14:25:10 INFO - PROCESS | 1659 | 14:28:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:28:13 INFO - PROCESS | 1659 | RSS: Main: 299896832 14:28:13 INFO - PROCESS | 1659 | 14:31:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:31:16 INFO - PROCESS | 1659 | RSS: Main: 265736192 14:31:16 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:34:19 INFO - PROCESS | 1659 | RSS: Main: 310652928 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | __start_tp_report 14:34:19 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 14:34:19 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 14:34:19 INFO - PROCESS | 1659 | |i|pagename|runs| 14:34:19 INFO - PROCESS | 1659 | |0;dojo.html;3505.3164632896587;3548.893533194002;3559.822008899556;3566.6076731559533;3643.617420170882;5130.179171332587;5780.797672081478;5788.594798364116;5800.158976948345;5832.883342333156;5762.798302059428;5809;5815.185873977646;5823.592348535604;5835.299764028312;5247.580193584514;5273.367195936493;5301.5228629423345;5310.8141215057485;5433.945660543383;5353.812616558421;5401.189821526763;5406.972675191721;5418.106012507931;5428.5928555358305;5343.7060961647285;5404.513593776559;5410.675359478424;5437.864053398677;5447.1829225616075;5411.810586629469;5422.376426710939;5448;5466.863328416782;5481.397046324901;5171.301874246966;5238.5023422774775;5332.760025798849;5335.813246536352;5371;4607.792649330788;5703.629264097862;5726.513246374022;5726.82819515411;5757.8560535986935;6272.435480806704;6291.1192433059405;6301.968490157566;6314.71583778731;6337.207849018872;6190.380961903818;6198.0702894566175;6205.87588248237;6262.279837818618;6267;5915.792947246826;5951.880962380728;5967.433093856077;5968.522518198533;5996.730147143346;6318.052292156213;6320.905186422207;6326;6347.777827776005;6360.618362898241;6066.848328791815;6098.535552314561;6271.278802937721;6288.622682639057;6293.748250070037;6280.905786413207;6284.874302513924;6305.5901366411035;6306.180196574416;6316.30520642729;6225.875482490324;6286.52851036165;6290.937090629035;6301.96849015752;6314.9684251579365;6183.288921774054;6266.248050234001;6294.559380843389;6301.40136687014;6322.620642761449;4956.950430495649;4987.102321582078;4993.825216117419;5001.324821149171;5002;4523.163214805271;4532.252178390529;4544.863654090383;4627.8611641650805;4645.279981602857;5769.711514424262;5794.130880367894;5804.042333015005;5812.651240925558;5865.413458654186;6189;6196;6212.347703491158;6222.000249719066;6259.499240060784;5837.737301821428;5851.970740146272;5871.6183448075735;5879.118132280107;5886.440788125121;5477.342718873681;5483.588730845203;5486.890262194814;5489.34127904646;5509.972450137804;6250.218722659577;6346.238451385863;6348.682565871595;6462.353764623594;6492.837679058061;6144;6261.311255761953;6265.27949285838;6305;6310.873782524232;6442.581232219891;6467.159269294962;6474.546781725234;6475.838104047437;6507.707153178024;6280.309165991828;6286.937130628635;6289.182406287154;6305.054241863757;6307.432331090224;6167.907481387872;6181.072839074175;6184.783532576338;6267;6277.591956522811;6167.814965551041;6215.906761398673;6216.627002379872;6223.190985171898;6237.4698150657705;6151;6175.907361389673;6194.38056194395;6216.347283535164;6243.656598887105;5847.649141051551;6016.368281330398;6024;6100.054491553817;6129.141920131096;6172.382761723792;6182.876342473215;6192.349803270772;6193.040078787795;6218.5647004711045;6008.969955150196;6088.847778805388;6113.938860611337;6116.5718399711595;6126 14:34:19 INFO - PROCESS | 1659 | |1;ext.html;548.7695168029427;567.4807551090752;568.7582777319639;587.3533988689417;590;31700.048998530052;32380.83809580952;39320.41019384708;39680;39818.40272395917;41907.37138942918;42502.574974250245;42563.57436425635;42623.93440163998;42883;8280.337572994145;8949.239314658262;9238.260939124888;9617.759556011086;9843.310968232227;9674.790651168603;11147.773744888056;11695;12224.327661978588;12235.69410764729;11832.94083529581;11921;11924.821127683092;11927.70180745484;11944.64166075019;11812.940935295312;11958.521659133625;11961.999999999956;11972.042236621137;11999.700007499796;11658.825117623242;11761.58834440799;11772.175947683665;11808.173427860052;11811.350375729331;36901.07747306312;41864.95337616553;42225.94435139146;42239.15521689549;42293.57706422927;3314.850831712579;3415.846286917095;3450.258194488172;3520.2079532105327;3922.7646341219333;22561;27122.18633441;28290.00984965537;28354.86580536776;29391;2736.1602352660543;2762.737539933703;2767.252841732741;2776;2826.1662809471254;330171;331369;332177;332317;333125;28978.7102128976;38151.236975260894;65374.019389709196;65448.345516545174;66099.66950165314;36370.45444318337;36819.81590092086;36823.815880920956;36850;36885.26229475396;16597.91701041487;16713.49859504217;16767.413140540266;16793.496195114167;16858.662826743395;12853;12951.805722914163;13898;13947;13956.930215348859;7669.424793140537;8004.359651227888;8428.620712067848;8484.915150848412;8567.828643427096;3120.937581248362;3251.64231934487;3562.340966921076;3596.8741094062107;3653;986.6102889358663;1054.7415883108688;1119.9720006999728;1141.3779490177874;1142.7200335917587;30406.783728651048;30997.69002309993;31138.532922006187;31727.52408713871;31829;1128.2414496555841;1135.267752299762;1164.2257898497573;1181.9054475641929;1324.0533018891538;15729.606759831096;15791.921040394724;15810.525684229491;16018.439354622533;16066.116363600115;621227;622280;629143;629625;630839;62616.747665047355;63419.4145146375;63447;63525.36474635287;63607;1423.8860891128684;1586.9285882135332;1591.6259678975664;1594.760785882127;1603.7674537192042;27110.457790843677;30192.24519387033;30553.54169687501;31654.683453165173;32363.19092022718;54045.72977135089;54394.456055440525;55023.17465237944;55044.69731816104;55117;368643;564445;579325;579843;580561;44333.33499997438;44978;45819.3127103087;45836.54163458456;46800;45768.313475298564;45956.310655340865;46514.534854652375;47313;47362.763186183845;32246.677533224367;36705.63294367129;38537.8438646841;39195.80402097971;39221.60778392294;39361.80319098386;39766.403503948044;40143.799281003405;40187.598124019554;41094;35914.820425897706;38952.6104738949;40114.39828402518;40337.39493907653;40357.39463908102;28451.857740711162;33598.328033439684;34189.97430077101;34965.47551786674;34968.65031349756;26107.08625198109;26258.606120908586;26316.416606261697;26401.20796376035;26821.731782682706 14:34:19 INFO - PROCESS | 1659 | |2;jquery.html;412.29497559173814;412.46173743265064;419.5678451195269;420.0611633000246;423.60816244973404;20492.487687807792;20512.897435512838;21215.151393944245;21260.936953152337;21927.67108493374;21218.89390553049;22077.889610551923;22754.431139221528;22940.8852955735;22976.08095676175;5849.385814489481;6164.445199932005;6165.475934545569;6178.814635560918;6188.876222475547;5860.384659610722;6029.186059881926;6187.876242475148;6188.628682279078;6191.597546159508;6085.695715214244;6113.991191453405;6115.724792384353;6141.631502109888;6146;5002.52476014778;5816.360200377955;6108.786192483264;6115.847103822395;6115.938840611604;5256.2904007959205;5280.049591073605;5295.655782374133;5300.072487314743;5304.389995150568;26450.73549264502;27021.864890675617;27258.5911211332;27583.724162758317;27649.308767280778;2205.9558808823895;2375.6792832967676;2433.914812981555;2465.408302007523;2891.551809469536;15282.847171528254;15644.374225031099;15767.526974190792;16086.115263660495;16458.259378328003;1792.4981005318532;1828.2961059991999;1931.2564662604857;1998.5503261766132;2115.3019503563787;101354.49322753413;119013.80986190114;120418;123433.14850277253;138571;11684.591039313584;11779.175457717878;12054.879451205552;12070.456829442695;12076.335801531;14366.56900292993;15807.841921580637;15807.920960395124;15809.209539522977;15823.287952042187;8587;8920.598573064228;9204.539773011322;9328.626854925862;9407.670731524364;9282.814343713088;9286.489243091559;9288.489133097744;9290.535473226311;9349.39228950116;4786.2581299898575;4835.927461088087;4840.7337596432535;4851.34506841579;4887.73117478535;2029.0970518119295;2078.9792102079086;2079.396974877269;2120.5758848230416;2136.658134698441;935.9812803743887;963.3978763272954;980.9754756131153;1040.4173662748885;1044.1125043712784;18725.90637046806;20583.324167858384;20798.1680732769;20954;21024;1035.53400969564;1038.683201623512;1041.9322744021615;1068.8289873620183;1092.2408925796494;10799.190060745475;11281.887181128084;11285.153613479022;11328.263662861887;11371.317720936604;657609.7119514372;659051;662695;669655;675104;74055.62972185104;108142;108991;127008;132533;1044.4516628769957;1049.4228174504144;1059.9417032063157;1070.8875568065396;1071.4963966935527;18262.788445216265;18433.539161520534;18879.528011799266;19087.236510539424;19087.759295645737;33864.49203261904;34093;44172.779136104116;53080.46919530755;53748.73125634503;76851.2314876844;79640.60179699064;82035;82224;83583.58208209163;8194.877076843972;8225.383096267684;8312.21034001769;8351.624176911931;8877.067907869581;11590.13074019435;13058.34708264602;13252.337383130998;13377.331133443095;13432;11293.491792869505;11505.252158609663;11583.364824280663;11610.76778464443;11690.76618467609;11032.155617308392;11318.773624527299;11325.754167041783;11754.76490470203;11925.224860384047;11570.016548593463;11747.236429632047;11888.881111188777;12081.214721043105;12185.268883866642;7944.205579442009;8253.79365515867;8296.917030829614;8439.367047471342;8835.939687237573;8305.916940830515;9454.243660507005;11104;11139.05318047975;11249.493772780408 14:34:19 INFO - PROCESS | 1659 | |3;mootools.html;1538.4769178479314;1664.7835781348424;1694.9914800693587;2038.4903774056486;2097.8636388634736;8253.876191857127;8948.06045365237;9109.68116115936;9123.635054597817;9140.497272650002;8850.336224783136;8913;8994.640214391417;8997.415168014075;9009.189172974431;2457.103157347573;2565.9358516037064;2568.1011645923963;2568.7045989711237;2572.588385858263;2491.4145175883655;2560.2703229579574;2563.333533281351;2563.4104156044123;2563.461673048662;2523.1547431610434;2550.3496608364935;2565.8588777617224;2566.217303722364;2569.5374832530138;2520.621906713989;2533.860637664937;2552.540542702313;2555.7987745759465;2567.281161274846;2499.700035995674;2540.2379286214245;2555.3356127406823;2555.9488810223693;2556.169244995384;8832.735017949408;9170.587323570455;9222.723318300461;9229.169374756237;9230.492322922237;5541.307336582927;5666.263385759866;5683.630564013326;5742.569307301927;5769.3076830780155;3578.946315805265;3602.513660655804;3667.688246499051;3745.3632882410056;3754.624537546251;1037.1184493180735;1067.7437415020418;1067.7597540553313;1072.5441687282873;1077;12277.140600157993;12372.319522426264;12443.25340479565;12456.75086498274;12467.376631168405;4686.390769199982;4689.7655117244;4800.639952003544;4842.322074909515;4846.418429788448;9843.507824608741;9850;9856.901430985741;9861.161801246973;9884.654037108667;5559.416261292506;5586.385497595261;5595.328560572757;5595.63628364155;5615;4615.815367385267;4783.736894470768;5054.115529782273;5068.910184310391;5190.377154741455;4013.678905687538;4014.8594799181888;4100.138970816102;4106.1582375612925;4136.503619565671;1239.857416397126;1251.2867665430617;1251.9061070419755;1258.7608354412632;1263.4503990764047;963.8939716631165;982.2780256511459;999.550202408919;1004.864343313658;1023.3757407981126;5283.6037297202865;6078.240219972504;6146.262448506208;6383.202099737533;6396.200474940632;960.1214888377057;987.3582171588381;1007.4940450438389;1028.1517747858047;1035.0787798859021;4118.691098167589;4133.42132101506;4134.338505839051;4160.4591403118;4220.2192594370135;10993.780124397626;11438.59964901241;11487.942560287145;11489.42552872353;11492.138089643144;10377.636782712569;10848.511816968256;11224.382658953673;11227;11264.43677816106;8601.870971935426;8635;8656.09111043344;8691.043985161627;8734.475931444134;5862.94137058624;6037.305709843425;6129.969350153221;6207.255129384503;6213.565050446426;9686;9747.171490423394;9794.951025244829;9950.601975920883;9950.701478955643;9863.654772082942;10473.423961682181;10493.842592361274;10648.680539583826;10655.041046305869;6268.717907694256;7233.1681856587165;7356.301151390609;8021.077576078826;8097.473664211808;8555.230029297392;8585.270252028648;8636.438631488933;8656.91343086561;8826.691065812665;7546.849063018819;7639.694412223671;7705.113911899979;7713.460057796125;7779.494332868572;7437.107547094167;7495.850082998419;7529.8117547061765;7633.931249625168;7641.2740789624895;7125.429965602636;7165.713371465083;7169.211386747558;7199.748008819666;7202.603856787927;4961.652684312208;4973.35346404965;5088.389393272683;5142.100132476877;5174.7930082796265;5068.746562671926;5092.719900405513;5116.258142569381;5207.270982062439;5333.333333333333 14:34:19 INFO - PROCESS | 1659 | |4;prototype.html;325.17892321887234;341.79833898000174;347.483235676273;350.7895262842295;353.7594435783669;6857.451403887683;6925.757598484054;6943.861122777542;6949.548279361844;6954.79135625932;6835.726570937169;6883.8623227535545;6884.862302753954;6905.930940690591;6919.065926099975;4865.44047434546;4952.678075925071;4978.377702787152;5102.285680004802;5156.3296771419855;5055.292259083732;5114.130597798383;5122.462141475147;5126.461721519243;5150.459201783815;5045.369328833895;5063.569596584295;5072.873178170538;5088.771005304751;5088.7964481420695;3893.8831835044994;4954.20732682769;5077.441481437039;5100.209467532539;5103.5151660592555;4377.9781101094295;4381.145676593065;4382.605565499089;4391.582799634061;4401.64786817057;6595.967020164869;6598.47212223021;6598.670066496656;6600.966995165041;6623.867522649568;5982.132590774313;5996.950533656636;6003.249593800775;6003.8198854034445;6005.309389420186;7007.264237255065;7222.638868056576;7258.745943891991;7269.236730143311;7270.418366530665;4860.343853579757;4892.755362231874;4910.607151427913;4913.680610760289;4916.655834091615;7668.118166410878;7675.846483070363;7719.112302085276;7723;7724.691012359499;4167.916341751166;4952.257161425815;4971.850844474671;4976.90046199074;4977.875553111201;4262.254105531581;5058.797648094109;5061.4179369373;5063.544281014726;5067.5185857343495;4884.853454396374;5215.59179021662;5827.215489744956;5935.1987481690285;6011.639301641915;6606.405423511907;6789.558678685869;7256.528325658815;7313.634318284065;7316.743913963092;1742.4511278947346;1771.706654142483;1773.361589827661;1777.8844375115575;1781.15395187285;1068.1561566362486;1077.6605369308643;1118.116687816632;1123.9662810115547;1152.7924973504682;6862.416694580917;6977.616231107338;6990.6155161465595;7000.334968178015;7070.505064645426;6175.320714721377;6180.690965451709;7681.846363072707;7692.115406728298;7713.074431068308;6989.4408447324095;6990.930090699129;6992.6853291602;6995;6996;3898.4737060497037;4021.738586991836;4059.939100913489;4064.878053658395;4073.837046518165;7978.920210797934;7988.80027999293;7989.7203597873795;7991.160928102466;8037.115917249098;7911.327537159291;7913.406494512935;7921.009873765779;7925.28672419485;7930.167332430012;8014.398920081017;8033.5983200838555;8042.718504852419;8050.476719013245;8065.1934806518875;7453.153710854958;7571.053618297713;7659.119201291923;7686.000819893378;7687.11598166218;7473.588952607659;7521.285477879593;7527.473076884566;7531.284527969834;7546.584937828253;6454.709538070704;7999.4400391972;8033.879491807745;8044.1955804419085;8051.51690898548;4791.377120974251;4836.564709176191;4842.104210721028;4844.128056949642;4855.053264613366;7390.482666213528;7616.581088040211;7636.885446718415;7650.540967541742;7651.387888968758;7339.889901651372;7364.374028207662;7402.29678180572;7410.703571857065;7436.442266829901;6000.339962604197;7402.1117465904435;7406.518576292524;7407.59258240802;7416.96162537256;7012.123484564429;7220.675069621774;7238.493305468567;7241.203467618452;7257.709691612276;7329.450291228286;7407.92592074094;7413.962930185315;7431.108267007994;7463.888041679271;6950.165980082423;7066.57600543969;7109.786706398816;7113.502054856317;7127.216006239413 14:34:19 INFO - PROCESS | 1659 | |5;yui.html;691.889297712366;694.84366017646;707;710.0378986473326;723.913130424349;15467.149306788122;15651.217439128055;15686.21568921555;15690.607734806636;15738.685226295482;13542.593722188325;14461.276936153177;14506.419743210285;14515.782263266034;14551.854481455182;971.6599190283397;998.3859926145404;999.2056315229373;999.7650552120245;1001.7796084861319;981.8527220916848;991.2912267728573;997.4364484066515;997.5710444508858;997.7405874472653;837.0415873824468;965.034965034965;968.7917097823967;1025.3847691385147;1041.0890470838017;1034.0331789776546;1036.1710631494811;1036.9066783989401;1037.0044757033181;1040.8594839696657;771.8842173673937;772.2277722277722;772.9497582657109;773.1958762886591;774.4385320642546;15239.161846098461;15277.00699454532;15283.541493755205;15317.923410382988;15341.156236406992;12791.872081279162;13152.40814163365;13285.3357332133;13339.266340351276;13379;8731.388802783807;9360.4383736976;10135.573916257877;10694.625688100958;10703.197260205516;3480.1821571930577;3532.7703699259464;3588.659077387644;3654.543182102237;3811.6569508744346;82592.76110858342;87639.56180219122;88307;89616;92072.53963730205;9853.655122070693;9890.456024918554;9924.60301587943;9978.700638980843;10151.695449136538;23307;23386.532269354517;23400.297991060295;23411.531769364516;23414.18050368263;7514.812129696692;7623.237676232443;7722.189170137055;7793.2596403341595;7917.406194535433;4175.68682348825;4267.381229721673;4290.871273861727;4335.1979883721615;4392.802323895432;3669.1377526281303;3717.628237176261;3721.5720192177705;3722.553293604785;3726.1616136369644;647.5531883000808;659.0147729144959;662.4998126414526;673.39394544909;683.2859661653584;566.4392251670898;597.7190720361423;600.1927407636722;613.227333559718;629.4115002472611;8263.628136733862;8298.917010829935;8451.915480845113;8472.534010629475;8573;526.5129754976631;599.9700014999232;615.4860691322706;616.1558664629487;631.3150231998334;3795.35478968576;3809.923801523954;3947.5262968443394;3971.4837071180564;4054.2296963576828;70261.64869175621;86502.26995460056;89885.10114898767;90074.28817476863;90858;65689.67155164194;81735;82601;85189.57405213059;86220;74683;75258.24741752731;75338.62330688312;75552.4889502207;76650;6675.499337549801;7852.900593916742;8020.598970051357;8054;8081.4342995992065;44532.44136455208;45632.77183614061;50796.49203507917;50894.236586451974;51636.48363516467;55257.78968841201;66276.04101569459;69555.30444695488;73890.52218955483;74359.62820185865;9982.550785214828;10019.348742331726;10449.21630877672;10546.525406356579;10646.520906559379;11059.889401105886;11377.43112844371;11490.827637585277;11496.540138394705;11994.64016079519;10685.465726713788;10719.464026798785;10790.62232821879;11005.229633925548;11031.172662050218;10859.565617375216;10869.67390978272;11074.390908499787;11113.22207445471;11132.554697811996;10531.21015923824;10563.735906602396;10580.788384232426;10640.733981650521;10886.727831804268;9085;9276.304277179104;9301.26659968199;9423.340366174301;9609.951950240204;9079.818403632022;9203.309751768511;9206.309526785652;9225.86161207569;9273.072692730942 14:34:19 INFO - PROCESS | 1659 | __end_tp_report 14:34:19 INFO - PROCESS | 1659 | __start_cc_report 14:34:19 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1048 14:34:19 INFO - PROCESS | 1659 | __end_cc_report 14:34:19 INFO - PROCESS | 1659 | __startTimestamp1467322459422__endTimestamp 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | ------- Summary: start ------- 14:34:19 INFO - PROCESS | 1659 | Number of tests: 6 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5835.33 Median:6100.05 stddev:615.13 (10.1%) stddev-sans-first:589.24 14:34:19 INFO - PROCESS | 1659 | Values: 3505.3 3548.9 3559.8 3566.6 3643.6 5130.2 5780.8 5788.6 5800.2 5832.9 5762.8 5809.0 5815.2 5823.6 5835.3 5247.6 5273.4 5301.5 5310.8 5433.9 5353.8 5401.2 5407.0 5418.1 5428.6 5343.7 5404.5 5410.7 5437.9 5447.2 5411.8 5422.4 5448.0 5466.9 5481.4 5171.3 5238.5 5332.8 5335.8 5371.0 4607.8 5703.6 5726.5 5726.8 5757.9 6272.4 6291.1 6302.0 6314.7 6337.2 6190.4 6198.1 6205.9 6262.3 6267.0 5915.8 5951.9 5967.4 5968.5 5996.7 6318.1 6320.9 6326.0 6347.8 6360.6 6066.8 6098.5 6271.3 6288.6 6293.7 6280.9 6284.9 6305.6 6306.2 6316.3 6225.9 6286.5 6290.9 6302.0 6315.0 6183.3 6266.2 6294.6 6301.4 6322.6 4957.0 4987.1 4993.8 5001.3 5002.0 4523.2 4532.3 4544.9 4627.9 4645.3 5769.7 5794.1 5804.0 5812.7 5865.4 6189.0 6196.0 6212.3 6222.0 6259.5 5837.7 5852.0 5871.6 5879.1 5886.4 5477.3 5483.6 5486.9 5489.3 5510.0 6250.2 6346.2 6348.7 6462.4 6492.8 6144.0 6261.3 6265.3 6305.0 6310.9 6442.6 6467.2 6474.5 6475.8 6507.7 6280.3 6286.9 6289.2 6305.1 6307.4 6167.9 6181.1 6184.8 6267.0 6277.6 6167.8 6215.9 6216.6 6223.2 6237.5 6151.0 6175.9 6194.4 6216.3 6243.7 5847.6 6016.4 6024.0 6100.1 6129.1 6172.4 6182.9 6192.3 6193.0 6218.6 6009.0 6088.8 6113.9 6116.6 6126.0 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:63956.85 Median:34967.06 stddev:137733.58 (393.9%) stddev-sans-first:138037.68 14:34:19 INFO - PROCESS | 1659 | Values: 548.8 567.5 568.8 587.4 590.0 31700.0 32380.8 39320.4 39680.0 39818.4 41907.4 42502.6 42563.6 42623.9 42883.0 8280.3 8949.2 9238.3 9617.8 9843.3 9674.8 11147.8 11695.0 12224.3 12235.7 11832.9 11921.0 11924.8 11927.7 11944.6 11812.9 11958.5 11962.0 11972.0 11999.7 11658.8 11761.6 11772.2 11808.2 11811.4 36901.1 41865.0 42225.9 42239.2 42293.6 3314.9 3415.8 3450.3 3520.2 3922.8 22561.0 27122.2 28290.0 28354.9 29391.0 2736.2 2762.7 2767.3 2776.0 2826.2 330171.0 331369.0 332177.0 332317.0 333125.0 28978.7 38151.2 65374.0 65448.3 66099.7 36370.5 36819.8 36823.8 36850.0 36885.3 16597.9 16713.5 16767.4 16793.5 16858.7 12853.0 12951.8 13898.0 13947.0 13956.9 7669.4 8004.4 8428.6 8484.9 8567.8 3120.9 3251.6 3562.3 3596.9 3653.0 986.6 1054.7 1120.0 1141.4 1142.7 30406.8 30997.7 31138.5 31727.5 31829.0 1128.2 1135.3 1164.2 1181.9 1324.1 15729.6 15791.9 15810.5 16018.4 16066.1 621227.0 622280.0 629143.0 629625.0 630839.0 62616.7 63419.4 63447.0 63525.4 63607.0 1423.9 1586.9 1591.6 1594.8 1603.8 27110.5 30192.2 30553.5 31654.7 32363.2 54045.7 54394.5 55023.2 55044.7 55117.0 368643.0 564445.0 579325.0 579843.0 580561.0 44333.3 44978.0 45819.3 45836.5 46800.0 45768.3 45956.3 46514.5 47313.0 47362.8 32246.7 36705.6 38537.8 39195.8 39221.6 39361.8 39766.4 40143.8 40187.6 41094.0 35914.8 38952.6 40114.4 40337.4 40357.4 28451.9 33598.3 34190.0 34965.5 34968.7 26107.1 26258.6 26316.4 26401.2 26821.7 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36724.22 Median:12141.92 stddev:110061.88 (906.5%) stddev-sans-first:110336.86 14:34:19 INFO - PROCESS | 1659 | Values: 412.3 412.5 419.6 420.1 423.6 20492.5 20512.9 21215.2 21260.9 21927.7 21218.9 22077.9 22754.4 22940.9 22976.1 5849.4 6164.4 6165.5 6178.8 6188.9 5860.4 6029.2 6187.9 6188.6 6191.6 6085.7 6114.0 6115.7 6141.6 6146.0 5002.5 5816.4 6108.8 6115.8 6115.9 5256.3 5280.0 5295.7 5300.1 5304.4 26450.7 27021.9 27258.6 27583.7 27649.3 2206.0 2375.7 2433.9 2465.4 2891.6 15282.8 15644.4 15767.5 16086.1 16458.3 1792.5 1828.3 1931.3 1998.6 2115.3 101354.5 119013.8 120418.0 123433.1 138571.0 11684.6 11779.2 12054.9 12070.5 12076.3 14366.6 15807.8 15807.9 15809.2 15823.3 8587.0 8920.6 9204.5 9328.6 9407.7 9282.8 9286.5 9288.5 9290.5 9349.4 4786.3 4835.9 4840.7 4851.3 4887.7 2029.1 2079.0 2079.4 2120.6 2136.7 936.0 963.4 981.0 1040.4 1044.1 18725.9 20583.3 20798.2 20954.0 21024.0 1035.5 1038.7 1041.9 1068.8 1092.2 10799.2 11281.9 11285.2 11328.3 11371.3 657609.7 659051.0 662695.0 669655.0 675104.0 74055.6 108142.0 108991.0 127008.0 132533.0 1044.5 1049.4 1059.9 1070.9 1071.5 18262.8 18433.5 18879.5 19087.2 19087.8 33864.5 34093.0 44172.8 53080.5 53748.7 76851.2 79640.6 82035.0 82224.0 83583.6 8194.9 8225.4 8312.2 8351.6 8877.1 11590.1 13058.3 13252.3 13377.3 13432.0 11293.5 11505.3 11583.4 11610.8 11690.8 11032.2 11318.8 11325.8 11754.8 11925.2 11570.0 11747.2 11888.9 12081.2 12185.3 7944.2 8253.8 8296.9 8439.4 8835.9 8305.9 9454.2 11104.0 11139.1 11249.5 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5920.04 Median:5078.65 stddev:3282.51 (64.6%) stddev-sans-first:3275.20 14:34:19 INFO - PROCESS | 1659 | Values: 1538.5 1664.8 1695.0 2038.5 2097.9 8253.9 8948.1 9109.7 9123.6 9140.5 8850.3 8913.0 8994.6 8997.4 9009.2 2457.1 2565.9 2568.1 2568.7 2572.6 2491.4 2560.3 2563.3 2563.4 2563.5 2523.2 2550.3 2565.9 2566.2 2569.5 2520.6 2533.9 2552.5 2555.8 2567.3 2499.7 2540.2 2555.3 2555.9 2556.2 8832.7 9170.6 9222.7 9229.2 9230.5 5541.3 5666.3 5683.6 5742.6 5769.3 3578.9 3602.5 3667.7 3745.4 3754.6 1037.1 1067.7 1067.8 1072.5 1077.0 12277.1 12372.3 12443.3 12456.8 12467.4 4686.4 4689.8 4800.6 4842.3 4846.4 9843.5 9850.0 9856.9 9861.2 9884.7 5559.4 5586.4 5595.3 5595.6 5615.0 4615.8 4783.7 5054.1 5068.9 5190.4 4013.7 4014.9 4100.1 4106.2 4136.5 1239.9 1251.3 1251.9 1258.8 1263.5 963.9 982.3 999.6 1004.9 1023.4 5283.6 6078.2 6146.3 6383.2 6396.2 960.1 987.4 1007.5 1028.2 1035.1 4118.7 4133.4 4134.3 4160.5 4220.2 10993.8 11438.6 11487.9 11489.4 11492.1 10377.6 10848.5 11224.4 11227.0 11264.4 8601.9 8635.0 8656.1 8691.0 8734.5 5862.9 6037.3 6130.0 6207.3 6213.6 9686.0 9747.2 9795.0 9950.6 9950.7 9863.7 10473.4 10493.8 10648.7 10655.0 6268.7 7233.2 7356.3 8021.1 8097.5 8555.2 8585.3 8636.4 8656.9 8826.7 7546.8 7639.7 7705.1 7713.5 7779.5 7437.1 7495.9 7529.8 7633.9 7641.3 7125.4 7165.7 7169.2 7199.7 7202.6 4961.7 4973.4 5088.4 5142.1 5174.8 5068.7 5092.7 5116.3 5207.3 5333.3 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:6019.57 Median:6895.40 stddev:1922.69 (27.9%) stddev-sans-first:1879.98 14:34:19 INFO - PROCESS | 1659 | Values: 325.2 341.8 347.5 350.8 353.8 6857.5 6925.8 6943.9 6949.5 6954.8 6835.7 6883.9 6884.9 6905.9 6919.1 4865.4 4952.7 4978.4 5102.3 5156.3 5055.3 5114.1 5122.5 5126.5 5150.5 5045.4 5063.6 5072.9 5088.8 5088.8 3893.9 4954.2 5077.4 5100.2 5103.5 4378.0 4381.1 4382.6 4391.6 4401.6 6596.0 6598.5 6598.7 6601.0 6623.9 5982.1 5997.0 6003.2 6003.8 6005.3 7007.3 7222.6 7258.7 7269.2 7270.4 4860.3 4892.8 4910.6 4913.7 4916.7 7668.1 7675.8 7719.1 7723.0 7724.7 4167.9 4952.3 4971.9 4976.9 4977.9 4262.3 5058.8 5061.4 5063.5 5067.5 4884.9 5215.6 5827.2 5935.2 6011.6 6606.4 6789.6 7256.5 7313.6 7316.7 1742.5 1771.7 1773.4 1777.9 1781.2 1068.2 1077.7 1118.1 1124.0 1152.8 6862.4 6977.6 6990.6 7000.3 7070.5 6175.3 6180.7 7681.8 7692.1 7713.1 6989.4 6990.9 6992.7 6995.0 6996.0 3898.5 4021.7 4059.9 4064.9 4073.8 7978.9 7988.8 7989.7 7991.2 8037.1 7911.3 7913.4 7921.0 7925.3 7930.2 8014.4 8033.6 8042.7 8050.5 8065.2 7453.2 7571.1 7659.1 7686.0 7687.1 7473.6 7521.3 7527.5 7531.3 7546.6 6454.7 7999.4 8033.9 8044.2 8051.5 4791.4 4836.6 4842.1 4844.1 4855.1 7390.5 7616.6 7636.9 7650.5 7651.4 7339.9 7364.4 7402.3 7410.7 7436.4 6000.3 7402.1 7406.5 7407.6 7417.0 7012.1 7220.7 7238.5 7241.2 7257.7 7329.5 7407.9 7414.0 7431.1 7463.9 6950.2 7066.6 7109.8 7113.5 7127.2 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:18533.37 Median:600.08 stddev:26229.43 (4371.0%) stddev-sans-first:26268.80 14:34:19 INFO - PROCESS | 1659 | Values: 691.9 694.8 707.0 710.0 723.9 15467.1 15651.2 15686.2 15690.6 15738.7 13542.6 14461.3 14506.4 14515.8 14551.9 971.7 998.4 999.2 999.8 1001.8 981.9 991.3 997.4 997.6 997.7 837.0 965.0 968.8 1025.4 1041.1 1034.0 1036.2 1036.9 1037.0 1040.9 771.9 772.2 772.9 773.2 774.4 15239.2 15277.0 15283.5 15317.9 15341.2 12791.9 13152.4 13285.3 13339.3 13379.0 8731.4 9360.4 10135.6 10694.6 10703.2 3480.2 3532.8 3588.7 3654.5 3811.7 82592.8 87639.6 88307.0 89616.0 92072.5 9853.7 9890.5 9924.6 9978.7 10151.7 23307.0 23386.5 23400.3 23411.5 23414.2 7514.8 7623.2 7722.2 7793.3 7917.4 4175.7 4267.4 4290.9 4335.2 4392.8 3669.1 3717.6 3721.6 3722.6 3726.2 647.6 659.0 662.5 673.4 683.3 566.4 597.7 600.2 613.2 629.4 8263.6 8298.9 8451.9 8472.5 8573.0 526.5 600.0 615.5 616.2 631.3 3795.4 3809.9 3947.5 3971.5 4054.2 70261.6 86502.3 89885.1 90074.3 90858.0 65689.7 81735.0 82601.0 85189.6 86220.0 74683.0 75258.2 75338.6 75552.5 76650.0 6675.5 7852.9 8020.6 8054.0 8081.4 44532.4 45632.8 50796.5 50894.2 51636.5 55257.8 66276.0 69555.3 73890.5 74359.6 9982.6 10019.3 10449.2 10546.5 10646.5 11059.9 11377.4 11490.8 11496.5 11994.6 10685.5 10719.5 10790.6 11005.2 11031.2 10859.6 10869.7 11074.4 11113.2 11132.6 10531.2 10563.7 10580.8 10640.7 10886.7 9085.0 9276.3 9301.3 9423.3 9610.0 9079.8 9203.3 9206.3 9225.9 9273.1 14:34:19 INFO - PROCESS | 1659 | -------- Summary: end -------- 14:34:19 INFO - PROCESS | 1659 | 14:34:19 INFO - TEST-INFO | 1659: exit 0 14:34:20 INFO - TEST-OK | dromaeo_css | took 1112969ms 14:34:20 INFO - TEST-START | kraken 14:34:20 INFO - operating with platform_type : mac_ 14:34:20 INFO - Initialising browser for kraken test... 14:34:20 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTQmGT8/profile http://localhost:49270/getInfo.html) 14:34:22 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 14:34:22 INFO - PROCESS | 1670 | colorDepth:24 14:34:22 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 14:34:22 INFO - PROCESS | 1670 | __metrics 14:34:22 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:22 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:34:23 INFO - TEST-INFO | 1670: exit 0 14:34:23 INFO - Browser initialized. 14:34:23 INFO - Running cycle 1/1 for kraken test... 14:34:23 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTQmGT8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:34 INFO - PROCESS | 1673 | RSS: Main: 161779712 14:34:34 INFO - PROCESS | 1673 | 14:34:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:38 INFO - PROCESS | 1673 | RSS: Main: 224239616 14:34:38 INFO - PROCESS | 1673 | 14:34:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:34:41 INFO - PROCESS | 1673 | RSS: Main: 239984640 14:34:41 INFO - PROCESS | 1673 | 14:34:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:34:45 INFO - PROCESS | 1673 | RSS: Main: 327053312 14:34:45 INFO - PROCESS | 1673 | 14:34:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:34:48 INFO - PROCESS | 1673 | RSS: Main: 231731200 14:34:48 INFO - PROCESS | 1673 | 14:34:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:50 INFO - PROCESS | 1673 | RSS: Main: 232132608 14:34:50 INFO - PROCESS | 1673 | 14:34:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:54 INFO - PROCESS | 1673 | RSS: Main: 268832768 14:34:54 INFO - PROCESS | 1673 | 14:34:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:57 INFO - PROCESS | 1673 | RSS: Main: 271253504 14:34:57 INFO - PROCESS | 1673 | 14:35:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:35:01 INFO - PROCESS | 1673 | RSS: Main: 271028224 14:35:01 INFO - PROCESS | 1673 | 14:35:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:03 INFO - PROCESS | 1673 | RSS: Main: 261046272 14:35:03 INFO - PROCESS | 1673 | 14:35:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:05 INFO - PROCESS | 1673 | RSS: Main: 268734464 14:35:05 INFO - PROCESS | 1673 | 14:35:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:08 INFO - PROCESS | 1673 | RSS: Main: 271355904 14:35:08 INFO - PROCESS | 1673 | 14:35:11 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:11 INFO - PROCESS | 1673 | RSS: Main: 277626880 14:35:11 INFO - PROCESS | 1673 | 14:35:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:15 INFO - PROCESS | 1673 | RSS: Main: 274825216 14:35:15 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:35:17 INFO - PROCESS | 1673 | RSS: Main: 335917056 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | __start_tp_report 14:35:17 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 14:35:17 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 14:35:17 INFO - PROCESS | 1673 | |i|pagename|runs| 14:35:17 INFO - PROCESS | 1673 | |0;ai-astar;109;113;116;112;109;112;111;111;112;133 14:35:17 INFO - PROCESS | 1673 | |1;audio-beat-detection;154;119;143;162;119;138;117;149;152;117 14:35:17 INFO - PROCESS | 1673 | |2;audio-dft;183;186;186;182;184;195;260;214;185;186 14:35:17 INFO - PROCESS | 1673 | |3;audio-fft;69;82;96;189;82;55;60;60;138;59 14:35:17 INFO - PROCESS | 1673 | |4;audio-oscillator;88;88;143;79;79;80;121;79;79;122 14:35:17 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;86;84;87;84;86;83;86;83;86;82 14:35:17 INFO - PROCESS | 1673 | |6;imaging-darkroom;92;92;92;92;92;103;150;92;91;92 14:35:17 INFO - PROCESS | 1673 | |7;imaging-desaturate;85;83;86;85;83;83;83;102;131;69 14:35:17 INFO - PROCESS | 1673 | |8;json-parse-financial;57;61;58;59;87;92;91;102;58;55 14:35:17 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;60;62;60;74;70;71;72;66;64;65 14:35:17 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;77;79;80;79;80;78;79;79;80;83 14:35:17 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;130;144;144;133;125;142;131;143;153;167 14:35:17 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;163;163;169;164;163;162;154;167;166;217 14:35:17 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;71;94;93;82;66;65;71;73;98 14:35:17 INFO - PROCESS | 1673 | __end_tp_report 14:35:17 INFO - PROCESS | 1673 | __start_cc_report 14:35:17 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1920 14:35:17 INFO - PROCESS | 1673 | __end_cc_report 14:35:17 INFO - PROCESS | 1673 | __startTimestamp1467322517523__endTimestamp 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | ------- Summary: start ------- 14:35:17 INFO - PROCESS | 1673 | Number of tests: 14 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:113.80 Median:112.00 stddev:7.04 (6.3%) stddev-sans-first:7.25 14:35:17 INFO - PROCESS | 1673 | Values: 109.0 113.0 116.0 112.0 109.0 112.0 111.0 111.0 112.0 133.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:146.00 stddev:17.54 (12.0%) stddev-sans-first:17.49 14:35:17 INFO - PROCESS | 1673 | Values: 154.0 119.0 143.0 162.0 119.0 138.0 117.0 149.0 152.0 117.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:196.10 Median:186.00 stddev:24.38 (13.1%) stddev-sans-first:25.40 14:35:17 INFO - PROCESS | 1673 | Values: 183.0 186.0 186.0 182.0 184.0 195.0 260.0 214.0 185.0 186.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:89.00 Median:64.50 stddev:43.06 (66.8%) stddev-sans-first:45.06 14:35:17 INFO - PROCESS | 1673 | Values: 69.0 82.0 96.0 189.0 82.0 55.0 60.0 60.0 138.0 59.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:23.69 (30.0%) stddev-sans-first:24.95 14:35:17 INFO - PROCESS | 1673 | Values: 88.0 88.0 143.0 79.0 79.0 80.0 121.0 79.0 79.0 122.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:84.70 Median:86.00 stddev:1.70 (2.0%) stddev-sans-first:1.74 14:35:17 INFO - PROCESS | 1673 | Values: 86.0 84.0 87.0 84.0 86.0 83.0 86.0 83.0 86.0 82.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:92.00 stddev:18.33 (19.9%) stddev-sans-first:19.28 14:35:17 INFO - PROCESS | 1673 | Values: 92.0 92.0 92.0 92.0 92.0 103.0 150.0 92.0 91.0 92.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:89.00 Median:83.00 stddev:16.73 (20.2%) stddev-sans-first:17.68 14:35:17 INFO - PROCESS | 1673 | Values: 85.0 83.0 86.0 85.0 83.0 83.0 83.0 102.0 131.0 69.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:60.00 stddev:18.51 (30.8%) stddev-sans-first:18.81 14:35:17 INFO - PROCESS | 1673 | Values: 57.0 61.0 58.0 59.0 87.0 92.0 91.0 102.0 58.0 55.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:68.00 stddev:5.08 (7.5%) stddev-sans-first:4.83 14:35:17 INFO - PROCESS | 1673 | Values: 60.0 62.0 60.0 74.0 70.0 71.0 72.0 66.0 64.0 65.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:1.58 (2.0%) stddev-sans-first:1.41 14:35:17 INFO - PROCESS | 1673 | Values: 77.0 79.0 80.0 79.0 80.0 78.0 79.0 79.0 80.0 83.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:143.50 stddev:12.40 (8.6%) stddev-sans-first:12.47 14:35:17 INFO - PROCESS | 1673 | Values: 130.0 144.0 144.0 133.0 125.0 142.0 131.0 143.0 153.0 167.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:165.00 stddev:17.40 (10.5%) stddev-sans-first:18.32 14:35:17 INFO - PROCESS | 1673 | Values: 163.0 163.0 169.0 164.0 163.0 162.0 154.0 167.0 166.0 217.0 14:35:17 INFO - PROCESS | 1673 | 14:35:17 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:77.50 stddev:12.53 (16.2%) stddev-sans-first:12.84 14:35:17 INFO - PROCESS | 1673 | Values: 69.0 71.0 94.0 93.0 82.0 66.0 65.0 71.0 73.0 98.0 14:35:17 INFO - PROCESS | 1673 | -------- Summary: end -------- 14:35:17 INFO - PROCESS | 1673 | 14:35:18 INFO - TEST-INFO | 1673: exit 0 14:35:18 INFO - TEST-OK | kraken | took 58393ms 14:35:18 INFO - SUITE-END | took 1171s 14:35:18 INFO - Completed test suite (00:19:31) 14:35:18 INFO - javascript benchmark 14:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3505.3164632896587, 3548.893533194002, 3559.822008899556, 3566.6076731559533, 3643.617420170882, 5130.179171332587, 5780.797672081478, 5788.594798364116, 5800.158976948345, 5832.883342333156, 5762.798302059428, 5809.0, 5815.185873977646, 5823.592348535604, 5835.299764028312, 5247.580193584514, 5273.367195936493, 5301.5228629423345, 5310.8141215057485, 5433.945660543383, 5353.812616558421, 5401.189821526763, 5406.972675191721, 5418.106012507931, 5428.5928555358305, 5343.7060961647285, 5404.513593776559, 5410.675359478424, 5437.864053398677, 5447.1829225616075, 5411.810586629469, 5422.376426710939, 5448.0, 5466.863328416782, 5481.397046324901, 5171.301874246966, 5238.5023422774775, 5332.760025798849, 5335.813246536352, 5371.0, 4607.792649330788, 5703.629264097862, 5726.513246374022, 5726.82819515411, 5757.8560535986935, 6272.435480806704, 6291.1192433059405, 6301.968490157566, 6314.71583778731, 6337.207849018872, 6190.380961903818, 6198.0702894566175, 6205.87588248237, 6262.279837818618, 6267.0, 5915.792947246826, 5951.880962380728, 5967.433093856077, 5968.522518198533, 5996.730147143346, 6318.052292156213, 6320.905186422207, 6326.0, 6347.777827776005, 6360.618362898241, 6066.848328791815, 6098.535552314561, 6271.278802937721, 6288.622682639057, 6293.748250070037, 6280.905786413207, 6284.874302513924, 6305.5901366411035, 6306.180196574416, 6316.30520642729, 6225.875482490324, 6286.52851036165, 6290.937090629035, 6301.96849015752, 6314.9684251579365, 6183.288921774054, 6266.248050234001, 6294.559380843389, 6301.40136687014, 6322.620642761449, 4956.950430495649, 4987.102321582078, 4993.825216117419, 5001.324821149171, 5002.0, 4523.163214805271, 4532.252178390529, 4544.863654090383, 4627.8611641650805, 4645.279981602857, 5769.711514424262, 5794.130880367894, 5804.042333015005, 5812.651240925558, 5865.413458654186, 6189.0, 6196.0, 6212.347703491158, 6222.000249719066, 6259.499240060784, 5837.737301821428, 5851.970740146272, 5871.6183448075735, 5879.118132280107, 5886.440788125121, 5477.342718873681, 5483.588730845203, 5486.890262194814, 5489.34127904646, 5509.972450137804, 6250.218722659577, 6346.238451385863, 6348.682565871595, 6462.353764623594, 6492.837679058061, 6144.0, 6261.311255761953, 6265.27949285838, 6305.0, 6310.873782524232, 6442.581232219891, 6467.159269294962, 6474.546781725234, 6475.838104047437, 6507.707153178024, 6280.309165991828, 6286.937130628635, 6289.182406287154, 6305.054241863757, 6307.432331090224, 6167.907481387872, 6181.072839074175, 6184.783532576338, 6267.0, 6277.591956522811, 6167.814965551041, 6215.906761398673, 6216.627002379872, 6223.190985171898, 6237.4698150657705, 6151.0, 6175.907361389673, 6194.38056194395, 6216.347283535164, 6243.656598887105, 5847.649141051551, 6016.368281330398, 6024.0, 6100.054491553817, 6129.141920131096, 6172.382761723792, 6182.876342473215, 6192.349803270772, 6193.040078787795, 6218.5647004711045, 6008.969955150196, 6088.847778805388, 6113.938860611337, 6116.5718399711595, 6126.0], "value": 5798.459136907794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7695168029427, 567.4807551090752, 568.7582777319639, 587.3533988689417, 590.0, 31700.048998530052, 32380.83809580952, 39320.41019384708, 39680.0, 39818.40272395917, 41907.37138942918, 42502.574974250245, 42563.57436425635, 42623.93440163998, 42883.0, 8280.337572994145, 8949.239314658262, 9238.260939124888, 9617.759556011086, 9843.310968232227, 9674.790651168603, 11147.773744888056, 11695.0, 12224.327661978588, 12235.69410764729, 11832.94083529581, 11921.0, 11924.821127683092, 11927.70180745484, 11944.64166075019, 11812.940935295312, 11958.521659133625, 11961.999999999956, 11972.042236621137, 11999.700007499796, 11658.825117623242, 11761.58834440799, 11772.175947683665, 11808.173427860052, 11811.350375729331, 36901.07747306312, 41864.95337616553, 42225.94435139146, 42239.15521689549, 42293.57706422927, 3314.850831712579, 3415.846286917095, 3450.258194488172, 3520.2079532105327, 3922.7646341219333, 22561.0, 27122.18633441, 28290.00984965537, 28354.86580536776, 29391.0, 2736.1602352660543, 2762.737539933703, 2767.252841732741, 2776.0, 2826.1662809471254, 330171.0, 331369.0, 332177.0, 332317.0, 333125.0, 28978.7102128976, 38151.236975260894, 65374.019389709196, 65448.345516545174, 66099.66950165314, 36370.45444318337, 36819.81590092086, 36823.815880920956, 36850.0, 36885.26229475396, 16597.91701041487, 16713.49859504217, 16767.413140540266, 16793.496195114167, 16858.662826743395, 12853.0, 12951.805722914163, 13898.0, 13947.0, 13956.930215348859, 7669.424793140537, 8004.359651227888, 8428.620712067848, 8484.915150848412, 8567.828643427096, 3120.937581248362, 3251.64231934487, 3562.340966921076, 3596.8741094062107, 3653.0, 986.6102889358663, 1054.7415883108688, 1119.9720006999728, 1141.3779490177874, 1142.7200335917587, 30406.783728651048, 30997.69002309993, 31138.532922006187, 31727.52408713871, 31829.0, 1128.2414496555841, 1135.267752299762, 1164.2257898497573, 1181.9054475641929, 1324.0533018891538, 15729.606759831096, 15791.921040394724, 15810.525684229491, 16018.439354622533, 16066.116363600115, 621227.0, 622280.0, 629143.0, 629625.0, 630839.0, 62616.747665047355, 63419.4145146375, 63447.0, 63525.36474635287, 63607.0, 1423.8860891128684, 1586.9285882135332, 1591.6259678975664, 1594.760785882127, 1603.7674537192042, 27110.457790843677, 30192.24519387033, 30553.54169687501, 31654.683453165173, 32363.19092022718, 54045.72977135089, 54394.456055440525, 55023.17465237944, 55044.69731816104, 55117.0, 368643.0, 564445.0, 579325.0, 579843.0, 580561.0, 44333.33499997438, 44978.0, 45819.3127103087, 45836.54163458456, 46800.0, 45768.313475298564, 45956.310655340865, 46514.534854652375, 47313.0, 47362.763186183845, 32246.677533224367, 36705.63294367129, 38537.8438646841, 39195.80402097971, 39221.60778392294, 39361.80319098386, 39766.403503948044, 40143.799281003405, 40187.598124019554, 41094.0, 35914.820425897706, 38952.6104738949, 40114.39828402518, 40337.39493907653, 40357.39463908102, 28451.857740711162, 33598.328033439684, 34189.97430077101, 34965.47551786674, 34968.65031349756, 26107.08625198109, 26258.606120908586, 26316.416606261697, 26401.20796376035, 26821.731782682706], "value": 19487.006251965246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.29497559173814, 412.46173743265064, 419.5678451195269, 420.0611633000246, 423.60816244973404, 20492.487687807792, 20512.897435512838, 21215.151393944245, 21260.936953152337, 21927.67108493374, 21218.89390553049, 22077.889610551923, 22754.431139221528, 22940.8852955735, 22976.08095676175, 5849.385814489481, 6164.445199932005, 6165.475934545569, 6178.814635560918, 6188.876222475547, 5860.384659610722, 6029.186059881926, 6187.876242475148, 6188.628682279078, 6191.597546159508, 6085.695715214244, 6113.991191453405, 6115.724792384353, 6141.631502109888, 6146.0, 5002.52476014778, 5816.360200377955, 6108.786192483264, 6115.847103822395, 6115.938840611604, 5256.2904007959205, 5280.049591073605, 5295.655782374133, 5300.072487314743, 5304.389995150568, 26450.73549264502, 27021.864890675617, 27258.5911211332, 27583.724162758317, 27649.308767280778, 2205.9558808823895, 2375.6792832967676, 2433.914812981555, 2465.408302007523, 2891.551809469536, 15282.847171528254, 15644.374225031099, 15767.526974190792, 16086.115263660495, 16458.259378328003, 1792.4981005318532, 1828.2961059991999, 1931.2564662604857, 1998.5503261766132, 2115.3019503563787, 101354.49322753413, 119013.80986190114, 120418.0, 123433.14850277253, 138571.0, 11684.591039313584, 11779.175457717878, 12054.879451205552, 12070.456829442695, 12076.335801531, 14366.56900292993, 15807.841921580637, 15807.920960395124, 15809.209539522977, 15823.287952042187, 8587.0, 8920.598573064228, 9204.539773011322, 9328.626854925862, 9407.670731524364, 9282.814343713088, 9286.489243091559, 9288.489133097744, 9290.535473226311, 9349.39228950116, 4786.2581299898575, 4835.927461088087, 4840.7337596432535, 4851.34506841579, 4887.73117478535, 2029.0970518119295, 2078.9792102079086, 2079.396974877269, 2120.5758848230416, 2136.658134698441, 935.9812803743887, 963.3978763272954, 980.9754756131153, 1040.4173662748885, 1044.1125043712784, 18725.90637046806, 20583.324167858384, 20798.1680732769, 20954.0, 21024.0, 1035.53400969564, 1038.683201623512, 1041.9322744021615, 1068.8289873620183, 1092.2408925796494, 10799.190060745475, 11281.887181128084, 11285.153613479022, 11328.263662861887, 11371.317720936604, 657609.7119514372, 659051.0, 662695.0, 669655.0, 675104.0, 74055.62972185104, 108142.0, 108991.0, 127008.0, 132533.0, 1044.4516628769957, 1049.4228174504144, 1059.9417032063157, 1070.8875568065396, 1071.4963966935527, 18262.788445216265, 18433.539161520534, 18879.528011799266, 19087.236510539424, 19087.759295645737, 33864.49203261904, 34093.0, 44172.779136104116, 53080.46919530755, 53748.73125634503, 76851.2314876844, 79640.60179699064, 82035.0, 82224.0, 83583.58208209163, 8194.877076843972, 8225.383096267684, 8312.21034001769, 8351.624176911931, 8877.067907869581, 11590.13074019435, 13058.34708264602, 13252.337383130998, 13377.331133443095, 13432.0, 11293.491792869505, 11505.252158609663, 11583.364824280663, 11610.76778464443, 11690.76618467609, 11032.155617308392, 11318.773624527299, 11325.754167041783, 11754.76490470203, 11925.224860384047, 11570.016548593463, 11747.236429632047, 11888.881111188777, 12081.214721043105, 12185.268883866642, 7944.205579442009, 8253.79365515867, 8296.917030829614, 8439.367047471342, 8835.939687237573, 8305.916940830515, 9454.243660507005, 11104.0, 11139.05318047975, 11249.493772780408], "value": 9997.585194674424, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.4769178479314, 1664.7835781348424, 1694.9914800693587, 2038.4903774056486, 2097.8636388634736, 8253.876191857127, 8948.06045365237, 9109.68116115936, 9123.635054597817, 9140.497272650002, 8850.336224783136, 8913.0, 8994.640214391417, 8997.415168014075, 9009.189172974431, 2457.103157347573, 2565.9358516037064, 2568.1011645923963, 2568.7045989711237, 2572.588385858263, 2491.4145175883655, 2560.2703229579574, 2563.333533281351, 2563.4104156044123, 2563.461673048662, 2523.1547431610434, 2550.3496608364935, 2565.8588777617224, 2566.217303722364, 2569.5374832530138, 2520.621906713989, 2533.860637664937, 2552.540542702313, 2555.7987745759465, 2567.281161274846, 2499.700035995674, 2540.2379286214245, 2555.3356127406823, 2555.9488810223693, 2556.169244995384, 8832.735017949408, 9170.587323570455, 9222.723318300461, 9229.169374756237, 9230.492322922237, 5541.307336582927, 5666.263385759866, 5683.630564013326, 5742.569307301927, 5769.3076830780155, 3578.946315805265, 3602.513660655804, 3667.688246499051, 3745.3632882410056, 3754.624537546251, 1037.1184493180735, 1067.7437415020418, 1067.7597540553313, 1072.5441687282873, 1077.0, 12277.140600157993, 12372.319522426264, 12443.25340479565, 12456.75086498274, 12467.376631168405, 4686.390769199982, 4689.7655117244, 4800.639952003544, 4842.322074909515, 4846.418429788448, 9843.507824608741, 9850.0, 9856.901430985741, 9861.161801246973, 9884.654037108667, 5559.416261292506, 5586.385497595261, 5595.328560572757, 5595.63628364155, 5615.0, 4615.815367385267, 4783.736894470768, 5054.115529782273, 5068.910184310391, 5190.377154741455, 4013.678905687538, 4014.8594799181888, 4100.138970816102, 4106.1582375612925, 4136.503619565671, 1239.857416397126, 1251.2867665430617, 1251.9061070419755, 1258.7608354412632, 1263.4503990764047, 963.8939716631165, 982.2780256511459, 999.550202408919, 1004.864343313658, 1023.3757407981126, 5283.6037297202865, 6078.240219972504, 6146.262448506208, 6383.202099737533, 6396.200474940632, 960.1214888377057, 987.3582171588381, 1007.4940450438389, 1028.1517747858047, 1035.0787798859021, 4118.691098167589, 4133.42132101506, 4134.338505839051, 4160.4591403118, 4220.2192594370135, 10993.780124397626, 11438.59964901241, 11487.942560287145, 11489.42552872353, 11492.138089643144, 10377.636782712569, 10848.511816968256, 11224.382658953673, 11227.0, 11264.43677816106, 8601.870971935426, 8635.0, 8656.09111043344, 8691.043985161627, 8734.475931444134, 5862.94137058624, 6037.305709843425, 6129.969350153221, 6207.255129384503, 6213.565050446426, 9686.0, 9747.171490423394, 9794.951025244829, 9950.601975920883, 9950.701478955643, 9863.654772082942, 10473.423961682181, 10493.842592361274, 10648.680539583826, 10655.041046305869, 6268.717907694256, 7233.1681856587165, 7356.301151390609, 8021.077576078826, 8097.473664211808, 8555.230029297392, 8585.270252028648, 8636.438631488933, 8656.91343086561, 8826.691065812665, 7546.849063018819, 7639.694412223671, 7705.113911899979, 7713.460057796125, 7779.494332868572, 7437.107547094167, 7495.850082998419, 7529.8117547061765, 7633.931249625168, 7641.2740789624895, 7125.429965602636, 7165.713371465083, 7169.211386747558, 7199.748008819666, 7202.603856787927, 4961.652684312208, 4973.35346404965, 5088.389393272683, 5142.100132476877, 5174.7930082796265, 5068.746562671926, 5092.719900405513, 5116.258142569381, 5207.270982062439, 5333.333333333333], "value": 4788.079558906365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.17892321887234, 341.79833898000174, 347.483235676273, 350.7895262842295, 353.7594435783669, 6857.451403887683, 6925.757598484054, 6943.861122777542, 6949.548279361844, 6954.79135625932, 6835.726570937169, 6883.8623227535545, 6884.862302753954, 6905.930940690591, 6919.065926099975, 4865.44047434546, 4952.678075925071, 4978.377702787152, 5102.285680004802, 5156.3296771419855, 5055.292259083732, 5114.130597798383, 5122.462141475147, 5126.461721519243, 5150.459201783815, 5045.369328833895, 5063.569596584295, 5072.873178170538, 5088.771005304751, 5088.7964481420695, 3893.8831835044994, 4954.20732682769, 5077.441481437039, 5100.209467532539, 5103.5151660592555, 4377.9781101094295, 4381.145676593065, 4382.605565499089, 4391.582799634061, 4401.64786817057, 6595.967020164869, 6598.47212223021, 6598.670066496656, 6600.966995165041, 6623.867522649568, 5982.132590774313, 5996.950533656636, 6003.249593800775, 6003.8198854034445, 6005.309389420186, 7007.264237255065, 7222.638868056576, 7258.745943891991, 7269.236730143311, 7270.418366530665, 4860.343853579757, 4892.755362231874, 4910.607151427913, 4913.680610760289, 4916.655834091615, 7668.118166410878, 7675.846483070363, 7719.112302085276, 7723.0, 7724.691012359499, 4167.916341751166, 4952.257161425815, 4971.850844474671, 4976.90046199074, 4977.875553111201, 4262.254105531581, 5058.797648094109, 5061.4179369373, 5063.544281014726, 5067.5185857343495, 4884.853454396374, 5215.59179021662, 5827.215489744956, 5935.1987481690285, 6011.639301641915, 6606.405423511907, 6789.558678685869, 7256.528325658815, 7313.634318284065, 7316.743913963092, 1742.4511278947346, 1771.706654142483, 1773.361589827661, 1777.8844375115575, 1781.15395187285, 1068.1561566362486, 1077.6605369308643, 1118.116687816632, 1123.9662810115547, 1152.7924973504682, 6862.416694580917, 6977.616231107338, 6990.6155161465595, 7000.334968178015, 7070.505064645426, 6175.320714721377, 6180.690965451709, 7681.846363072707, 7692.115406728298, 7713.074431068308, 6989.4408447324095, 6990.930090699129, 6992.6853291602, 6995.0, 6996.0, 3898.4737060497037, 4021.738586991836, 4059.939100913489, 4064.878053658395, 4073.837046518165, 7978.920210797934, 7988.80027999293, 7989.7203597873795, 7991.160928102466, 8037.115917249098, 7911.327537159291, 7913.406494512935, 7921.009873765779, 7925.28672419485, 7930.167332430012, 8014.398920081017, 8033.5983200838555, 8042.718504852419, 8050.476719013245, 8065.1934806518875, 7453.153710854958, 7571.053618297713, 7659.119201291923, 7686.000819893378, 7687.11598166218, 7473.588952607659, 7521.285477879593, 7527.473076884566, 7531.284527969834, 7546.584937828253, 6454.709538070704, 7999.4400391972, 8033.879491807745, 8044.1955804419085, 8051.51690898548, 4791.377120974251, 4836.564709176191, 4842.104210721028, 4844.128056949642, 4855.053264613366, 7390.482666213528, 7616.581088040211, 7636.885446718415, 7650.540967541742, 7651.387888968758, 7339.889901651372, 7364.374028207662, 7402.29678180572, 7410.703571857065, 7436.442266829901, 6000.339962604197, 7402.1117465904435, 7406.518576292524, 7407.59258240802, 7416.96162537256, 7012.123484564429, 7220.675069621774, 7238.493305468567, 7241.203467618452, 7257.709691612276, 7329.450291228286, 7407.92592074094, 7413.962930185315, 7431.108267007994, 7463.888041679271, 6950.165980082423, 7066.57600543969, 7109.786706398816, 7113.502054856317, 7127.216006239413], "value": 5379.20693161417, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.889297712366, 694.84366017646, 707.0, 710.0378986473326, 723.913130424349, 15467.149306788122, 15651.217439128055, 15686.21568921555, 15690.607734806636, 15738.685226295482, 13542.593722188325, 14461.276936153177, 14506.419743210285, 14515.782263266034, 14551.854481455182, 971.6599190283397, 998.3859926145404, 999.2056315229373, 999.7650552120245, 1001.7796084861319, 981.8527220916848, 991.2912267728573, 997.4364484066515, 997.5710444508858, 997.7405874472653, 837.0415873824468, 965.034965034965, 968.7917097823967, 1025.3847691385147, 1041.0890470838017, 1034.0331789776546, 1036.1710631494811, 1036.9066783989401, 1037.0044757033181, 1040.8594839696657, 771.8842173673937, 772.2277722277722, 772.9497582657109, 773.1958762886591, 774.4385320642546, 15239.161846098461, 15277.00699454532, 15283.541493755205, 15317.923410382988, 15341.156236406992, 12791.872081279162, 13152.40814163365, 13285.3357332133, 13339.266340351276, 13379.0, 8731.388802783807, 9360.4383736976, 10135.573916257877, 10694.625688100958, 10703.197260205516, 3480.1821571930577, 3532.7703699259464, 3588.659077387644, 3654.543182102237, 3811.6569508744346, 82592.76110858342, 87639.56180219122, 88307.0, 89616.0, 92072.53963730205, 9853.655122070693, 9890.456024918554, 9924.60301587943, 9978.700638980843, 10151.695449136538, 23307.0, 23386.532269354517, 23400.297991060295, 23411.531769364516, 23414.18050368263, 7514.812129696692, 7623.237676232443, 7722.189170137055, 7793.2596403341595, 7917.406194535433, 4175.68682348825, 4267.381229721673, 4290.871273861727, 4335.1979883721615, 4392.802323895432, 3669.1377526281303, 3717.628237176261, 3721.5720192177705, 3722.553293604785, 3726.1616136369644, 647.5531883000808, 659.0147729144959, 662.4998126414526, 673.39394544909, 683.2859661653584, 566.4392251670898, 597.7190720361423, 600.1927407636722, 613.227333559718, 629.4115002472611, 8263.628136733862, 8298.917010829935, 8451.915480845113, 8472.534010629475, 8573.0, 526.5129754976631, 599.9700014999232, 615.4860691322706, 616.1558664629487, 631.3150231998334, 3795.35478968576, 3809.923801523954, 3947.5262968443394, 3971.4837071180564, 4054.2296963576828, 70261.64869175621, 86502.26995460056, 89885.10114898767, 90074.28817476863, 90858.0, 65689.67155164194, 81735.0, 82601.0, 85189.57405213059, 86220.0, 74683.0, 75258.24741752731, 75338.62330688312, 75552.4889502207, 76650.0, 6675.499337549801, 7852.900593916742, 8020.598970051357, 8054.0, 8081.4342995992065, 44532.44136455208, 45632.77183614061, 50796.49203507917, 50894.236586451974, 51636.48363516467, 55257.78968841201, 66276.04101569459, 69555.30444695488, 73890.52218955483, 74359.62820185865, 9982.550785214828, 10019.348742331726, 10449.21630877672, 10546.525406356579, 10646.520906559379, 11059.889401105886, 11377.43112844371, 11490.827637585277, 11496.540138394705, 11994.64016079519, 10685.465726713788, 10719.464026798785, 10790.62232821879, 11005.229633925548, 11031.172662050218, 10859.565617375216, 10869.67390978272, 11074.390908499787, 11113.22207445471, 11132.554697811996, 10531.21015923824, 10563.735906602396, 10580.788384232426, 10640.733981650521, 10886.727831804268, 9085.0, 9276.304277179104, 9301.26659968199, 9423.340366174301, 9609.951950240204, 9079.818403632022, 9203.309751768511, 9206.309526785652, 9225.86161207569, 9273.072692730942], "value": 7024.634740448371, "unit": "score"}], "name": "dromaeo_css", "value": 7675.059672355868, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 116.0, 112.0, 109.0, 112.0, 111.0, 111.0, 112.0, 133.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 143.0, 162.0, 119.0, 138.0, 117.0, 149.0, 152.0, 117.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 186.0, 182.0, 184.0, 195.0, 260.0, 214.0, 185.0, 186.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 96.0, 189.0, 82.0, 55.0, 60.0, 60.0, 138.0, 59.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 143.0, 79.0, 79.0, 80.0, 121.0, 79.0, 79.0, 122.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 86.0, 83.0, 86.0, 83.0, 86.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 103.0, 150.0, 92.0, 91.0, 92.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 85.0, 83.0, 83.0, 83.0, 102.0, 131.0, 69.0], "value": 89.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 58.0, 59.0, 87.0, 92.0, 91.0, 102.0, 58.0, 55.0], "value": 72.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 74.0, 70.0, 71.0, 72.0, 66.0, 64.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 80.0, 79.0, 80.0, 78.0, 79.0, 79.0, 80.0, 83.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 144.0, 144.0, 133.0, 125.0, 142.0, 131.0, 143.0, 153.0, 167.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 169.0, 164.0, 163.0, 162.0, 154.0, 167.0, 166.0, 217.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 94.0, 93.0, 82.0, 66.0, 65.0, 71.0, 73.0, 98.0], "value": 78.2, "unit": "score"}], "name": "kraken", "value": 1510.2, "alertThreshold": 2.0}]} 14:35:18 INFO - Return code: 0 14:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:18 ERROR - # TBPL SUCCESS # 14:35:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:18 INFO - 2016-06-30 14:35:18.816 screenresolution[1677:9770] starting screenresolution argv=screenresolution get 14:35:18 INFO - 2016-06-30 14:35:18.819 screenresolution[1677:9770] Display 0: 1600x1200x32@60 14:35:18 INFO - 2016-06-30 14:35:18.825 screenresolution[1678:9772] starting screenresolution argv=screenresolution list 14:35:18 INFO - Available Modes on Display 0 14:35:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:19 INFO - Intel Iris: 14:35:19 INFO - Chipset Model: Intel Iris 14:35:19 INFO - Type: GPU 14:35:19 INFO - Bus: Built-In 14:35:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:19 INFO - Vendor: Intel (0x8086) 14:35:19 INFO - Device ID: 0x0a2e 14:35:19 INFO - Revision ID: 0x0009 14:35:19 INFO - Displays: 14:35:19 INFO - Display: 14:35:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:19 INFO - Display Serial Number: 1600x1200 60 14:35:19 INFO - Main Display: Yes 14:35:19 INFO - Mirror: Off 14:35:19 INFO - Online: Yes 14:35:19 INFO - Rotation: Supported 14:35:19 INFO - Return code: 0 14:35:19 INFO - Running post-action listener: _resource_record_post_action 14:35:19 INFO - Running post-run listener: _resource_record_post_run 14:35:20 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 38139392; Write bytes: 494072320; Read time: 434; Write time: 1664 14:35:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189211136; Write bytes: 186955264; Read time: 17243; Write time: 417 14:35:20 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 36357632; Write bytes: 296328192; Read time: 415; Write time: 1214 14:35:20 INFO - Running post-run listener: _upload_blobber_files 14:35:20 INFO - Blob upload gear active. 14:35:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:20 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 14:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:35:20 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:21 INFO - (blobuploader) - INFO - Done attempting. 14:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:22 INFO - (blobuploader) - INFO - Done attempting. 14:35:22 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:22 INFO - Return code: 0 14:35:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ccce25ea2635c8a51c7296b1348ffcba55fa4851cb726b04944c3e24380dc262b0c50b0b80bd70bc8678532a9617821b32bd3cd85ef94c8b94c303559aad6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1464bb30699f638f410d3471cf44f74c41bcb6c11b6ecd6669115ce90d0e5961117358382181bdf6ac8a7ec8475a168d2062be516d6298b37a7c042d5101370c"} 14:35:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:22 INFO - Contents: 14:35:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ccce25ea2635c8a51c7296b1348ffcba55fa4851cb726b04944c3e24380dc262b0c50b0b80bd70bc8678532a9617821b32bd3cd85ef94c8b94c303559aad6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1464bb30699f638f410d3471cf44f74c41bcb6c11b6ecd6669115ce90d0e5961117358382181bdf6ac8a7ec8475a168d2062be516d6298b37a7c042d5101370c"} 14:35:22 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:22 INFO - Copying logs to upload dir... 14:35:22 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.148756 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-30 14:35:22.197052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:22.200511) ========= 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.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ccce25ea2635c8a51c7296b1348ffcba55fa4851cb726b04944c3e24380dc262b0c50b0b80bd70bc8678532a9617821b32bd3cd85ef94c8b94c303559aad6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1464bb30699f638f410d3471cf44f74c41bcb6c11b6ecd6669115ce90d0e5961117358382181bdf6ac8a7ec8475a168d2062be516d6298b37a7c042d5101370c"} build_url:https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/WyC-sJnWRVeeg6_lEneDYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ccce25ea2635c8a51c7296b1348ffcba55fa4851cb726b04944c3e24380dc262b0c50b0b80bd70bc8678532a9617821b32bd3cd85ef94c8b94c303559aad6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1464bb30699f638f410d3471cf44f74c41bcb6c11b6ecd6669115ce90d0e5961117358382181bdf6ac8a7ec8475a168d2062be516d6298b37a7c042d5101370c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:22.236401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:22.236994) ========= 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.1GvhUTNdX1/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.PH9javeCqG/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005140 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 14:35:22.287947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 14:35:22.288629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 14:35:22.289269) ========= ========= Total master_lag: 0.19 =========