From 2df70ce95f2a6840b7a70fde38c25c72132924e1 Mon Sep 17 00:00:00 2001 From: chrislu Date: Thu, 21 Sep 2023 23:51:32 -0700 Subject: [PATCH] adjust logs --- weed/util/lock_table.go | 36 +++++++++++++++++++++--------------- weed/util/lock_table_test.go | 5 +++-- 2 files changed, 24 insertions(+), 17 deletions(-) diff --git a/weed/util/lock_table.go b/weed/util/lock_table.go index 1a4f029f8..d10b51334 100644 --- a/weed/util/lock_table.go +++ b/weed/util/lock_table.go @@ -64,12 +64,14 @@ func (lt *LockTable[T]) AcquireLock(intention string, key T, lockType LockType) // If the lock is held exclusively, wait entry.mu.Lock() if len(entry.waiters) > 0 || lockType == ExclusiveLock { - glog.V(4).Infof("ActiveLock %d %s wait for %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, lockType, len(entry.waiters), entry.activeLockOwnerCount) - if glog.V(4) && len(entry.waiters) > 0 { - for _, waiter := range entry.waiters { - fmt.Printf(" %d", waiter.ID) + if glog.V(4) { + fmt.Printf("ActiveLock %d %s wait for %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, lockType, len(entry.waiters), entry.activeLockOwnerCount) + if len(entry.waiters) > 0 { + for _, waiter := range entry.waiters { + fmt.Printf(" %d", waiter.ID) + } + fmt.Printf("\n") } - fmt.Printf("\n") } entry.waiters = append(entry.waiters, lock) if lockType == ExclusiveLock { @@ -91,12 +93,14 @@ func (lt *LockTable[T]) AcquireLock(intention string, key T, lockType LockType) // Otherwise, grant the lock entry.lockType = lockType - glog.V(4).Infof("ActiveLock %d %s locked %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, lockType, len(entry.waiters), entry.activeLockOwnerCount) - if glog.V(4) && len(entry.waiters) > 0 { - for _, waiter := range entry.waiters { - fmt.Printf(" %d", waiter.ID) + if glog.V(4) { + fmt.Printf("ActiveLock %d %s locked %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, lockType, len(entry.waiters), entry.activeLockOwnerCount) + if len(entry.waiters) > 0 { + for _, waiter := range entry.waiters { + fmt.Printf(" %d", waiter.ID) + } + fmt.Printf("\n") } - fmt.Printf("\n") } entry.mu.Unlock() @@ -129,12 +133,14 @@ func (lt *LockTable[T]) ReleaseLock(key T, lock *ActiveLock) { delete(lt.locks, key) } - glog.V(4).Infof("ActiveLock %d %s unlocked %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, entry.lockType, len(entry.waiters), entry.activeLockOwnerCount) - if len(entry.waiters) > 0 { - for _, waiter := range entry.waiters { - fmt.Printf(" %d", waiter.ID) + if glog.V(4) { + fmt.Printf("ActiveLock %d %s unlocked %+v type=%v with waiters %d active %d.\n", lock.ID, lock.intention, key, entry.lockType, len(entry.waiters), entry.activeLockOwnerCount) + if len(entry.waiters) > 0 { + for _, waiter := range entry.waiters { + fmt.Printf(" %d", waiter.ID) + } + fmt.Printf("\n") } - fmt.Printf("\n") } entry.activeLockOwnerCount-- diff --git a/weed/util/lock_table_test.go b/weed/util/lock_table_test.go index 272e5672f..001fa0bdf 100644 --- a/weed/util/lock_table_test.go +++ b/weed/util/lock_table_test.go @@ -1,6 +1,7 @@ package util import ( + "fmt" "math/rand" "sync" "testing" @@ -26,14 +27,14 @@ func TestOrderedLock(t *testing.T) { lock := lt.AcquireLock("", key, lockType) // Lock acquired, perform some work - glog.V(4).Infof("ActiveLock %d acquired the lock.\n", lock.ID) + fmt.Printf("ActiveLock %d acquired lock %v\n", lock.ID, lockType) // Simulate some work time.Sleep(time.Duration(rand.Int31n(10)*10) * time.Millisecond) // Release the lock lt.ReleaseLock(key, lock) - glog.V(4).Infof("ActiveLock %d released the lock.\n", lock.ID) + fmt.Printf("ActiveLock %d released lock %v\n", lock.ID, lockType) }(i) }