[91.366290] Initializing watchdogs
[91.366495]   /dev/watchdog0
[91.405227] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.420542] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.426924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.431779] [001/133] (960s left) gem_exec_balancer (fairslice)
[91.582148] Starting subtest: fairslice
[91.584845] Subtest fairslice: SKIP (0.000s)
[91.851252] [002/133] (960s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[92.027102] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[92.028061] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.045198] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[92.080095] Starting dynamic subtest: pipe-A-HDMI-A-2
[92.143737] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[92.173485] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.200593] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[92.215274] Starting dynamic subtest: pipe-B-HDMI-A-2
[92.227331] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[92.243171] Starting dynamic subtest: pipe-C-HDMI-A-1
[92.251382] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[92.268457] Starting dynamic subtest: pipe-C-HDMI-A-2
[92.276685] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[92.278238] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.023s)
[93.000121] [003/133] (959s left) gem_exec_balancer (smoke)
[93.135075] Starting subtest: smoke
[97.510745] Subtest smoke: SUCCESS (4.378s)
[97.773786] [004/133] (954s left) i915_module_load (reload)
[97.870976] Starting subtest: reload
[102.190552] Subtest reload: SUCCESS (4.320s)
[102.300321] [005/133] (949s left) syncobj_wait (wait-all-complex)
[102.425362] Starting subtest: wait-all-complex
[102.645858] Subtest wait-all-complex: SUCCESS (0.219s)
[102.798944] [006/133] (949s left) kms_pm_rpm (i2c)
[104.766296] Starting subtest: i2c
[106.611027] Subtest i2c: SUCCESS (1.841s)
[106.943498] [007/133] (945s left) gem_userptr_blits (readonly-unsync)
[107.067077] Subtest readonly-unsync: SKIP (0.000s)
[107.327333] [008/133] (945s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[107.438618] Starting subtest: basic-gtt-cpu-noreloc
[107.454170] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.013s)
[107.686671] [009/133] (944s left) gem_ctx_persistence (heartbeat-many)
[107.829123] Starting subtest: heartbeat-many
[108.348124] Subtest heartbeat-many: SUCCESS (0.521s)
[108.479710] [010/133] (944s left) dumb_buffer (create-clear)
[108.582773] Starting subtest: create-clear
[142.586715] Subtest create-clear: SUCCESS (34.005s)
[142.727233] [011/133] (910s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[142.913541] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[142.918348] Starting dynamic subtest: pipe-A-valid-mode
[143.981675] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.073s)
[143.983515] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.078s)
[144.297528] [012/133] (908s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[144.501181] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[144.506267] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[144.710948] [013/133] (908s left) gem_readwrite (new-obj)
[144.826246] Starting subtest: new-obj
[144.828760] Subtest new-obj: SUCCESS (0.000s)
[144.966069] [014/133] (908s left) syncobj_timeline (single-wait-all-available-submitted)
[145.073402] Starting subtest: single-wait-all-available-submitted
[145.075264] Subtest single-wait-all-available-submitted: SUCCESS (0.001s)
[145.200355] [015/133] (908s left) kms_sequence (queue-idle)
[145.378108] Starting subtest: queue-idle
[145.380083] Starting dynamic subtest: pipe-A-HDMI-A-1
[148.163524] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.781s)
[148.188254] Starting dynamic subtest: pipe-A-HDMI-A-2
[150.634813] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.468s)
[150.665877] Starting dynamic subtest: pipe-B-HDMI-A-1
[153.076112] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.434s)
[153.118444] Starting dynamic subtest: pipe-B-HDMI-A-2
[155.571131] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.491s)
[155.598123] Starting dynamic subtest: pipe-C-HDMI-A-1
[158.063689] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.489s)
[158.091127] Starting dynamic subtest: pipe-C-HDMI-A-2
[160.499129] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.431s)
[160.501149] Subtest queue-idle: SUCCESS (15.121s)
[160.838676] [016/133] (892s left) kms_vblank (query-idle)
[161.024058] Starting subtest: query-idle
[161.029246] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.761144] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.732s)
[163.805405] Starting dynamic subtest: pipe-A-HDMI-A-2
[166.175408] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.410s)
[166.202554] Starting dynamic subtest: pipe-C-HDMI-A-1
[168.606645] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.420s)
[168.649926] Starting dynamic subtest: pipe-C-HDMI-A-2
[171.007137] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.395s)
[171.012453] Subtest query-idle: SUCCESS (9.983s)
[171.287323] [017/133] (882s left) kms_chamelium_frames (dp-crc-multiple)
[171.882641] Subtest dp-crc-multiple: SKIP (0.000s)
[172.141624] [018/133] (881s left) gem_exec_schedule (deep)
[172.403200] Starting subtest: deep
[172.404404] Starting dynamic subtest: rcs0
[185.677711] Dynamic subtest rcs0: SUCCESS (13.255s)
[185.712202] Starting dynamic subtest: bcs0
[199.975353] Dynamic subtest bcs0: SUCCESS (14.297s)
[200.020133] Starting dynamic subtest: vcs0
[213.854508] Dynamic subtest vcs0: SUCCESS (13.865s)
[213.946738] Starting dynamic subtest: vecs0
[227.584088] Dynamic subtest vecs0: SUCCESS (13.723s)
[227.590718] Subtest deep: SUCCESS (55.174s)
[228.606208] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[228.609779] [019/133] (824s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[228.790084] Starting subtest: modeset-transition-nonblocking-fencing
[228.792047] Starting dynamic subtest: 1x-outputs
[232.300705] Dynamic subtest 1x-outputs: SUCCESS (3.510s)
[232.323288] Starting dynamic subtest: 2x-outputs
[239.657102] Dynamic subtest 2x-outputs: SUCCESS (7.352s)
[239.658697] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.866s)
[239.956823] [020/133] (813s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[240.141127] Starting subtest: primary-4-tiled-reflect-x-0
[240.146186] Subtest primary-4-tiled-reflect-x-0: SKIP (0.004s)
[240.290266] [021/133] (813s left) i915_drm_fdinfo (busy)
[240.397284] Starting subtest: busy
[240.403603] Starting dynamic subtest: rcs0
[240.930337] Dynamic subtest rcs0: SUCCESS (0.530s)
[240.958192] Starting dynamic subtest: bcs0
[241.464110] Dynamic subtest bcs0: SUCCESS (0.531s)
[241.493051] Starting dynamic subtest: vcs0
[241.996097] Dynamic subtest vcs0: SUCCESS (0.528s)
[242.023148] Starting dynamic subtest: vecs0
[242.532058] Dynamic subtest vecs0: SUCCESS (0.533s)
[242.535071] Subtest busy: SUCCESS (2.134s)
[242.676919] [022/133] (811s left) api_intel_allocator (simple-allocator)
[242.785448] Starting subtest: simple-allocator
[242.786362] Starting dynamic subtest: basic
[242.792456] Dynamic subtest basic: SUCCESS (0.009s)
[242.820085] Starting dynamic subtest: parallel-one
[243.219093] Dynamic subtest parallel-one: SUCCESS (0.422s)
[243.239415] Starting dynamic subtest: print
[243.240283] Dynamic subtest print: SUCCESS (0.000s)
[243.261795] Starting dynamic subtest: reuse
[243.263206] Dynamic subtest reuse: SUCCESS (0.001s)
[243.283084] Starting dynamic subtest: reserve
[243.284797] Dynamic subtest reserve: SUCCESS (0.000s)
[243.303036] Starting dynamic subtest: fork-reopen-allocator
[243.303873] Dynamic subtest fork-reopen-allocator: SUCCESS (0.031s)
[243.304679] Subtest simple-allocator: SUCCESS (0.470s)
[243.391587] [023/133] (810s left) kms_addfb_basic (basic-y-tiled-legacy)
[243.494741] Starting subtest: basic-y-tiled-legacy
[243.496072] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[243.723393] [024/133] (810s left) kms_cursor_crc (cursor-offscreen-256x85)
[243.926125] Starting subtest: cursor-offscreen-256x85
[243.969119] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.818233] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.849s)
[246.947245] Starting dynamic subtest: pipe-C-HDMI-A-1
[249.460376] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.546s)
[249.461307] Subtest cursor-offscreen-256x85: SUCCESS (5.534s)
[249.770038] [025/133] (804s left) kms_flip (blocking-absolute-wf_vblank)
[249.946749] Starting subtest: blocking-absolute-wf_vblank
[249.948231] Starting dynamic subtest: A-HDMI-A1
[255.611195] Dynamic subtest A-HDMI-A1: SUCCESS (5.660s)
[255.632337] Starting dynamic subtest: B-HDMI-A1
[261.064700] Dynamic subtest B-HDMI-A1: SUCCESS (5.451s)
[261.084501] Starting dynamic subtest: C-HDMI-A1
[266.448385] Dynamic subtest C-HDMI-A1: SUCCESS (5.378s)
[266.467571] Starting dynamic subtest: A-HDMI-A2
[271.838872] Dynamic subtest A-HDMI-A2: SUCCESS (5.392s)
[271.858630] Starting dynamic subtest: B-HDMI-A2
[277.233356] Dynamic subtest B-HDMI-A2: SUCCESS (5.388s)
[277.253169] Starting dynamic subtest: C-HDMI-A2
[282.607188] Dynamic subtest C-HDMI-A2: SUCCESS (5.371s)
[282.611163] Subtest blocking-absolute-wf_vblank: SUCCESS (32.659s)
[283.105860] [026/133] (771s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[283.314051] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[283.319088] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[283.487399] [027/133] (770s left) kms_color (degamma)
[283.667173] Starting subtest: degamma
[283.669166] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.665490] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.001s)
[284.705571] Starting dynamic subtest: pipe-A-HDMI-A-2
[285.362917] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.694s)
[285.402405] Starting dynamic subtest: pipe-B-HDMI-A-1
[286.048738] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.683s)
[286.067566] Starting dynamic subtest: pipe-B-HDMI-A-2
[286.760300] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.710s)
[286.804473] Starting dynamic subtest: pipe-C-HDMI-A-1
[287.456420] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.690s)
[287.476349] Starting dynamic subtest: pipe-C-HDMI-A-2
[288.135205] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.677s)
[288.137316] Subtest degamma: SUCCESS (4.473s)
[288.496749] [028/133] (765s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[288.676214] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[288.681845] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[288.815911] [029/133] (765s left) gem_workarounds (basic-read-context)
[288.951620] Starting subtest: basic-read-context
[288.969837] Subtest basic-read-context: SUCCESS (0.021s)
[289.145873] [030/133] (765s left) kms_cursor_crc (cursor-sliding-128x42)
[289.329085] Starting subtest: cursor-sliding-128x42
[289.378066] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.410077] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.032s)
[293.501831] Starting dynamic subtest: pipe-C-HDMI-A-1
[297.247114] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.760s)
[297.248271] Subtest cursor-sliding-128x42: SUCCESS (7.916s)
[297.636314] [031/133] (756s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[297.829087] Starting subtest: cursorA-vs-flipB-legacy
[309.214083] Subtest cursorA-vs-flipB-legacy: SUCCESS (11.389s)
[309.585765] [032/133] (745s left) gem_exec_flush (basic-wb-rw-default)
[309.710218] Starting subtest: basic-wb-rw-default
[315.119612] Subtest basic-wb-rw-default: SUCCESS (5.413s)
[315.374902] [033/133] (739s left) i915_selftest (mock)
[316.719631] Starting subtest: mock
[316.722899] Starting dynamic subtest: sanitycheck
[318.410687] Dynamic subtest sanitycheck: SUCCESS (1.688s)
[318.431443] Starting dynamic subtest: shmem
[320.093303] Dynamic subtest shmem: SUCCESS (1.679s)
[320.112849] Starting dynamic subtest: fence
[329.069831] Dynamic subtest fence: SUCCESS (8.974s)
[329.091447] Starting dynamic subtest: scatterlist
[331.761240] Dynamic subtest scatterlist: SUCCESS (2.689s)
[331.785397] Starting dynamic subtest: syncmap
[335.526441] Dynamic subtest syncmap: SUCCESS (3.762s)
[335.548271] Starting dynamic subtest: uncore
[337.229688] Dynamic subtest uncore: SUCCESS (1.698s)
[337.250371] Starting dynamic subtest: ring
[338.909950] Dynamic subtest ring: SUCCESS (1.677s)
[338.930768] Starting dynamic subtest: engine
[340.585587] Dynamic subtest engine: SUCCESS (1.673s)
[340.609354] Starting dynamic subtest: timelines
[350.223115] Dynamic subtest timelines: SUCCESS (9.633s)
[350.244763] Starting dynamic subtest: requests
[354.070086] Dynamic subtest requests: SUCCESS (3.846s)
[354.096299] Starting dynamic subtest: objects
[355.869612] Dynamic subtest objects: SUCCESS (1.796s)
[355.892395] Starting dynamic subtest: phys
[357.732238] Dynamic subtest phys: SUCCESS (1.858s)
[357.755338] Starting dynamic subtest: dmabuf
[359.537933] Dynamic subtest dmabuf: SUCCESS (1.803s)
[359.561352] Starting dynamic subtest: vma
[380.266089] Dynamic subtest vma: SUCCESS (20.725s)
[380.286537] Starting dynamic subtest: evict
[384.371277] Dynamic subtest evict: SUCCESS (4.100s)
[384.397271] Starting dynamic subtest: gtt
[389.986704] Dynamic subtest gtt: SUCCESS (5.612s)
[390.007719] Starting dynamic subtest: hugepages
[392.235483] Dynamic subtest hugepages: SUCCESS (2.246s)
[392.256340] Starting dynamic subtest: memory_region
[400.273027] Dynamic subtest memory_region: SUCCESS (8.035s)
[400.274814] Subtest mock: SUCCESS (83.554s)
[400.344202] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[400.347097] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[400.350935] [034/133] (654s left) gem_mmap_wc (invalid-flags)
[403.158805] Starting subtest: invalid-flags
[403.162097] Subtest invalid-flags: SUCCESS (0.000s)
[403.355505] [FACT gem_mmap_wc (invalid-flags)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[403.358514] [FACT gem_mmap_wc (invalid-flags)] new: kernel.kmod_is_loaded.i915: true
[403.371875] [035/133] (651s left) gem_compute (compute-square)
[403.500104] Starting subtest: compute-square
[403.503424] Subtest compute-square: SKIP (0.000s)
[403.642627] [036/133] (651s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[403.823646] Starting subtest: sprite-rotation-90-pos-100-0
[418.855865] Subtest sprite-rotation-90-pos-100-0: SUCCESS (15.036s)
[419.138763] [037/133] (636s left) core_getclient (basic)
[419.247328] Starting subtest: basic
[419.249124] Subtest basic: SUCCESS (0.000s)
[419.397175] [038/133] (635s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[419.594250] Starting subtest: y-tiled-addfb-size-offset-overflow
[419.596292] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[419.740216] [039/133] (635s left) kms_cursor_crc (cursor-size-change)
[419.923086] Starting subtest: cursor-size-change
[419.930681] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.052862] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.124s)
[421.091707] Starting dynamic subtest: pipe-C-HDMI-A-1
[421.849836] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.787s)
[421.852759] Subtest cursor-size-change: SUCCESS (1.925s)
[422.187875] [040/133] (633s left) gem_vm_create (invalid-destroy)
[422.320525] Starting subtest: invalid-destroy
[422.323209] Subtest invalid-destroy: SUCCESS (0.002s)
[422.452712] [041/133] (633s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[422.559699] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[422.662140] [042/133] (633s left) gem_pxp (hw-rejects-pxp-context)
[425.328915] Starting subtest: hw-rejects-pxp-context
[425.330028] Subtest hw-rejects-pxp-context: SUCCESS (0.002s)
[425.501125] [043/133] (630s left) prime_self_import (basic-with_one_bo_two_files)
[425.602321] Starting subtest: basic-with_one_bo_two_files
[425.604704] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[425.756200] [044/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[425.954290] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[425.959152] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[426.104589] [045/133] (629s left) perf_pmu (semaphore-wait-idle)
[426.223184] Starting subtest: semaphore-wait-idle
[426.226576] Starting dynamic subtest: rcs0
[426.739979] Dynamic subtest rcs0: SUCCESS (0.518s)
[426.765592] Starting dynamic subtest: bcs0
[427.260921] Dynamic subtest bcs0: SUCCESS (0.517s)
[427.285824] Starting dynamic subtest: vcs0
[427.780275] Dynamic subtest vcs0: SUCCESS (0.513s)
[427.803833] Starting dynamic subtest: vecs0
[428.299211] Dynamic subtest vecs0: SUCCESS (0.514s)
[428.301086] Subtest semaphore-wait-idle: SUCCESS (2.078s)
[428.457120] [046/133] (627s left) perf_pmu (idle)
[428.575426] Starting subtest: idle
[428.578160] Starting dynamic subtest: rcs0
[429.096018] Dynamic subtest rcs0: SUCCESS (0.517s)
[429.122616] Starting dynamic subtest: bcs0
[429.611491] Dynamic subtest bcs0: SUCCESS (0.511s)
[429.634921] Starting dynamic subtest: vcs0
[430.132156] Dynamic subtest vcs0: SUCCESS (0.512s)
[430.154659] Starting dynamic subtest: vecs0
[430.647513] Dynamic subtest vecs0: SUCCESS (0.513s)
[430.653318] Subtest idle: SUCCESS (2.074s)
[430.818965] [047/133] (625s left) kms_addfb_basic (bad-pitch-0)
[430.927531] Starting subtest: bad-pitch-0
[430.929082] Subtest bad-pitch-0: SUCCESS (0.000s)
[431.171284] [048/133] (625s left) gem_mmap (big-bo)
[431.274520] Starting subtest: big-bo
[432.305125] Subtest big-bo: SUCCESS (1.029s)
[432.454707] [049/133] (623s left) kms_addfb_basic (unused-modifier)
[432.669276] Starting subtest: unused-modifier
[432.672338] Subtest unused-modifier: SUCCESS (0.000s)
[432.922569] [050/133] (623s left) gem_softpin (reverse)
[433.050096] Starting subtest: reverse
[433.063575] Subtest reverse: SUCCESS (0.015s)
[433.206241] [051/133] (623s left) gem_lmem_swapping (verify-random-ccs)
[433.337096] Subtest verify-random-ccs: SKIP (0.000s)
[433.447328] [052/133] (623s left) gem_exec_suspend (basic-s4-devices)
[433.575985] Starting subtest: basic-S4-devices
[433.576886] Starting dynamic subtest: smem
[444.777749] Dynamic subtest smem: SUCCESS (11.203s)
[444.780309] Subtest basic-S4-devices: SUCCESS (11.207s)
[455.062953] [053/133] (611s left) gem_ctx_bad_destroy (double-destroy)
[455.178883] Starting subtest: double-destroy
[455.179876] Subtest double-destroy: SUCCESS (0.000s)
[455.317094] [054/133] (611s left) kms_psr (fbc-psr-sprite-render)
[455.520093] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[455.636288] [055/133] (611s left) syncobj_timeline (wait-zero-handles)
[455.745880] Starting subtest: wait-zero-handles
[455.747136] Subtest wait-zero-handles: SUCCESS (0.000s)
[455.897965] [056/133] (611s left) gem_mmap_wc (write-cpu-read-wc)
[455.997129] Starting subtest: write-cpu-read-wc
[456.107214] Subtest write-cpu-read-wc: SUCCESS (0.108s)
[456.247215] [057/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[456.444117] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[456.449132] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[456.611541] [058/133] (610s left) kms_plane (plane-position-covered)
[456.799275] Starting subtest: plane-position-covered
[457.595311] Starting dynamic subtest: pipe-A-plane-1
[458.163999] Dynamic subtest pipe-A-plane-1: SUCCESS (0.566s)
[458.199274] Starting dynamic subtest: pipe-A-plane-2
[458.720938] Dynamic subtest pipe-A-plane-2: SUCCESS (0.553s)
[458.749049] Starting dynamic subtest: pipe-A-plane-3
[459.298227] Dynamic subtest pipe-A-plane-3: SUCCESS (0.571s)
[459.345503] Starting dynamic subtest: pipe-A-plane-4
[459.356509] Dynamic subtest pipe-A-plane-4: SUCCESS (0.008s)
[459.820531] Starting dynamic subtest: pipe-B-plane-1
[460.309191] Dynamic subtest pipe-B-plane-1: SUCCESS (0.534s)
[460.338151] Starting dynamic subtest: pipe-B-plane-2
[460.852192] Dynamic subtest pipe-B-plane-2: SUCCESS (0.540s)
[460.905639] Starting dynamic subtest: pipe-B-plane-3
[461.372115] Dynamic subtest pipe-B-plane-3: SUCCESS (0.516s)
[461.403725] Starting dynamic subtest: pipe-B-plane-4
[461.407611] Dynamic subtest pipe-B-plane-4: SUCCESS (0.009s)
[461.408752] Subtest plane-position-covered: SUCCESS (4.590s)
[461.683401] [059/133] (605s left) kms_feature_discovery (display-3x)
[461.881173] Starting subtest: display-3x
[461.883182] Subtest display-3x: SKIP (0.000s)
[462.018189] [060/133] (605s left) gem_mmap_offset (partial-unmap)
[462.125251] Starting subtest: partial-unmap
[462.130130] Starting dynamic subtest: smem0
[462.250859] Dynamic subtest smem0: SUCCESS (0.124s)
[462.255604] Subtest partial-unmap: SUCCESS (0.128s)
[462.399213] [061/133] (605s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[462.585343] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[462.586287] Starting dynamic subtest: pipe-A-HDMI-A-1
[462.607189] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[462.658356] Starting dynamic subtest: pipe-A-HDMI-A-2
[462.684481] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[462.729307] Starting dynamic subtest: pipe-B-HDMI-A-1
[462.756515] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[462.801226] Starting dynamic subtest: pipe-B-HDMI-A-2
[462.818270] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[462.842095] Starting dynamic subtest: pipe-C-HDMI-A-1
[462.852046] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[462.876421] Starting dynamic subtest: pipe-C-HDMI-A-2
[462.885072] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[462.886883] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.044s)
[463.721312] [062/133] (603s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[463.907687] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[464.018931] [063/133] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[464.232740] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[464.241144] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[464.377812] [064/133] (603s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[464.624352] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[464.630072] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[464.806454] [065/133] (603s left) gem_ccs (block-copy-compressed)
[464.921319] Subtest block-copy-compressed: SKIP (0.000s)
[465.035388] [066/133] (602s left) gem_userptr_blits (coherency-sync)
[465.172087] Starting subtest: coherency-sync
[465.331907] Subtest coherency-sync: SKIP (0.141s)
[465.508277] [067/133] (602s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[465.829999] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[465.833446] Starting dynamic subtest: pipe-A
[466.197359] Dynamic subtest pipe-A: SUCCESS (0.371s)
[466.246966] Starting dynamic subtest: pipe-B
[466.683375] Dynamic subtest pipe-B: SUCCESS (0.479s)
[466.721267] Starting dynamic subtest: pipe-C
[466.790822] Dynamic subtest pipe-C: SUCCESS (0.103s)
[466.793756] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.967s)
[467.294512] [068/133] (600s left) syncobj_basic (bad-flags-fd-to-handle)
[467.396941] Starting subtest: bad-flags-fd-to-handle
[467.399182] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[467.543618] [069/133] (600s left) perf_pmu (busy-double-start)
[467.656119] Starting subtest: busy-double-start
[467.658629] Starting dynamic subtest: rcs0
[471.197147] Dynamic subtest rcs0: SUCCESS (3.535s)
[471.220506] Starting dynamic subtest: bcs0
[474.748903] Dynamic subtest bcs0: SUCCESS (3.552s)
[474.775091] Starting dynamic subtest: vcs0
[478.294150] Dynamic subtest vcs0: SUCCESS (3.541s)
[478.323416] Starting dynamic subtest: vecs0
[481.838807] Dynamic subtest vecs0: SUCCESS (3.539s)
[481.842823] Subtest busy-double-start: SUCCESS (14.186s)
[482.025712] [070/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[482.222899] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[482.227208] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[482.377218] [071/133] (586s left) gem_exec_capture (userptr)
[482.496248] Starting subtest: userptr
[483.786263] Subtest userptr: SUCCESS (1.288s)
[483.945354] [072/133] (584s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[484.137061] Starting subtest: drrs-dirtyfb-ioctl
[484.150620] Subtest drrs-dirtyfb-ioctl: SKIP (0.007s)
[484.295519] [073/133] (584s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[484.496198] Starting subtest: plane-use-after-nonblocking-unbind
[484.501866] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.031629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.530s)
[485.307484] Starting dynamic subtest: pipe-A-HDMI-A-2
[485.756358] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.498s)
[486.069323] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.529059] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.511s)
[486.805382] Starting dynamic subtest: pipe-B-HDMI-A-2
[487.188234] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.433s)
[487.410288] Subtest plane-use-after-nonblocking-unbind: SUCCESS (2.911s)
[487.700281] [074/133] (581s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[487.908160] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[488.849109] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.949s)
[489.166083] [075/133] (579s left) kms_pm_rpm (fences)
[491.154972] Starting subtest: fences
[494.294078] Subtest fences: SUCCESS (3.139s)
[494.582581] [076/133] (574s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[494.778167] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[494.782391] Starting dynamic subtest: pipe-A-valid-mode
[495.416067] Dynamic subtest pipe-A-valid-mode: SKIP (0.636s)
[495.418943] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.644s)
[495.914830] [077/133] (573s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[496.034827] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[496.138336] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[496.318578] [078/133] (572s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[496.540061] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[497.605177] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.067s)
[497.982770] [079/133] (571s left) gem_pxp (fail-invalid-protected-context)
[500.630708] Starting subtest: fail-invalid-protected-context
[500.633794] Subtest fail-invalid-protected-context: SKIP (0.000s)
[500.782051] [080/133] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[500.968639] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[503.789341] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.819s)
[504.117536] [081/133] (565s left) syncobj_timeline (invalid-wait-illegal-handle)
[504.225138] Starting subtest: invalid-wait-illegal-handle
[504.228114] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[504.371251] [082/133] (565s left) kms_chamelium_hpd (dp-hpd-fast)
[505.005163] Subtest dp-hpd-fast: SKIP (0.000s)
[505.305089] [083/133] (564s left) gem_exec_store (dword)
[505.435622] Starting subtest: dword
[505.439113] Starting dynamic subtest: rcs0
[505.473753] Dynamic subtest rcs0: SUCCESS (0.036s)
[505.505884] Starting dynamic subtest: bcs0
[505.506806] Dynamic subtest bcs0: SUCCESS (0.016s)
[505.537108] Starting dynamic subtest: vcs0
[505.538342] Dynamic subtest vcs0: SUCCESS (0.014s)
[505.561739] Starting dynamic subtest: vecs0
[505.562959] Dynamic subtest vecs0: SUCCESS (0.018s)
[505.564050] Subtest dword: SUCCESS (0.098s)
[505.790425] [084/133] (563s left) gem_softpin (noreloc-interruptible)
[505.915684] Starting subtest: noreloc-interruptible
[511.378321] Subtest noreloc-interruptible: SUCCESS (5.461s)
[511.557341] [085/133] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[511.768263] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[511.771685] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[511.922483] [086/133] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[512.115268] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[512.119133] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[512.274222] [087/133] (557s left) kms_plane_alpha_blend (constant-alpha-mid)
[512.473074] Starting subtest: constant-alpha-mid
[512.643258] Starting dynamic subtest: pipe-A-HDMI-A-1
[513.697603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.052s)
[513.729500] Starting dynamic subtest: pipe-C-HDMI-A-1
[514.594271] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.882s)
[514.597523] Subtest constant-alpha-mid: SUCCESS (2.124s)
[514.932494] [088/133] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[515.154079] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[518.086464] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SUCCESS (2.931s)
[518.315346] [089/133] (551s left) kms_joiner (basic-force-ultra-joiner)
[518.504848] Starting subtest: basic-force-ultra-joiner
[518.511085] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[518.647072] [090/133] (551s left) kms_psr (psr2-sprite-mmap-cpu)
[518.845330] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[518.956432] [091/133] (551s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[519.165092] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[521.888046] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.721s)
[522.131522] [092/133] (548s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[522.319361] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[522.323055] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[523.100527] [093/133] (547s left) gem_ctx_shared (q-smoketest)
[523.235100] Starting subtest: Q-smoketest
[523.236785] Starting dynamic subtest: rcs0
[528.663226] Dynamic subtest rcs0: SUCCESS (5.425s)
[528.700369] Starting dynamic subtest: bcs0
[534.094393] Dynamic subtest bcs0: SUCCESS (5.425s)
[534.120256] Starting dynamic subtest: vcs0
[539.536281] Dynamic subtest vcs0: SUCCESS (5.437s)
[539.562187] Starting dynamic subtest: vecs0
[544.967634] Dynamic subtest vecs0: SUCCESS (5.434s)
[544.970151] Subtest Q-smoketest: SUCCESS (21.736s)
[545.232929] [094/133] (525s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[545.406376] Starting subtest: cursorB-vs-flipA-atomic
[556.750934] Subtest cursorB-vs-flipA-atomic: SUCCESS (11.341s)
[557.087561] [095/133] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[557.294290] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[557.297086] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[557.458786] [096/133] (513s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[557.659045] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[557.826130] [097/133] (513s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[557.940484] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[557.942539] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s)
[558.119655] [098/133] (512s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[558.325408] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[560.728371] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SUCCESS (2.407s)
[560.956576] [099/133] (510s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[561.064699] Starting subtest: multi-wait-for-submit-unsubmitted
[561.170550] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[561.320486] [100/133] (509s left) kms_cursor_edge_walk (64x64-left-edge)
[561.493218] Starting subtest: 64x64-left-edge
[561.508833] Starting dynamic subtest: pipe-A-HDMI-A-1
[565.457401] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.960s)
[565.514450] Starting dynamic subtest: pipe-C-HDMI-A-1
[568.954420] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.489s)
[568.956530] Subtest 64x64-left-edge: SUCCESS (7.463s)
[569.260381] [101/133] (502s left) kms_lease (lease-invalid-connector)
[569.469050] Starting subtest: lease-invalid-connector
[569.471854] Starting dynamic subtest: pipe-A-HDMI-A-1
[569.473164] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[569.526757] Starting dynamic subtest: pipe-A-HDMI-A-2
[569.527644] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[569.556637] Starting dynamic subtest: pipe-B-HDMI-A-1
[569.557478] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[569.595075] Starting dynamic subtest: pipe-B-HDMI-A-2
[569.596280] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[569.619507] Starting dynamic subtest: pipe-C-HDMI-A-1
[569.620305] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[569.643559] Starting dynamic subtest: pipe-C-HDMI-A-2
[569.644370] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[569.645156] Subtest lease-invalid-connector: SUCCESS (0.059s)
[569.729906] [102/133] (501s left) kms_plane_lowres (tiling-4)
[569.925244] Starting subtest: tiling-4
[569.927517] Subtest tiling-4: SKIP (0.000s)
[570.075679] [103/133] (501s left) gem_ctx_param (invalid-get-no-zeromap)
[570.176893] Starting subtest: invalid-get-no-zeromap
[570.178055] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[570.327175] [104/133] (501s left) gem_exec_whisper (basic-queues-forked-all)
[570.452690] Starting subtest: basic-queues-forked-all
[581.107347] Subtest basic-queues-forked-all: SUCCESS (10.653s)
[581.377324] [105/133] (490s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[581.573222] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[581.580619] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[582.295573] [106/133] (489s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[582.517177] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[582.521078] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[582.671694] [107/133] (489s left) gem_exec_schedule (preempt-hang)
[582.933121] Starting subtest: preempt-hang
[582.935672] Starting dynamic subtest: rcs0
[583.199319] Dynamic subtest rcs0: SUCCESS (0.266s)
[583.236660] Starting dynamic subtest: bcs0
[583.490898] Dynamic subtest bcs0: SUCCESS (0.283s)
[583.525716] Starting dynamic subtest: vcs0
[583.747588] Dynamic subtest vcs0: SUCCESS (0.254s)
[583.783549] Starting dynamic subtest: vecs0
[584.007877] Dynamic subtest vecs0: SUCCESS (0.252s)
[584.017438] Subtest preempt-hang: SUCCESS (1.075s)
[584.304216] [108/133] (487s left) gem_workarounds (suspend-resume-context)
[584.441186] Starting subtest: suspend-resume-context