/* * Copyright (C) 2022 The Android Open Source Project * * Licensed under the Apache License, Version 2.0 (the "License"); * you may not use this file except in compliance with the License. * You may obtain a copy of the License at * * http://www.apache.org/licenses/LICENSE-2.0 * * Unless required by applicable law or agreed to in writing, software * distributed under the License is distributed on an "AS IS" BASIS, * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. * See the License for the specific language governing permissions and * limitations under the License. */ package com.android.server.utils; import static android.os.Trace.TRACE_TAG_APP; import static com.android.dx.mockito.inline.extended.ExtendedMockito.mockitoSession; import static com.android.dx.mockito.inline.extended.ExtendedMockito.verify; import static com.google.common.truth.Truth.assertThat; import static org.mockito.Matchers.anyString; import static org.mockito.Matchers.contains; import static org.mockito.Matchers.eq; import static org.mockito.Matchers.matches; import static org.mockito.Mockito.never; import static org.mockito.Mockito.times; import android.os.Trace; import android.util.Slog; import androidx.test.filters.SmallTest; import androidx.test.runner.AndroidJUnit4; import com.android.dx.mockito.inline.extended.MockedVoidMethod; import org.junit.After; import org.junit.Before; import org.junit.Test; import org.junit.runner.RunWith; import org.mockito.MockitoSession; import java.util.ArrayList; import java.util.List; /** * Tests for {@link TimingsTraceAndSlog}. * *

Usage: {@code atest FrameworksMockingServicesTests:TimingsTraceAndSlogTest} */ @SmallTest @RunWith(AndroidJUnit4.class) public class TimingsTraceAndSlogTest { private static final String TAG = "TEST"; private MockitoSession mSession; @Before public final void startMockSession() { mSession = mockitoSession() .spyStatic(Slog.class) .spyStatic(Trace.class) .startMocking(); } @After public final void finishMockSession() { mSession.finishMocking(); } @Test public void testDifferentThreads() throws Exception { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); // Should be able to log on the same thread log.traceBegin("test"); log.traceEnd(); final List errors = new ArrayList<>(); // Calling from a different thread should fail Thread t = new Thread(() -> { try { log.traceBegin("test"); errors.add("traceBegin should fail on a different thread"); } catch (IllegalStateException expected) { } try { log.traceEnd(); errors.add("traceEnd should fail on a different thread"); } catch (IllegalStateException expected) { } // Verify that creating a new log will work TimingsTraceAndSlog log2 = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); log2.traceBegin("test"); log2.traceEnd(); }); t.start(); t.join(); assertThat(errors).isEmpty(); } @Test public void testGetUnfinishedTracesForDebug() { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); assertThat(log.getUnfinishedTracesForDebug()).isEmpty(); log.traceBegin("One"); assertThat(log.getUnfinishedTracesForDebug()).containsExactly("One").inOrder(); log.traceBegin("Two"); assertThat(log.getUnfinishedTracesForDebug()).containsExactly("One", "Two").inOrder(); log.traceEnd(); assertThat(log.getUnfinishedTracesForDebug()).containsExactly("One").inOrder(); log.traceEnd(); assertThat(log.getUnfinishedTracesForDebug()).isEmpty(); } @Test public void testLogDuration() throws Exception { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); log.logDuration("logro", 42); verify((MockedVoidMethod) () -> Slog.v(eq(TAG), contains("logro took to complete: 42ms"))); } @Test public void testOneLevel() throws Exception { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); log.traceBegin("test"); log.traceEnd(); verify((MockedVoidMethod) () -> Trace.traceBegin(TRACE_TAG_APP, "test")); verify((MockedVoidMethod) () -> Trace.traceEnd(TRACE_TAG_APP)); verify((MockedVoidMethod) () -> Slog.v(eq(TAG), matches("test took to complete: \\dms"))); } @Test public void testMultipleLevels() throws Exception { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); log.traceBegin("L1"); log.traceBegin("L2"); log.traceEnd(); log.traceEnd(); verify((MockedVoidMethod) () -> Trace.traceBegin(TRACE_TAG_APP, "L1")); verify((MockedVoidMethod) () -> Trace.traceBegin(TRACE_TAG_APP, "L2")); verify((MockedVoidMethod) () -> Trace.traceEnd(TRACE_TAG_APP), times(2)); // L1 and L2 verify((MockedVoidMethod) () -> Slog.v(eq(TAG), matches("L2 took to complete: \\d+ms"))); verify((MockedVoidMethod) () -> Slog.v(eq(TAG), matches("L1 took to complete: \\d+ms"))); } @Test public void testEndNoBegin() throws Exception { TimingsTraceAndSlog log = new TimingsTraceAndSlog(TAG, TRACE_TAG_APP); log.traceEnd(); verify((MockedVoidMethod) () -> Trace.traceEnd(TRACE_TAG_APP)); verify((MockedVoidMethod) () -> Slog.d(eq(TAG), anyString()), never()); verify((MockedVoidMethod) () -> Slog.w(TAG, "traceEnd called more times than traceBegin")); } }