[59.336455] Initializing watchdogs
[59.336522]   /dev/watchdog0
[59.350817] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.355128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.357412] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.360732] [001/132] (960s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[59.448298] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[59.504161] [002/132] (960s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[59.620188] Starting subtest: y-tiled-8bpp-rotate-90
[59.624742] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[59.714126] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[59.811214] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[59.815168] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[59.902416] [004/132] (960s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[60.011074] Starting subtest: x-tiled-8bpp-rotate-90
[60.047626] Subtest x-tiled-8bpp-rotate-90: SKIP (0.036s)
[60.157293] [005/132] (959s left) vgem_basic (second-client)
[60.224800] Starting subtest: second-client
[60.243810] Subtest second-client: SUCCESS (0.020s)
[60.297098] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[60.299735] [006/132] (959s left) gem_eio (suspend)
[60.439510] Starting subtest: suspend
[72.586045] Subtest suspend: SUCCESS (12.113s)
[72.720332] [007/132] (947s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[72.817845] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[72.822028] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[72.909400] [008/132] (947s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[73.022938] Starting subtest: verify-pxp-key-change-after-suspend-resume
[80.198684] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.173s)
[80.335376] [009/132] (939s left) prime_mmap_coherency (write)
[80.398801] Starting subtest: write
[85.778265] Subtest write: SUCCESS (5.376s)
[85.912527] [010/132] (934s left) syncobj_eventfd (binary-wait-before-signal)
[85.976023] Starting subtest: binary-wait-before-signal
[86.005577] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[86.095405] [011/132] (934s left) syncobj_timeline (multi-wait-submitted-signaled)
[86.155813] Starting subtest: multi-wait-submitted-signaled
[86.158196] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[86.266245] [012/132] (934s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[86.317638] Starting subtest: single-wait-all-for-submit-available-submitted
[86.319926] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[86.413315] [013/132] (933s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[86.516960] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[86.521496] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[86.585940] [014/132] (933s left) kms_force_connector_basic (prune-stale-modes)
[86.661201] Starting subtest: prune-stale-modes
[87.102914] Subtest prune-stale-modes: SUCCESS (0.442s)
[87.237300] [015/132] (933s left) gem_flink_basic (basic)
[87.292491] Starting subtest: basic
[87.294169] Subtest basic: SUCCESS (0.000s)
[87.382863] [016/132] (933s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[87.464723] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[87.468538] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[87.548662] [017/132] (932s left) gem_exec_schedule (u-lateslice)
[87.626262] Starting subtest: u-lateslice
[87.628105] Starting dynamic subtest: rcs0
[87.642883] Dynamic subtest rcs0: SUCCESS (0.022s)
[87.651999] Starting dynamic subtest: bcs0
[87.661203] Dynamic subtest bcs0: SUCCESS (0.018s)
[87.670479] Starting dynamic subtest: vcs0
[87.687112] Dynamic subtest vcs0: SUCCESS (0.026s)
[87.696034] Starting dynamic subtest: vcs1
[87.710357] Dynamic subtest vcs1: SUCCESS (0.023s)
[87.718873] Starting dynamic subtest: vecs0
[87.730496] Dynamic subtest vecs0: SUCCESS (0.020s)
[87.738769] Starting dynamic subtest: ccs0
[87.751224] Dynamic subtest ccs0: SUCCESS (0.020s)
[87.753121] Subtest u-lateslice: SUCCESS (0.131s)
[89.009952] [018/132] (931s left) kms_psr (fbc-psr-basic)
[89.114127] Starting subtest: fbc-psr-basic
[89.116087] Starting dynamic subtest: eDP-1
[89.120274] Dynamic subtest eDP-1: SKIP (0.000s)
[89.124422] Subtest fbc-psr-basic: SKIP (0.000s)
[89.191235] [019/132] (931s left) kms_addfb_basic (basic)
[89.243776] Starting subtest: basic
[89.246184] Subtest basic: SUCCESS (0.000s)
[89.373214] [020/132] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[89.475058] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[89.479204] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[89.571116] [021/132] (931s left) gem_flink_race (flink_name)
[89.614693] Starting subtest: flink_name
[95.008999] Subtest flink_name: SUCCESS (5.390s)
[95.128979] [022/132] (925s left) syncobj_wait (reset-multiple-signaled)
[95.187846] Starting subtest: reset-multiple-signaled
[95.190326] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[95.283999] [023/132] (925s left) kms_lease (atomic-implicit-crtc)
[95.377029] Starting subtest: atomic-implicit-crtc
[95.379442] Starting dynamic subtest: pipe-A-eDP-1
[95.390991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[95.401697] Starting dynamic subtest: pipe-B-eDP-1
[95.413250] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[95.421604] Starting dynamic subtest: pipe-C-eDP-1
[95.432183] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[95.440517] Starting dynamic subtest: pipe-D-eDP-1
[95.451637] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[95.453870] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[95.512694] [024/132] (925s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[95.573057] Starting subtest: multi-wait-for-submit-unsubmitted
[95.675300] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[95.750122] [025/132] (925s left) gem_ccs (large-ctrl-surf-copy)
[95.832892] Starting subtest: large-ctrl-surf-copy
[95.837690] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[95.964601] [026/132] (924s left) gem_exec_suspend (basic-s3)
[96.030088] Starting subtest: basic-S3
[96.032462] Starting dynamic subtest: smem
[116.283832] Dynamic subtest smem: SUCCESS (6.797s)
[116.286988] Subtest basic-S3: SUCCESS (6.798s)
[116.486030] [027/132] (904s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[116.595372] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[116.599800] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[116.702049] [028/132] (904s left) gem_mmap_wc (bad-size)
[116.759379] Subtest bad-size: SKIP (0.000s)
[116.816757] [029/132] (904s left) gem_ctx_persistence (engines-cleanup)
[116.883333] Starting subtest: engines-cleanup
[116.885800] Starting dynamic subtest: rcs0
[116.974778] Dynamic subtest rcs0: SUCCESS (0.089s)
[116.987425] Starting dynamic subtest: bcs0
[117.016282] Dynamic subtest bcs0: SUCCESS (0.040s)
[117.030018] Starting dynamic subtest: vcs0
[117.073499] Dynamic subtest vcs0: SUCCESS (0.055s)
[117.088338] Starting dynamic subtest: vcs1
[117.097055] Dynamic subtest vcs1: SUCCESS (0.023s)
[117.105486] Starting dynamic subtest: vecs0
[117.171454] Dynamic subtest vecs0: SUCCESS (0.070s)
[117.181272] Starting dynamic subtest: ccs0
[117.216151] Dynamic subtest ccs0: SUCCESS (0.046s)
[117.218446] Subtest engines-cleanup: SUCCESS (0.326s)
[117.298374] [030/132] (903s left) kms_sequence (queue-busy)
[117.398447] Starting subtest: queue-busy
[117.400389] Starting dynamic subtest: pipe-A-eDP-1
[119.384585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[119.393992] Starting dynamic subtest: pipe-B-eDP-1
[122.054350] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.626s)
[122.065221] Starting dynamic subtest: pipe-C-eDP-1
[124.680356] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[124.693808] Starting dynamic subtest: pipe-D-eDP-1
[127.274461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[127.276756] Subtest queue-busy: SUCCESS (9.747s)
[128.146304] [031/132] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[128.247024] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[128.251419] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[128.336619] [032/132] (892s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[128.437553] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[128.441513] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[128.519383] [033/132] (892s left) api_intel_bb (blit-noreloc-purge-cache)
[128.586773] Starting subtest: blit-noreloc-purge-cache
[128.601928] Subtest blit-noreloc-purge-cache: SUCCESS (0.015s)
[128.726116] [034/132] (892s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[128.854795] Starting subtest: cursorB-vs-flipA-atomic-transitions
[128.859552] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[129.064888] [035/132] (892s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[129.170166] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[129.172216] Starting dynamic subtest: pipe-A-eDP-1
[129.189599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[129.199557] Starting dynamic subtest: pipe-B-eDP-1
[129.216211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[129.224956] Starting dynamic subtest: pipe-C-eDP-1
[129.241584] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[129.250000] Starting dynamic subtest: pipe-D-eDP-1
[129.266260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[129.268181] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[131.462830] [036/132] (889s left) kms_pm_rpm (i2c)
[133.431460] Starting subtest: i2c
[138.435275] Subtest i2c: SUCCESS (4.993s)
[138.533849] [037/132] (882s left) i915_hangman (gt-engine-hang)
[138.614832] Starting subtest: gt-engine-hang
[138.617221] Starting dynamic subtest: rcs0
[140.251123] Dynamic subtest rcs0: SUCCESS (1.633s)
[140.262788] Starting dynamic subtest: bcs0
[142.298046] Dynamic subtest bcs0: SUCCESS (2.042s)
[142.315682] Starting dynamic subtest: vcs0
[144.280792] Dynamic subtest vcs0: SUCCESS (1.979s)
[144.291970] Starting dynamic subtest: vcs1
[146.265042] Dynamic subtest vcs1: SUCCESS (1.981s)
[146.277555] Starting dynamic subtest: vecs0
[148.313907] Dynamic subtest vecs0: SUCCESS (2.046s)
[148.327609] Starting dynamic subtest: ccs0
[150.232975] Dynamic subtest ccs0: SUCCESS (1.918s)
[150.236748] Subtest gt-engine-hang: SUCCESS (11.608s)
[150.317126] [038/132] (871s left) kms_chamelium_frames (dp-frame-dump)
[150.703389] Subtest dp-frame-dump: SKIP (0.000s)
[151.520438] [039/132] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[151.614614] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[159.023643] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.411s)
[159.166722] [040/132] (862s left) perf_pmu (busy-idle-check-all)
[159.213756] Starting subtest: busy-idle-check-all
[159.216140] Starting dynamic subtest: rcs0
[159.871402] Dynamic subtest rcs0: SUCCESS (0.658s)
[159.882792] Starting dynamic subtest: bcs0
[160.523507] Dynamic subtest bcs0: SUCCESS (0.651s)
[160.537041] Starting dynamic subtest: vcs0
[162.299105] Dynamic subtest vcs0: SUCCESS (1.772s)
[162.311911] Starting dynamic subtest: vcs1
[164.347208] Dynamic subtest vcs1: SUCCESS (2.046s)
[164.359517] Starting dynamic subtest: vecs0
[166.331509] Dynamic subtest vecs0: SUCCESS (1.982s)
[166.344121] Starting dynamic subtest: ccs0
[166.987918] Dynamic subtest ccs0: SUCCESS (0.657s)
[166.990652] Subtest busy-idle-check-all: SUCCESS (7.774s)
[167.091803] [041/132] (854s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[167.209227] Starting subtest: psr2-cursor-plane-update-sf
[167.211342] Starting dynamic subtest: pipe-A-eDP-1
[167.768945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[167.778685] Starting dynamic subtest: pipe-B-eDP-1
[169.060259] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[169.062628] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.859s)
[169.928780] [042/132] (851s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[170.020877] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[170.023198] Starting dynamic subtest: pipe-A-eDP-1
[170.082080] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[170.091545] Starting dynamic subtest: pipe-B-eDP-1
[170.150030] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[170.161367] Starting dynamic subtest: pipe-C-eDP-1
[170.218375] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[170.228586] Starting dynamic subtest: pipe-D-eDP-1
[170.287469] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[170.291971] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[172.285584] [043/132] (849s left) kms_dsc (dsc-with-formats)
[172.383351] Starting subtest: dsc-with-formats
[172.423197] Subtest dsc-with-formats: SKIP (0.001s)
[172.464195] [044/132] (849s left) kms_content_protection (dp-mst-type-0-hdcp14)
[172.603665] Starting subtest: dp-mst-type-0-hdcp14
[172.608281] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[172.742971] [045/132] (849s left) gem_mmap_gtt (hang-busy)
[172.804956] Subtest hang-busy: SKIP (0.000s)
[172.876944] [046/132] (848s left) kms_flip (modeset-vs-vblank-race-interruptible)
[172.981331] Starting subtest: modeset-vs-vblank-race-interruptible
[172.984081] Starting dynamic subtest: A-eDP1
[177.723072] Dynamic subtest A-eDP1: SUCCESS (4.737s)
[177.735431] Starting dynamic subtest: B-eDP1
[182.364134] Dynamic subtest B-eDP1: SUCCESS (4.638s)
[182.380317] Starting dynamic subtest: C-eDP1
[186.953458] Dynamic subtest C-eDP1: SUCCESS (4.585s)
[186.965133] Starting dynamic subtest: D-eDP1
[191.489292] Dynamic subtest D-eDP1: SUCCESS (4.532s)
[191.491643] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.505s)
[192.642797] [047/132] (829s left) kms_psr (pr-dpms)
[192.744034] Starting subtest: pr-dpms
[192.748199] Subtest pr-dpms: SKIP (0.000s)
[192.815950] [048/132] (829s left) syncobj_wait (multi-wait-all-submitted-signaled)
[192.864977] Starting subtest: multi-wait-all-submitted-signaled
[192.966065] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[193.044608] [049/132] (828s left) kms_flip (2x-flip-vs-dpms-on-nop)
[193.139839] Starting subtest: 2x-flip-vs-dpms-on-nop
[193.151465] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[193.233986] [050/132] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[193.335832] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[193.340085] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[193.448060] [051/132] (828s left) gem_exec_flush (basic-wb-set-default)
[193.506264] Starting subtest: basic-wb-set-default
[198.965871] Subtest basic-wb-set-default: SUCCESS (5.459s)
[199.154068] [052/132] (822s left) gem_exec_whisper (basic-queues-priority)
[199.224291] Starting subtest: basic-queues-priority
[222.592743] Subtest basic-queues-priority: SUCCESS (23.365s)
[222.781838] [053/132] (799s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[222.889688] Starting subtest: fbc-psr2-sprite-mmap-cpu
[222.892056] Starting dynamic subtest: eDP-1
[222.896494] Dynamic subtest eDP-1: SKIP (0.000s)
[222.900930] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[222.982821] [054/132] (799s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[223.050942] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[223.053331] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[223.167333] [055/132] (799s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[223.271907] Starting subtest: plane-upscale-factor-0-25-with-rotation
[223.274205] Starting dynamic subtest: pipe-A
[223.497151] Dynamic subtest pipe-A: SUCCESS (0.227s)
[223.507585] Starting dynamic subtest: pipe-B
[224.818835] Dynamic subtest pipe-B: SUCCESS (1.321s)
[224.831629] Starting dynamic subtest: pipe-C
[226.142025] Dynamic subtest pipe-C: SUCCESS (1.323s)
[226.151768] Starting dynamic subtest: pipe-D
[227.464955] Dynamic subtest pipe-D: SUCCESS (1.321s)
[227.467300] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.197s)
[228.637521] [056/132] (793s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[228.736681] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[229.527478] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[229.699055] [057/132] (792s left) gem_exec_balancer (semaphore)
[229.765344] Starting subtest: semaphore
[231.291134] Subtest semaphore: SUCCESS (1.524s)
[231.624215] [058/132] (790s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[231.685511] Subtest writes-after-reads-uncached: SKIP (0.000s)
[231.748469] [059/132] (790s left) kms_color (ctm-max)
[231.847745] Starting subtest: ctm-max
[231.849664] Starting dynamic subtest: pipe-A-eDP-1
[232.567942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[232.578604] Starting dynamic subtest: pipe-B-eDP-1
[233.955578] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[233.966163] Starting dynamic subtest: pipe-C-eDP-1
[235.325874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[235.336605] Starting dynamic subtest: pipe-D-eDP-1
[236.652786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[236.655186] Subtest ctm-max: SUCCESS (4.806s)
[237.452853] [060/132] (784s left) gem_exec_balancer (full)
[237.504349] Starting subtest: full
[242.171357] Subtest full: SUCCESS (4.667s)
[242.503260] [061/132] (779s left) syncobj_wait (single-wait-all-signaled)
[242.564982] Starting subtest: single-wait-all-signaled
[242.567271] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[242.673928] [062/132] (779s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[242.743747] Starting subtest: saturated-hostile-nopreempt
[242.746343] Starting dynamic subtest: rcs0
[242.806308] Dynamic subtest rcs0: SKIP (0.060s)
[242.818463] Starting dynamic subtest: bcs0
[242.832463] Dynamic subtest bcs0: SKIP (0.024s)
[242.841980] Starting dynamic subtest: vcs0
[242.849083] Dynamic subtest vcs0: SKIP (0.014s)
[242.858673] Starting dynamic subtest: vcs1
[242.868379] Dynamic subtest vcs1: SKIP (0.020s)
[242.877322] Starting dynamic subtest: vecs0
[242.889430] Dynamic subtest vecs0: SKIP (0.020s)
[242.899139] Starting dynamic subtest: ccs0
[242.910472] Dynamic subtest ccs0: SKIP (0.020s)
[242.915131] Subtest saturated-hostile-nopreempt: SKIP (0.165s)
[242.988513] [063/132] (779s left) sysfs_heartbeat_interval (mixed)
[243.048650] Starting subtest: mixed
[243.051067] Starting dynamic subtest: vecs0
[248.280778] Dynamic subtest vecs0: SUCCESS (5.231s)
[248.293083] Starting dynamic subtest: ccs0
[253.464490] Dynamic subtest ccs0: SUCCESS (5.182s)
[253.475001] Starting dynamic subtest: vcs0
[258.655913] Dynamic subtest vcs0: SUCCESS (5.189s)
[258.667726] Starting dynamic subtest: bcs0
[263.816579] Dynamic subtest bcs0: SUCCESS (5.158s)
[263.831400] Starting dynamic subtest: rcs0
[269.042907] Dynamic subtest rcs0: SUCCESS (5.222s)
[269.055176] Starting dynamic subtest: vcs1
[274.272098] Dynamic subtest vcs1: SUCCESS (5.226s)
[274.274563] Subtest mixed: SUCCESS (31.220s)
[274.376899] [064/132] (748s left) perf_pmu (all-busy-check-all)
[274.421054] Starting subtest: all-busy-check-all
[276.347426] Subtest all-busy-check-all: SUCCESS (1.924s)
[276.454514] [065/132] (746s left) kms_plane (planar-pixel-format-settings)
[276.561652] Starting subtest: planar-pixel-format-settings
[276.630968] Subtest planar-pixel-format-settings: SUCCESS (0.070s)
[276.737622] [066/132] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[276.833500] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[283.940647] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.108s)
[284.067847] [067/132] (738s left) kms_atomic_transition (modeset-transition-fencing)
[284.156783] Starting subtest: modeset-transition-fencing
[284.158749] Starting dynamic subtest: 1x-outputs
[295.762638] Dynamic subtest 1x-outputs: SUCCESS (11.603s)
[295.765250] Subtest modeset-transition-fencing: SUCCESS (11.605s)
[296.139216] [068/132] (726s left) kms_cursor_legacy (forked-bo)
[296.257500] Starting subtest: forked-bo
[296.259487] Starting dynamic subtest: pipe-A
[301.722879] Dynamic subtest pipe-A: SUCCESS (5.462s)
[301.736754] Starting dynamic subtest: pipe-B
[307.207641] Dynamic subtest pipe-B: SUCCESS (5.481s)
[307.221293] Starting dynamic subtest: pipe-C
[312.677876] Dynamic subtest pipe-C: SUCCESS (5.466s)
[312.691369] Starting dynamic subtest: pipe-D
[318.147060] Dynamic subtest pipe-D: SUCCESS (5.465s)
[318.159431] Starting dynamic subtest: all-pipes
[323.638764] Dynamic subtest all-pipes: SUCCESS (5.487s)
[323.641191] Subtest forked-bo: SUCCESS (27.372s)
[323.784316] [069/132] (698s left) gem_exec_reloc (basic-cpu)
[323.848801] Subtest basic-cpu: SKIP (0.000s)
[323.916661] [070/132] (698s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[323.966168] Starting subtest: y-tiled-to-vebox-x-tiled
[323.970600] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[324.155524] [071/132] (698s left) gem_eio (execbuf)
[324.344870] Starting subtest: execbuf
[324.633823] Subtest execbuf: SUCCESS (0.291s)
[324.796682] [072/132] (698s left) kms_async_flips (async-flip-suspend-resume)
[324.885945] Starting subtest: async-flip-suspend-resume
[325.260403] Starting dynamic subtest: pipe-A-eDP-1
[342.404683] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.908s)
[342.803494] Starting dynamic subtest: pipe-B-eDP-1
[360.408637] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.819s)
[360.794652] Starting dynamic subtest: pipe-C-eDP-1
[378.419333] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.834s)
[378.801339] Starting dynamic subtest: pipe-D-eDP-1
[396.408166] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.831s)
[396.410717] Subtest async-flip-suspend-resume: SUCCESS (12.892s)
[397.611733] [073/132] (625s left) kms_flip (plain-flip-ts-check)
[397.719023] Starting subtest: plain-flip-ts-check
[397.721930] Starting dynamic subtest: A-eDP1
[418.421806] Dynamic subtest A-eDP1: SUCCESS (20.506s)
[418.433868] Starting dynamic subtest: B-eDP1
[427.292254] Dynamic subtest B-eDP1: SUCCESS (8.855s)
[427.304376] Starting dynamic subtest: C-eDP1
[436.110813] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[436.121406] Starting dynamic subtest: D-eDP1
[444.943846] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[444.949977] Subtest plain-flip-ts-check: SUCCESS (47.017s)
[446.123301] [074/132] (576s left) prime_vgem (sync)
[446.192919] Starting subtest: sync
[446.195728] Starting dynamic subtest: rcs0
[446.244040] Dynamic subtest rcs0: SUCCESS (0.051s)
[446.255548] Starting dynamic subtest: bcs0
[446.310101] Dynamic subtest bcs0: SUCCESS (0.065s)
[446.320830] Starting dynamic subtest: vcs0
[446.358671] Dynamic subtest vcs0: SUCCESS (0.048s)
[446.371163] Starting dynamic subtest: vcs1
[446.406069] Dynamic subtest vcs1: SUCCESS (0.046s)
[446.417222] Starting dynamic subtest: vecs0
[446.451865] Dynamic subtest vecs0: SUCCESS (0.045s)
[446.462890] Starting dynamic subtest: ccs0
[446.497673] Dynamic subtest ccs0: SUCCESS (0.045s)
[446.500273] Subtest sync: SUCCESS (0.306s)
[446.618583] [075/132] (576s left) kms_psr (psr2-primary-blt)
[446.705811] Starting subtest: psr2-primary-blt
[446.708634] Starting dynamic subtest: eDP-1
[448.428568] Dynamic subtest eDP-1: SUCCESS (1.723s)
[448.430945] Subtest psr2-primary-blt: SUCCESS (1.724s)
[449.300281] [076/132] (573s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[449.393379] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[450.040330] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[450.196591] [077/132] (572s left) gem_exec_schedule (preempt-engines)
[450.276761] Starting subtest: preempt-engines
[450.279220] Starting dynamic subtest: rcs0
[452.537027] Dynamic subtest rcs0: SUCCESS (2.269s)
[452.553002] Starting dynamic subtest: bcs0
[454.792994] Dynamic subtest bcs0: SUCCESS (2.254s)
[454.806008] Starting dynamic subtest: vcs0
[457.132089] Dynamic subtest vcs0: SUCCESS (2.336s)
[457.144916] Starting dynamic subtest: vcs1
[459.470179] Dynamic subtest vcs1: SUCCESS (2.336s)
[459.480320] Starting dynamic subtest: vecs0
[461.782445] Dynamic subtest vecs0: SUCCESS (2.309s)
[461.792942] Starting dynamic subtest: ccs0
[464.102098] Dynamic subtest ccs0: SUCCESS (2.316s)
[464.105066] Subtest preempt-engines: SUCCESS (13.831s)
[464.417752] [078/132] (558s left) dmabuf_sync_file (import-multiple-read-only)
[464.463810] Starting subtest: import-multiple-read-only
[464.466709] Subtest import-multiple-read-only: SUCCESS (0.003s)
[464.522270] [079/132] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[464.638893] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[468.885071] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.247s)
[470.011395] [080/132] (553s left) kms_invalid_mode (bad-htotal)
[470.115085] Starting subtest: bad-htotal
[470.117549] Starting dynamic subtest: pipe-A-eDP-1
[470.400997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[470.411037] Starting dynamic subtest: pipe-B-eDP-1
[470.413225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[470.422594] Starting dynamic subtest: pipe-C-eDP-1
[470.424900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[470.434711] Starting dynamic subtest: pipe-D-eDP-1
[470.437093] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[470.439905] Subtest bad-htotal: SUCCESS (0.294s)
[471.217704] [081/132] (552s left) perf (gen12-unprivileged-single-ctx-counters)
[471.335282] Starting subtest: gen12-unprivileged-single-ctx-counters
[471.337697] Starting dynamic subtest: rcs0
[471.548806] Dynamic subtest rcs0: SUCCESS (0.214s)
[471.551820] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.216s)
[471.599864] [082/132] (551s left) syncobj_basic (bad-pad-handle-to-fd)
[471.677059] Starting subtest: bad-pad-handle-to-fd
[471.679908] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[471.779363] [083/132] (551s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[471.887728] Starting subtest: psr2-plane-move-sf-dmg-area
[471.889965] Starting dynamic subtest: pipe-A-eDP-1
[476.455039] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.570s)
[476.466093] Starting dynamic subtest: pipe-B-eDP-1
[481.780801] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.323s)
[481.783764] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.895s)
[482.653844] [084/132] (540s left) kms_cursor_edge_walk (128x128-top-edge)
[482.756807] Starting subtest: 128x128-top-edge
[482.759635] Starting dynamic subtest: pipe-A-eDP-1
[486.229850] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[486.240865] Starting dynamic subtest: pipe-D-eDP-1
[489.349867] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[489.352668] Subtest 128x128-top-edge: SUCCESS (6.591s)
[490.164690] [085/132] (533s left) kms_psr (psr-sprite-plane-onoff)
[490.267565] Starting subtest: psr-sprite-plane-onoff
[490.270461] Starting dynamic subtest: eDP-1
[492.006913] Dynamic subtest eDP-1: SUCCESS (1.737s)
[492.009777] Subtest psr-sprite-plane-onoff: SUCCESS (1.738s)
[492.831092] [086/132] (530s left) gem_exec_schedule (fifo)
[492.899250] Starting subtest: fifo
[492.901961] Starting dynamic subtest: rcs0
[492.984689] Dynamic subtest rcs0: SUCCESS (0.095s)
[492.998608] Starting dynamic subtest: vcs0
[493.072392] Dynamic subtest vcs0: SUCCESS (0.087s)
[493.087400] Starting dynamic subtest: vcs1
[493.151665] Dynamic subtest vcs1: SUCCESS (0.078s)
[493.165094] Starting dynamic subtest: vecs0
[493.231834] Dynamic subtest vecs0: SUCCESS (0.080s)
[493.245392] Starting dynamic subtest: ccs0
[493.321696] Dynamic subtest ccs0: SUCCESS (0.088s)
[493.324988] Subtest fifo: SUCCESS (0.434s)
[494.820455] [087/132] (528s left) gem_exec_params (batch-first)
[494.869435] Starting subtest: batch-first
[494.875900] Subtest batch-first: SUCCESS (0.007s)
[494.998439] [088/132] (528s left) gem_eio (create)
[495.226352] Starting subtest: create
[495.589063] Subtest create: SUCCESS (0.360s)
[495.742452] [089/132] (527s left) i915_drm_fdinfo (memory-info-active)
[495.786631] Starting subtest: memory-info-active
[495.789329] Starting dynamic subtest: smem0
[498.302352] Dynamic subtest smem0: SUCCESS (2.520s)
[498.304948] Subtest memory-info-active: SUCCESS (2.521s)
[498.380749] [090/132] (525s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[498.478574] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[498.483270] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[498.573378] [091/132] (525s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[498.896597] Starting subtest: cursor-rapid-movement-512x170
[498.900409] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[499.059447] [092/132] (524s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[499.142721] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[499.144620] Starting dynamic subtest: pipe-A-eDP-1
[499.166200] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.176758] Starting dynamic subtest: pipe-B-eDP-1
[499.197525] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.207564] Starting dynamic subtest: pipe-C-eDP-1
[499.230762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.240462] Starting dynamic subtest: pipe-D-eDP-1
[499.264370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.268745] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[501.307214] [093/132] (522s left) kms_rotation_crc (bad-tiling)
[501.394349] Starting subtest: bad-tiling
[501.398851] Subtest bad-tiling: SKIP (0.001s)
[501.483288] [094/132] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[501.582190] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[501.587468] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[501.681867] [095/132] (522s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[501.765704] Starting subtest: coverage-vs-premult-vs-constant
[502.057942] Starting dynamic subtest: pipe-A-eDP-1
[502.637213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[502.647921] Starting dynamic subtest: pipe-D-eDP-1
[503.917513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[503.920115] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.152s)
[504.765889] [096/132] (519s left) gem_mmap_gtt (big-bo)
[504.835987] Subtest big-bo: SKIP (0.000s)
[504.891937] [097/132] (519s left) sw_sync (alloc_timeline)
[504.932874] Starting subtest: alloc_timeline
[504.935961] Subtest alloc_timeline: SUCCESS (0.000s)
[504.993308] [098/132] (519s left) kms_chamelium_hpd (dp-hpd-fast)
[505.366680] Subtest dp-hpd-fast: SKIP (0.000s)
[506.164859] [099/132] (517s left) core_getclient (basic)
[506.223417] Starting subtest: basic
[506.225969] Subtest basic: SUCCESS (0.000s)
[506.303191] [100/132] (517s left) kms_pm_rpm (basic-rte)
[506.347685] Starting subtest: basic-rte
[509.379922] Subtest basic-rte: SUCCESS (3.035s)
[511.208469] [101/132] (512s left) gem_exec_fence (syncobj-timeline-chain-engines)
[511.757731] Starting subtest: syncobj-timeline-chain-engines
[511.888021] Subtest syncobj-timeline-chain-engines: SUCCESS (0.130s)
[512.816416] [102/132] (511s left) core_setmaster_vs_auth
[513.008043] [103/132] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[513.115917] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[519.864988] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.751s)
[519.999565] [104/132] (504s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[520.120358] Starting subtest: cursorB-vs-flipA-toggle
[520.125444] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[520.266459] [105/132] (504s left) gem_spin_batch (resubmit)
[520.333048] Starting subtest: resubmit
[520.335434] Starting dynamic subtest: rcs0
[520.337920] Dynamic subtest rcs0: SUCCESS (0.007s)
[520.350670] Starting dynamic subtest: bcs0
[520.353080] Dynamic subtest bcs0: SUCCESS (0.003s)
[520.363566] Starting dynamic subtest: vcs0
[520.365869] Dynamic subtest vcs0: SUCCESS (0.003s)
[520.376599] Starting dynamic subtest: vcs1
[520.378855] Dynamic subtest vcs1: SUCCESS (0.004s)
[520.388991] Starting dynamic subtest: vecs0
[520.391546] Dynamic subtest vecs0: SUCCESS (0.003s)
[520.401609] Starting dynamic subtest: ccs0
[520.403869] Dynamic subtest ccs0: SUCCESS (0.003s)
[520.406262] Subtest resubmit: SUCCESS (0.028s)
[520.581408] [106/132] (503s left) kms_panel_fitting (legacy)
[520.676948] Starting subtest: legacy
[520.679760] Starting dynamic subtest: pipe-A-eDP-1
[521.266673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[521.295746] Starting dynamic subtest: pipe-B-eDP-1
[522.943850] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.657s)
[522.972362] Starting dynamic subtest: pipe-C-eDP-1
[524.519634] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s)
[524.546247] Starting dynamic subtest: pipe-D-eDP-1
[526.051052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[526.054106] Subtest legacy: SUCCESS (5.376s)
[527.254386] [107/132] (497s left) gen9_exec_parse (bb-start-out)
[527.317079] Subtest bb-start-out: SKIP (0.000s)
[527.408858] [108/132] (497s left) gem_render_copy_redux (normal)
[527.461673] Starting subtest: normal
[527.774880] Subtest normal: SUCCESS (0.312s)
[527.914541] [109/132] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[528.016345] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[528.021792] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[528.116514] [110/132] (496s left) gem_ccs (ctrl-surf-copy-new-ctx)
[528.171802] Starting subtest: ctrl-surf-copy-new-ctx
[528.176918] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[528.273425] [111/132] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[528.369686] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[528.373760] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[528.459822] [112/132] (496s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[528.555064] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[528.557077] Starting dynamic subtest: pipe-A-eDP-1
[528.577746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.588897] Starting dynamic subtest: pipe-B-eDP-1
[528.609786] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.619309] Starting dynamic subtest: pipe-C-eDP-1
[528.640234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.649628] Starting dynamic subtest: pipe-D-eDP-1
[528.672778] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.676920] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[530.725568] [113/132] (494s left) gem_exec_whisper (basic-contexts-forked-all)
[530.798944] Starting subtest: basic-contexts-forked-all
[553.841091] Subtest basic-contexts-forked-all: SUCCESS (23.036s)
[554.028700] [114/132] (470s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[554.122766] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[554.125470] Starting dynamic subtest: pipe-A-eDP-1
[554.135914] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[554.147826] Starting dynamic subtest: pipe-B-eDP-1
[554.158071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[554.169071] Starting dynamic subtest: pipe-C-eDP-1
[554.179529] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[554.190113] Starting dynamic subtest: pipe-D-eDP-1
[554.200997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[554.206494] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[556.368735] [115/132] (468s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[556.469961] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[556.500115] Starting dynamic subtest: pipe-A-plane-0
[557.234947] Dynamic subtest pipe-A-plane-0: SUCCESS (0.733s)
[557.247400] Starting dynamic subtest: pipe-A-plane-3
[557.688612] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[558.755789] Starting dynamic subtest: pipe-B-plane-0
[559.490803] Dynamic subtest pipe-B-plane-0: SUCCESS (0.744s)
[559.501732] Starting dynamic subtest: pipe-B-plane-3
[559.990524] Dynamic subtest pipe-B-plane-3: SUCCESS (0.499s)
[560.312987] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.841s)
[561.142184] [116/132] (463s left) gem_close (many-handles-one-vma)
[561.215891] Starting subtest: many-handles-one-vma
[561.247690] Subtest many-handles-one-vma: SUCCESS (0.033s)
[561.363493] [117/132] (463s left) kms_vblank (query-forked-busy)
[561.466073] Starting subtest: query-forked-busy
[561.468728] Starting dynamic subtest: pipe-A-eDP-1
[563.343980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[563.360541] Starting dynamic subtest: pipe-D-eDP-1
[565.900578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[565.903356] Subtest query-forked-busy: SUCCESS (4.435s)
[566.701473] [118/132] (458s left) i915_pm_rpm (gem-mmap-type)
[568.837276] Starting subtest: gem-mmap-type
[568.839864] Starting dynamic subtest: wb-smem0
[572.620934] Dynamic subtest wb-smem0: SUCCESS (3.784s)
[572.634209] Starting dynamic subtest: wc-smem0
[575.812839] Dynamic subtest wc-smem0: SUCCESS (3.190s)
[575.824228] Starting dynamic subtest: uc-smem0
[579.003419] Dynamic subtest uc-smem0: SUCCESS (3.190s)
[579.006273] Subtest gem-mmap-type: SUCCESS (10.167s)
[579.093050] [119/132] (445s left) syncobj_timeline (invalid-signal-illegal-point)
[579.143816] Starting subtest: invalid-signal-illegal-point
[579.146068] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[579.244596] [120/132] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[579.340900] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[579.345782] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[579.442930] [121/132] (445s left) kms_prop_blob (invalid-set-prop-any)
[579.503078] Starting subtest: invalid-set-prop-any
[579.505663] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[579.591638] [122/132] (445s left) i915_selftest (live)
[582.266213] Starting subtest: live
[582.268679] Starting dynamic subtest: sanitycheck
[585.788873] Dynamic subtest sanitycheck: SUCCESS (3.521s)
[585.799074] Starting dynamic subtest: uncore
[589.332682] Dynamic subtest uncore: SUCCESS (3.541s)
[589.342321] Starting dynamic subtest: workarounds
[593.318340] Dynamic subtest workarounds: SUCCESS (3.983s)
[593.333889] Starting dynamic subtest: gt_engines
[597.238561] Dynamic subtest gt_engines: SUCCESS (3.917s)
[597.249482] Starting dynamic subtest: gt_timelines
[613.668544] Dynamic subtest gt_timelines: SUCCESS (16.423s)
[613.678868] Starting dynamic subtest: gt_contexts
[617.282226] Dynamic subtest gt_contexts: SUCCESS (3.612s)
[617.292844] Starting dynamic subtest: gt_lrc
[622.434915] Dynamic subtest gt_lrc: SUCCESS (5.151s)
[622.445626] Starting dynamic subtest: gt_mocs
[626.338359] Dynamic subtest gt_mocs: SUCCESS (3.903s)
[626.347400] Starting dynamic subtest: gt_pm
[631.996339] Dynamic subtest gt_pm: SUCCESS (5.658s)
[632.007640] Starting dynamic subtest: gt_heartbeat
[637.118306] Dynamic subtest gt_heartbeat: SUCCESS (5.122s)
[637.128453] Starting dynamic subtest: gt_tlb
[647.387565] Dynamic subtest gt_tlb: SUCCESS (10.257s)
[647.395439] Starting dynamic subtest: requests
[659.951243] Dynamic subtest requests: SUCCESS (12.576s)
[659.961338] Starting dynamic subtest: migrate
[668.548051] Dynamic subtest migrate: SUCCESS (8.595s)
[668.557057] Starting dynamic subtest: active
[673.697072] Dynamic subtest active: SUCCESS (5.148s)
[673.707468] Starting dynamic subtest: objects
[678.013131] Dynamic subtest objects: SUCCESS (4.314s)
[678.030308] Starting dynamic subtest: mman
[682.198686] Dynamic subtest mman: SUCCESS (4.183s)
[682.215275] Starting dynamic subtest: dmabuf
[685.820377] Dynamic subtest dmabuf: SUCCESS (3.620s)
[685.830938] Starting dynamic subtest: vma
[691.009080] Dynamic subtest vma: SUCCESS (5.186s)
[691.019186] Starting dynamic subtest: coherency
[695.370068] Dynamic subtest coherency: SUCCESS (4.359s)
[695.380091] Starting dynamic subtest: gtt
[706.051709] Dynamic subtest gtt: SUCCESS (10.678s)
[706.063668] Starting dynamic subtest: gem
[712.387602] Dynamic subtest gem: SUCCESS (6.334s)
[712.398007] Starting dynamic subtest: evict
[717.275429] Dynamic subtest evict: SUCCESS (4.885s)
[717.285981] Starting dynamic subtest: hugepages
[726.908327] Dynamic subtest hugepages: SUCCESS (9.630s)
[726.918863] Starting dynamic subtest: gem_contexts
[754.408615] Dynamic subtest gem_contexts: SUCCESS (27.494s)
[754.419123] Starting dynamic subtest: client
[758.040446] Dynamic subtest client: SUCCESS (3.630s)
[758.050845] Starting dynamic subtest: gem_migrate
[761.594081] Dynamic subtest gem_migrate: SUCCESS (3.551s)
[761.604462] Starting dynamic subtest: reset
[767.065985] Dynamic subtest reset: SUCCESS (5.469s)
[767.076801] Starting dynamic subtest: memory_region
[770.582076] Dynamic subtest memory_region: SUCCESS (3.514s)
[770.590908] Starting dynamic subtest: hangcheck
[784.518536] Dynamic subtest hangcheck: SUCCESS (13.931s)
[784.529007] Starting dynamic subtest: execlists
[789.683067] Dynamic subtest execlists: SUCCESS (5.162s)
[789.693548] Starting dynamic subtest: ring_submission
[793.241338] Dynamic subtest ring_submission: SUCCESS (3.556s)
[793.250808] Starting dynamic subtest: perf
[797.360188] Dynamic subtest perf: SUCCESS (4.117s)
[797.369795] Starting dynamic subtest: slpc
[810.327104] Dynamic subtest slpc: SUCCESS (12.961s)
[810.337605] Starting dynamic subtest: guc
[815.044071] Dynamic subtest guc: SUCCESS (4.714s)
[815.055000] Starting dynamic subtest: guc_multi_lrc
[818.599063] Dynamic subtest guc_multi_lrc: SUCCESS (3.553s)
[818.608270] Starting dynamic subtest: guc_hang
[824.310793] Dynamic subtest guc_hang: SUCCESS (5.708s)
[824.325008] Starting dynamic subtest: late_gt_pm
[827.887083] Dynamic subtest late_gt_pm: SUCCESS (3.574s)
[827.889994] Subtest live: SUCCESS (245.592s)
[827.920900] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[827.921661] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[827.925432] [123/132] (197s left) kms_getfb (getfb2-accept-nv12)
[830.369736] Starting subtest: getfb2-accept-nv12
[830.372692] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[830.458003] [FACT kms_getfb (getfb2-accept-nv12)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[830.459342] [FACT kms_getfb (getfb2-accept-nv12)] new: kernel.kmod_is_loaded.i915: true
[830.463491] [124/132] (194s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[830.523195] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[830.525846] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[830.625571] [125/132] (194s left) gem_readwrite (read-write)
[830.677357] Subtest read-write: SKIP (0.000s)
[830.739844] [126/132] (194s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[830.795921] Subtest untiled-to-tiled: SKIP (0.000s)
[830.872548] [127/132] (194s left) kms_cursor_crc (cursor-onscreen-32x32)
[831.013272] Starting subtest: cursor-onscreen-32x32
[831.062904] Subtest cursor-onscreen-32x32: SKIP (0.045s)
[831.328940] [128/132] (194s left) gem_eio (in-flight-10ms)
[831.479689] Starting subtest: in-flight-10ms
[838.743897] Subtest in-flight-10ms: SUCCESS (7.259s)
[838.863277] [129/132] (186s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[838.960293] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[838.964627] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[839.053429] [130/132] (186s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[839.142289] Starting subtest: bo-too-small-due-to-tiling
[839.147618] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[839.249780] [131/132] (186s left) gen7_exec_parse (basic-allowed)
[839.311582] Subtest basic-allowed: SKIP (0.000s)
[839.381514] [132/132] (186s left) kms_big_fb (linear-16bpp-rotate-0)
[839.482444] Starting subtest: linear-16bpp-rotate-0
[840.927789] Subtest linear-16bpp-rotate-0: SUCCESS (1.445s)
[841.046343] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: gem_eio
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: prime_mmap_coherency
results: parsing output: 9/ for test: syncobj_eventfd
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_force_connector_basic
results: parsing output: 14/ for test: gem_flink_basic
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_flink_race
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_ccs
results: parsing output: 25/ for test: gem_exec_suspend
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_sequence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_dsc
results: parsing output: 43/ for test: kms_content_protection
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_flush
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_partial_pwrite_pread
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_invalid_mode
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_cursor_edge_walk
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_alpha_blend
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: core_getclient
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: core_setmaster_vs_auth
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_panel_fitting
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: gem_render_copy_redux
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: gem_close
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: i915_selftest
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_readwrite
results: parsing output: 125/ for test: gem_set_tiling_vs_blt
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_big_fb
Done.