[59.625638] Initializing watchdogs
[59.625686]   /dev/watchdog0
[59.640785] [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.645658] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.648343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.652179] [001/132] (960s left) kms_psr (psr-primary-blt)
[59.777465] Starting subtest: psr-primary-blt
[59.779879] Starting dynamic subtest: eDP-1
[61.531301] Dynamic subtest eDP-1: SUCCESS (1.744s)
[61.533758] Subtest psr-primary-blt: SUCCESS (1.745s)
[62.386635] [002/132] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[62.491439] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[62.495738] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[62.585225] [003/132] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[62.680859] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[67.285484] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.593s)
[68.412627] [004/132] (951s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[68.511648] Starting subtest: crc-primary-basic-y-tiled-ccs
[68.513929] Starting dynamic subtest: pipe-A-eDP-1
[68.536515] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.544818] Starting dynamic subtest: pipe-B-eDP-1
[68.566272] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.573915] Starting dynamic subtest: pipe-C-eDP-1
[68.595337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.602367] Starting dynamic subtest: pipe-D-eDP-1
[68.624033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.628064] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[70.682297] [005/132] (949s left) kms_cursor_crc (cursor-sliding-32x32)
[70.832096] Starting subtest: cursor-sliding-32x32
[70.879988] Subtest cursor-sliding-32x32: SKIP (0.042s)
[71.144832] [006/132] (949s left) gem_exec_schedule (preempt-self)
[71.222473] Starting subtest: preempt-self
[71.224784] Starting dynamic subtest: rcs0
[71.237056] Dynamic subtest rcs0: SUCCESS (0.019s)
[71.247083] Starting dynamic subtest: bcs0
[71.259728] Dynamic subtest bcs0: SUCCESS (0.022s)
[71.271200] Starting dynamic subtest: vcs0
[71.282886] Dynamic subtest vcs0: SUCCESS (0.023s)
[71.290753] Starting dynamic subtest: vcs1
[71.299531] Dynamic subtest vcs1: SUCCESS (0.016s)
[71.307270] Starting dynamic subtest: vecs0
[71.318073] Dynamic subtest vecs0: SUCCESS (0.018s)
[71.325862] Starting dynamic subtest: ccs0
[71.334856] Dynamic subtest ccs0: SUCCESS (0.016s)
[71.337142] Subtest preempt-self: SUCCESS (0.117s)
[73.014569] [007/132] (947s left) gem_exec_whisper (basic-fds-priority)
[73.080467] Starting subtest: basic-fds-priority
[97.011431] Subtest basic-fds-priority: SUCCESS (23.917s)
[97.198168] [008/132] (923s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[97.316198] Starting subtest: yf-tiled-16bpp-rotate-0
[97.320393] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[97.417047] [009/132] (923s left) i915_pm_rc6_residency (media-rc6-accuracy)
[97.467079] Starting subtest: media-rc6-accuracy
[97.471471] Subtest media-rc6-accuracy: SKIP (0.000s)
[97.572738] [010/132] (922s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[97.665439] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[104.770773] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.106s)
[104.869191] [011/132] (915s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[104.917660] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[104.956691] [012/132] (915s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[105.007982] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[105.064859] [013/132] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[105.179932] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[105.184453] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[105.279985] [014/132] (915s left) kms_cursor_legacy (forked-bo)
[105.400625] Starting subtest: forked-bo
[105.402713] Starting dynamic subtest: pipe-A
[110.891084] Dynamic subtest pipe-A: SUCCESS (5.486s)
[110.902172] Starting dynamic subtest: pipe-B
[116.369345] Dynamic subtest pipe-B: SUCCESS (5.473s)
[116.381616] Starting dynamic subtest: pipe-C
[121.828753] Dynamic subtest pipe-C: SUCCESS (5.460s)
[121.839240] Starting dynamic subtest: pipe-D
[127.300097] Dynamic subtest pipe-D: SUCCESS (5.470s)
[127.310591] Starting dynamic subtest: all-pipes
[132.780185] Dynamic subtest all-pipes: SUCCESS (5.479s)
[132.782680] Subtest forked-bo: SUCCESS (27.372s)
[132.919574] [015/132] (887s left) perf_pmu (busy-accuracy-50)
[132.968859] Starting subtest: busy-accuracy-50
[132.971428] Starting dynamic subtest: rcs0
[134.508910] Dynamic subtest rcs0: SUCCESS (1.537s)
[134.519758] Starting dynamic subtest: bcs0
[136.055297] Dynamic subtest bcs0: SUCCESS (1.545s)
[136.066030] Starting dynamic subtest: vcs0
[137.599313] Dynamic subtest vcs0: SUCCESS (1.543s)
[137.610250] Starting dynamic subtest: vcs1
[139.140727] Dynamic subtest vcs1: SUCCESS (1.540s)
[139.151112] Starting dynamic subtest: vecs0
[140.683667] Dynamic subtest vecs0: SUCCESS (1.541s)
[140.694783] Starting dynamic subtest: ccs0
[142.230320] Dynamic subtest ccs0: SUCCESS (1.546s)
[142.232754] Subtest busy-accuracy-50: SUCCESS (9.259s)
[142.362455] [016/132] (878s left) kms_psr (fbc-pr-basic)
[142.462538] Starting subtest: fbc-pr-basic
[142.466566] Subtest fbc-pr-basic: SKIP (0.000s)
[142.538451] [017/132] (878s left) prime_mmap (test_errors)
[142.602608] Starting subtest: test_errors
[142.604528] Starting dynamic subtest: test_errors-smem
[142.702575] Dynamic subtest test_errors-smem: SUCCESS (0.101s)
[142.705479] Subtest test_errors: SUCCESS (0.101s)
[142.796975] [018/132] (878s left) gem_mmap_wc (bad-object)
[142.862087] Subtest bad-object: SKIP (0.000s)
[142.923773] [019/132] (877s left) kms_lease (empty-lease)
[143.014032] Starting subtest: empty-lease
[143.016336] Starting dynamic subtest: pipe-A-eDP-1
[143.018702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[143.028613] Starting dynamic subtest: pipe-B-eDP-1
[143.030441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[143.038634] Starting dynamic subtest: pipe-C-eDP-1
[143.040472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[143.048533] Starting dynamic subtest: pipe-D-eDP-1
[143.050387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[143.052224] Subtest empty-lease: SUCCESS (0.007s)
[143.127104] [020/132] (877s left) i915_selftest (live)
[144.935713] Starting subtest: live
[144.938127] Starting dynamic subtest: sanitycheck
[149.253919] Dynamic subtest sanitycheck: SUCCESS (4.318s)
[149.263306] Starting dynamic subtest: uncore
[153.572749] Dynamic subtest uncore: SUCCESS (4.318s)
[153.581627] Starting dynamic subtest: workarounds
[156.602753] Dynamic subtest workarounds: SUCCESS (3.029s)
[156.611941] Starting dynamic subtest: gt_engines
[159.606223] Dynamic subtest gt_engines: SUCCESS (3.003s)
[159.615153] Starting dynamic subtest: gt_timelines
[175.170888] Dynamic subtest gt_timelines: SUCCESS (15.564s)
[175.180145] Starting dynamic subtest: gt_contexts
[179.544554] Dynamic subtest gt_contexts: SUCCESS (4.372s)
[179.556541] Starting dynamic subtest: gt_lrc
[183.887053] Dynamic subtest gt_lrc: SUCCESS (4.342s)
[183.896085] Starting dynamic subtest: gt_mocs
[186.905467] Dynamic subtest gt_mocs: SUCCESS (3.018s)
[186.914722] Starting dynamic subtest: gt_pm
[193.648787] Dynamic subtest gt_pm: SUCCESS (6.742s)
[193.657655] Starting dynamic subtest: gt_heartbeat
[197.939816] Dynamic subtest gt_heartbeat: SUCCESS (4.289s)
[197.948785] Starting dynamic subtest: gt_tlb
[207.277271] Dynamic subtest gt_tlb: SUCCESS (9.335s)
[207.286892] Starting dynamic subtest: requests
[220.695065] Dynamic subtest requests: SUCCESS (13.417s)
[220.704658] Starting dynamic subtest: migrate
[228.393532] Dynamic subtest migrate: SUCCESS (7.696s)
[228.402617] Starting dynamic subtest: active
[231.116728] Dynamic subtest active: SUCCESS (2.722s)
[231.126225] Starting dynamic subtest: objects
[235.891635] Dynamic subtest objects: SUCCESS (4.773s)
[235.900725] Starting dynamic subtest: mman
[240.645453] Dynamic subtest mman: SUCCESS (4.753s)
[240.655519] Starting dynamic subtest: dmabuf
[243.550758] Dynamic subtest dmabuf: SUCCESS (2.904s)
[243.560164] Starting dynamic subtest: vma
[247.890207] Dynamic subtest vma: SUCCESS (4.337s)
[247.899671] Starting dynamic subtest: coherency
[252.815235] Dynamic subtest coherency: SUCCESS (4.923s)
[252.824530] Starting dynamic subtest: gtt
[262.572435] Dynamic subtest gtt: SUCCESS (9.755s)
[262.581795] Starting dynamic subtest: gem
[268.634044] Dynamic subtest gem: SUCCESS (6.060s)
[268.644570] Starting dynamic subtest: evict
[272.710111] Dynamic subtest evict: SUCCESS (4.075s)
[272.719460] Starting dynamic subtest: hugepages
[283.534702] Dynamic subtest hugepages: SUCCESS (10.822s)
[283.544272] Starting dynamic subtest: gem_contexts
[312.718983] Dynamic subtest gem_contexts: SUCCESS (29.183s)
[312.728649] Starting dynamic subtest: client
[317.042865] Dynamic subtest client: SUCCESS (4.323s)
[317.052845] Starting dynamic subtest: gem_migrate
[319.761728] Dynamic subtest gem_migrate: SUCCESS (2.718s)
[319.771295] Starting dynamic subtest: reset
[322.492111] Dynamic subtest reset: SUCCESS (2.728s)
[322.507670] Starting dynamic subtest: memory_region
[325.195191] Dynamic subtest memory_region: SUCCESS (2.701s)
[325.204826] Starting dynamic subtest: hangcheck
[338.135661] Dynamic subtest hangcheck: SUCCESS (12.938s)
[338.145148] Starting dynamic subtest: execlists
[342.481743] Dynamic subtest execlists: SUCCESS (4.344s)
[342.490812] Starting dynamic subtest: ring_submission
[346.809203] Dynamic subtest ring_submission: SUCCESS (4.326s)
[346.818779] Starting dynamic subtest: perf
[351.184934] Dynamic subtest perf: SUCCESS (4.372s)
[351.194092] Starting dynamic subtest: slpc
[365.222146] Dynamic subtest slpc: SUCCESS (14.035s)
[365.230857] Starting dynamic subtest: guc
[369.224287] Dynamic subtest guc: SUCCESS (4.001s)
[369.233703] Starting dynamic subtest: guc_multi_lrc
[373.574178] Dynamic subtest guc_multi_lrc: SUCCESS (4.348s)
[373.583380] Starting dynamic subtest: guc_hang
[378.413581] Dynamic subtest guc_hang: SUCCESS (4.837s)
[378.423642] Starting dynamic subtest: late_gt_pm
[381.128238] Dynamic subtest late_gt_pm: SUCCESS (2.713s)
[381.130922] Subtest live: SUCCESS (236.184s)
[381.157969] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[381.161855] [021/132] (639s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[382.708281] Starting subtest: bad-pixel-format-yf-tiled-ccs
[382.710567] Starting dynamic subtest: pipe-A-eDP-1
[382.733727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[382.743715] Starting dynamic subtest: pipe-B-eDP-1
[382.766394] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[382.774809] Starting dynamic subtest: pipe-C-eDP-1
[382.796082] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[382.803395] Starting dynamic subtest: pipe-D-eDP-1
[382.825078] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[382.829473] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.010s)
[385.035652] [FACT kms_ccs (bad-pixel-format-yf-tiled-ccs)] new: kernel.kmod_is_loaded.i915: true
[385.039482] [022/132] (635s left) gem_ppgtt (blt-vs-render-ctx0)
[385.118253] Starting subtest: blt-vs-render-ctx0
[418.321312] Subtest blt-vs-render-ctx0: SUCCESS (33.198s)
[418.455529] [023/132] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[418.595648] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[418.599854] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[418.708812] [024/132] (602s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[418.769910] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[418.772285] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[418.877153] [025/132] (602s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[418.936848] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[418.939292] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[419.053839] [026/132] (602s left) gem_exec_flush (basic-wb-prw-default)
[419.113451] Starting subtest: basic-wb-prw-default
[424.586968] Subtest basic-wb-prw-default: SUCCESS (5.473s)
[424.773921] [027/132] (596s left) perf_pmu (idle)
[424.822349] Starting subtest: idle
[424.824472] Starting dynamic subtest: rcs0
[425.377090] Dynamic subtest rcs0: SUCCESS (0.554s)
[425.388714] Starting dynamic subtest: bcs0
[425.903972] Dynamic subtest bcs0: SUCCESS (0.524s)
[425.915194] Starting dynamic subtest: vcs0
[426.429187] Dynamic subtest vcs0: SUCCESS (0.522s)
[426.440871] Starting dynamic subtest: vcs1
[426.951550] Dynamic subtest vcs1: SUCCESS (0.519s)
[426.962864] Starting dynamic subtest: vecs0
[427.472417] Dynamic subtest vecs0: SUCCESS (0.518s)
[427.484025] Starting dynamic subtest: ccs0
[427.988436] Dynamic subtest ccs0: SUCCESS (0.514s)
[427.991095] Subtest idle: SUCCESS (3.168s)
[428.095604] [028/132] (593s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[428.213167] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[428.590848] Starting dynamic subtest: pipe-A-eDP-1
[431.387099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.795s)
[431.747684] Starting dynamic subtest: pipe-B-eDP-1
[434.509260] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[434.871872] Starting dynamic subtest: pipe-C-eDP-1
[437.646151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s)
[438.018751] Starting dynamic subtest: pipe-D-eDP-1
[440.769088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[440.771695] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.556s)
[441.960459] [029/132] (579s left) kms_dsc (dsc-with-bpc-formats)
[442.059320] Starting subtest: dsc-with-bpc-formats
[442.171767] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[442.207776] [030/132] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[442.304427] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[449.680324] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s)
[449.816445] [031/132] (571s left) kms_flip (flip-vs-panning)
[449.926176] Starting subtest: flip-vs-panning
[449.928151] Starting dynamic subtest: A-eDP1
[458.714059] Dynamic subtest A-eDP1: SUCCESS (8.789s)
[458.726563] Starting dynamic subtest: B-eDP1
[467.446800] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[467.457698] Starting dynamic subtest: C-eDP1
[476.164212] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[476.173516] Starting dynamic subtest: D-eDP1
[484.899157] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[484.903812] Subtest flip-vs-panning: SUCCESS (34.979s)
[486.068673] [032/132] (535s left) kms_flip (flip-vs-expired-vblank)
[486.154352] Starting subtest: flip-vs-expired-vblank
[486.156794] Starting dynamic subtest: A-eDP1
[494.868510] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[494.878075] Starting dynamic subtest: B-eDP1
[503.505676] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[503.516229] Starting dynamic subtest: C-eDP1
[512.125581] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[512.134586] Starting dynamic subtest: D-eDP1
[520.760994] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[520.763459] Subtest flip-vs-expired-vblank: SUCCESS (34.608s)
[521.941774] [033/132] (499s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[522.126874] Starting subtest: cursor-rapid-movement-64x21
[522.171560] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[522.386319] [034/132] (499s left) kms_big_fb (x-tiled-addfb)
[522.492280] Starting subtest: x-tiled-addfb
[522.494465] Subtest x-tiled-addfb: SUCCESS (0.000s)
[522.590355] [035/132] (498s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[522.659633] Starting subtest: yf-tiled-ccs-to-x-tiled
[522.664216] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[522.853894] [036/132] (498s left) gem_ctx_persistence (engines-hang)
[522.911353] Starting subtest: engines-hang
[522.913935] Starting dynamic subtest: rcs0
[523.054925] Dynamic subtest rcs0: SUCCESS (0.143s)
[523.066394] Starting dynamic subtest: bcs0
[523.107841] Dynamic subtest bcs0: SUCCESS (0.051s)
[523.119021] Starting dynamic subtest: vcs0
[523.209693] Dynamic subtest vcs0: SUCCESS (0.100s)
[523.221319] Starting dynamic subtest: vcs1
[523.286707] Dynamic subtest vcs1: SUCCESS (0.075s)
[523.297675] Starting dynamic subtest: vecs0
[523.429281] Dynamic subtest vecs0: SUCCESS (0.140s)
[523.440879] Starting dynamic subtest: ccs0
[523.534809] Dynamic subtest ccs0: SUCCESS (0.103s)
[523.537505] Subtest engines-hang: SUCCESS (0.625s)
[523.619535] [037/132] (497s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[523.683384] Starting subtest: multi-wait-all-available-submitted-signaled
[523.685651] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[523.777225] [038/132] (497s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[523.885149] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[530.735054] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.852s)
[530.851752] [039/132] (490s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[530.973172] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[532.376300] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.403s)
[533.257734] [040/132] (488s left) api_intel_bb (simple-bb-ctx)
[533.319085] Starting subtest: simple-bb-ctx
[533.327135] Subtest simple-bb-ctx: SUCCESS (0.008s)
[533.435482] [041/132] (488s left) gem_mmap_gtt (flink-race)
[533.485124] Subtest flink-race: SKIP (0.000s)
[533.544388] [042/132] (488s left) gem_mmap (bad-object)
[533.594782] Subtest bad-object: SKIP (0.000s)
[533.655517] [043/132] (488s left) gem_exec_fence (syncobj-invalid-wait)
[534.154629] Starting subtest: syncobj-invalid-wait
[534.156763] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[535.969992] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[535.973998] [044/132] (485s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[536.074416] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[536.079168] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[537.180265] [045/132] (484s left) gem_wait (invalid-buf)
[537.245076] Starting subtest: invalid-buf
[537.247546] Subtest invalid-buf: SUCCESS (0.000s)
[537.448871] [046/132] (484s left) kms_cursor_crc (cursor-offscreen-512x512)
[537.728772] Starting subtest: cursor-offscreen-512x512
[537.733327] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[537.890309] [047/132] (484s left) gem_ctx_engines (execute-one)
[537.952082] Starting subtest: execute-one
[540.457105] Subtest execute-one: SUCCESS (2.505s)
[541.953451] [048/132] (480s left) kms_content_protection (atomic-dpms-hdcp14)
[542.092840] Starting subtest: atomic-dpms-hdcp14
[542.097246] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[542.204916] [049/132] (479s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[542.301086] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[542.305341] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[542.438709] [050/132] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[542.533358] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[542.537288] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[542.625749] [051/132] (479s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[542.685349] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[542.796361] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[542.873771] [052/132] (479s left) perf_pmu (rc6)
[542.913115] Starting subtest: rc6
[542.915492] Starting dynamic subtest: gt0
[549.277336] Dynamic subtest gt0: SUCCESS (6.364s)
[549.289189] Starting dynamic subtest: runtime-pm-gt0
[556.990120] Dynamic subtest runtime-pm-gt0: SUCCESS (7.710s)
[557.001868] Starting dynamic subtest: runtime-pm-long-gt0
[569.479381] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.486s)
[569.491773] Starting dynamic subtest: other-idle-gt0
[575.824221] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[575.836966] Starting dynamic subtest: gt1
[582.168115] Dynamic subtest gt1: SUCCESS (6.340s)
[582.180685] Starting dynamic subtest: runtime-pm-gt1
[589.645520] Dynamic subtest runtime-pm-gt1: SUCCESS (7.474s)
[589.657175] Starting dynamic subtest: runtime-pm-long-gt1
[602.134876] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.487s)
[602.144943] Starting dynamic subtest: other-idle-gt1
[608.483780] Dynamic subtest other-idle-gt1: SUCCESS (6.346s)
[608.487016] Subtest rc6: SUCCESS (65.570s)
[609.719518] [053/132] (412s left) vgem_slow (nohang)
[609.783468] Starting subtest: nohang
[620.149588] Subtest nohang: SUCCESS (10.364s)
[620.190169] [054/132] (402s left) i915_drm_fdinfo (most-busy-check-all)
[620.231064] Starting subtest: most-busy-check-all
[620.233199] Starting dynamic subtest: rcs0
[620.241104] Dynamic subtest rcs0: SKIP (0.008s)
[620.252859] Starting dynamic subtest: bcs0
[620.256859] Dynamic subtest bcs0: SKIP (0.000s)
[620.266433] Starting dynamic subtest: vcs0
[620.270764] Dynamic subtest vcs0: SKIP (0.000s)
[620.280077] Starting dynamic subtest: vcs1
[620.284228] Dynamic subtest vcs1: SKIP (0.000s)
[620.293089] Starting dynamic subtest: vecs0
[620.297276] Dynamic subtest vecs0: SKIP (0.000s)
[620.306217] Starting dynamic subtest: ccs0
[620.310325] Dynamic subtest ccs0: SKIP (0.000s)
[620.314552] Subtest most-busy-check-all: SKIP (0.014s)
[620.354338] [055/132] (401s left) perf (disabled-read-error)
[620.470519] Starting subtest: disabled-read-error
[620.493801] Subtest disabled-read-error: SUCCESS (0.023s)
[620.546747] [056/132] (401s left) kms_color (ctm-negative)
[620.670378] Starting subtest: ctm-negative
[620.672667] Starting dynamic subtest: pipe-A-eDP-1
[621.383837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[621.394899] Starting dynamic subtest: pipe-B-eDP-1
[622.782753] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[622.792793] Starting dynamic subtest: pipe-C-eDP-1
[624.138205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[624.148111] Starting dynamic subtest: pipe-D-eDP-1
[625.465715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[625.468144] Subtest ctm-negative: SUCCESS (4.797s)
[626.267126] [057/132] (396s left) kms_plane_alpha_blend (alpha-7efc)
[626.372078] Starting subtest: alpha-7efc
[626.665916] Starting dynamic subtest: pipe-A-eDP-1
[627.257299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[627.285904] Starting dynamic subtest: pipe-D-eDP-1
[628.591905] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[628.594416] Subtest alpha-7efc: SUCCESS (2.219s)
[629.428945] [058/132] (393s left) sysfs_preempt_timeout (idempotent)
[629.490511] Starting subtest: idempotent
[629.492748] Starting dynamic subtest: vecs0
[629.495100] Dynamic subtest vecs0: SUCCESS (0.000s)
[629.506057] Starting dynamic subtest: ccs0
[629.507884] Dynamic subtest ccs0: SUCCESS (0.000s)
[629.516800] Starting dynamic subtest: vcs0
[629.518722] Dynamic subtest vcs0: SUCCESS (0.000s)
[629.527845] Starting dynamic subtest: bcs0
[629.530115] Dynamic subtest bcs0: SUCCESS (0.000s)
[629.539155] Starting dynamic subtest: rcs0
[629.541407] Dynamic subtest rcs0: SUCCESS (0.000s)
[629.550496] Starting dynamic subtest: vcs1
[629.552808] Dynamic subtest vcs1: SUCCESS (0.000s)
[629.555070] Subtest idempotent: SUCCESS (0.007s)
[629.593956] [059/132] (392s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[629.690603] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[629.694804] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[629.741831] [060/132] (392s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[629.848963] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[630.863979] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.014s)
[630.950423] [061/132] (391s left) gem_workarounds (basic-read-context)
[631.019501] Starting subtest: basic-read-context
[631.029930] Subtest basic-read-context: SUCCESS (0.010s)
[631.124656] [062/132] (391s left) syncobj_wait (single-wait-for-submit-signaled)
[631.191698] Starting subtest: single-wait-for-submit-signaled
[631.193606] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[631.253851] [063/132] (391s left) gem_ctx_persistence (heartbeat-many)
[631.317790] Starting subtest: heartbeat-many
[631.321501] Subtest heartbeat-many: SKIP (0.000s)
[631.402914] [064/132] (391s left) kms_plane_multiple (2x-tiling-4)
[631.504063] Starting subtest: 2x-tiling-4
[631.507476] Subtest 2x-tiling-4: SKIP (0.000s)
[631.555938] [065/132] (391s left) kms_flip (2x-flip-vs-fences-interruptible)
[631.642040] Starting subtest: 2x-flip-vs-fences-interruptible
[631.645620] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[631.723029] [066/132] (391s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[631.777398] Starting subtest: yf-tiled-to-vebox-x-tiled
[631.781309] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[631.939590] [067/132] (390s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[632.314176] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[633.161039] [068/132] (389s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[633.253106] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[639.977058] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.725s)
[640.106695] [069/132] (382s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[642.035443] Starting subtest: dpms-mode-unset-lpsp
[648.377673] Subtest dpms-mode-unset-lpsp: SUCCESS (6.345s)
[648.724375] [070/132] (374s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[648.785169] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[648.787389] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[648.855414] [071/132] (374s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[648.941977] Starting subtest: fbc-psr2-cursor-mmap-gtt
[648.944199] Starting dynamic subtest: eDP-1
[648.948289] Dynamic subtest eDP-1: SKIP (0.000s)
[648.952433] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[648.992461] [072/132] (374s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[649.088072] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[649.092225] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[649.168536] [073/132] (373s left) gem_wait (await)
[649.248922] Starting subtest: await
[649.251439] Starting dynamic subtest: all-engines
[650.368929] Dynamic subtest all-engines: SUCCESS (1.119s)
[650.386847] Starting dynamic subtest: rcs0
[651.426492] Dynamic subtest rcs0: SUCCESS (1.055s)
[651.444839] Starting dynamic subtest: bcs0
[652.483236] Dynamic subtest bcs0: SUCCESS (1.055s)
[652.503418] Starting dynamic subtest: vcs0
[653.539454] Dynamic subtest vcs0: SUCCESS (1.054s)
[653.556282] Starting dynamic subtest: vcs1
[654.592656] Dynamic subtest vcs1: SUCCESS (1.051s)
[654.609547] Starting dynamic subtest: vecs0
[655.647235] Dynamic subtest vecs0: SUCCESS (1.052s)
[655.663681] Starting dynamic subtest: ccs0
[656.702781] Dynamic subtest ccs0: SUCCESS (1.053s)
[656.705733] Subtest await: SUCCESS (7.454s)
[656.881562] [074/132] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[656.985291] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[656.989603] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[657.064493] [075/132] (366s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[657.193717] Starting subtest: basic-flip-before-cursor-legacy
[658.125071] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.932s)
[658.942232] [076/132] (364s left) gem_exec_balancer (waits)
[659.003265] Starting subtest: waits
[665.571476] Subtest waits: SUCCESS (6.567s)
[665.848979] [077/132] (357s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[665.947235] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[665.949656] Starting dynamic subtest: pipe-A-eDP-1
[665.973095] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[665.987412] Starting dynamic subtest: pipe-B-eDP-1
[666.009807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[666.019768] Starting dynamic subtest: pipe-C-eDP-1
[666.041631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[666.053030] Starting dynamic subtest: pipe-D-eDP-1
[666.075629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[666.080181] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[668.198457] [078/132] (355s left) kms_plane (pixel-format-linear-modifier)
[668.295189] Starting subtest: pixel-format-linear-modifier
[668.321724] Starting dynamic subtest: pipe-A-plane-0
[672.032639] Dynamic subtest pipe-A-plane-0: SUCCESS (3.711s)
[672.043550] Starting dynamic subtest: pipe-A-plane-3
[673.754851] Dynamic subtest pipe-A-plane-3: SUCCESS (1.721s)
[673.767331] Starting dynamic subtest: pipe-A-plane-5
[673.966038] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[675.111526] Starting dynamic subtest: pipe-B-plane-0
[678.670723] Dynamic subtest pipe-B-plane-0: SUCCESS (3.566s)
[678.680261] Starting dynamic subtest: pipe-B-plane-3
[680.292379] Dynamic subtest pipe-B-plane-3: SUCCESS (1.620s)
[680.301899] Starting dynamic subtest: pipe-B-plane-5
[680.504268] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[680.816924] Subtest pixel-format-linear-modifier: SUCCESS (12.519s)
[681.666426] [079/132] (341s left) gem_exec_balancer (bonded-pair)
[681.729049] Starting subtest: bonded-pair
[681.734175] Subtest bonded-pair: SKIP (0.000s)
[682.015325] [080/132] (341s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[682.072615] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[682.135337] [081/132] (341s left) kms_addfb_basic (addfb25-modifier-no-flag)
[682.236987] Starting subtest: addfb25-modifier-no-flag
[682.238939] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[682.313437] [082/132] (341s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[682.412832] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[682.415148] Starting dynamic subtest: pipe-A
[682.639799] Dynamic subtest pipe-A: SUCCESS (0.229s)
[682.650311] Starting dynamic subtest: pipe-B
[683.950236] Dynamic subtest pipe-B: SUCCESS (1.310s)
[683.960375] Starting dynamic subtest: pipe-C
[685.285408] Dynamic subtest pipe-C: SUCCESS (1.334s)
[685.295195] Starting dynamic subtest: pipe-D
[686.628470] Dynamic subtest pipe-D: SUCCESS (1.342s)
[686.630732] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.218s)
[687.787169] [083/132] (335s left) gem_exec_reloc (basic-write-read-active)
[687.854658] Subtest basic-write-read-active: SKIP (0.000s)
[687.933593] [084/132] (335s left) kms_big_fb (linear-8bpp-rotate-180)
[688.047155] Starting subtest: linear-8bpp-rotate-180
[689.283309] Subtest linear-8bpp-rotate-180: SUCCESS (1.236s)
[689.375781] [085/132] (334s left) syncobj_basic (bad-create-flags)
[689.421164] Starting subtest: bad-create-flags
[689.423075] Subtest bad-create-flags: SUCCESS (0.000s)
[689.486419] [086/132] (334s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[689.535073] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[689.643730] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[689.718442] [087/132] (333s left) kms_prime (basic-crc-vgem)
[689.804344] Starting subtest: basic-crc-vgem
[689.806786] Starting dynamic subtest: second-to-first
[690.812340] Dynamic subtest second-to-first: SUCCESS (1.012s)
[690.814315] Subtest basic-crc-vgem: SUCCESS (1.012s)
[690.863275] [088/132] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[690.977371] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[690.980953] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[691.049075] [089/132] (332s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[691.155525] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[691.159242] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[691.230125] [090/132] (332s left) syncobj_wait (invalid-signal-zero-handles)
[691.289732] Starting subtest: invalid-signal-zero-handles
[691.291761] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[691.361763] [091/132] (332s left) gem_caching (reads)
[691.420460] Subtest reads: SKIP (0.000s)
[691.499814] [092/132] (332s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[691.596273] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[691.599934] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[691.650160] [093/132] (332s left) prime_vgem (busy)
[691.730453] Starting subtest: busy
[691.732468] Starting dynamic subtest: rcs0
[691.761651] Dynamic subtest rcs0: SUCCESS (0.031s)
[691.771077] Starting dynamic subtest: bcs0
[691.805658] Dynamic subtest bcs0: SUCCESS (0.043s)
[691.815187] Starting dynamic subtest: vcs0
[691.851714] Dynamic subtest vcs0: SUCCESS (0.045s)
[691.861018] Starting dynamic subtest: vcs1
[691.899429] Dynamic subtest vcs1: SUCCESS (0.046s)
[691.913807] Starting dynamic subtest: vecs0
[691.947578] Dynamic subtest vecs0: SUCCESS (0.047s)
[691.957185] Starting dynamic subtest: ccs0
[691.991212] Dynamic subtest ccs0: SUCCESS (0.043s)
[691.993128] Subtest busy: SUCCESS (0.262s)
[692.085177] [094/132] (331s left) kms_joiner (invalid-modeset-ultra-joiner)
[692.178280] Starting subtest: invalid-modeset-ultra-joiner
[692.181593] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[692.223537] [095/132] (331s left) syncobj_basic (bad-destroy)
[692.276435] Starting subtest: bad-destroy
[692.278203] Subtest bad-destroy: SUCCESS (0.000s)
[692.348298] [096/132] (331s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[692.474237] Starting subtest: cursorA-vs-flipB-atomic
[692.477871] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[692.595343] [097/132] (331s left) prime_self_import (basic-with_two_bos)
[692.632048] Starting subtest: basic-with_two_bos
[692.644555] Subtest basic-with_two_bos: SUCCESS (0.017s)
[692.709135] [098/132] (331s left) gem_mmap_gtt (coherency)
[692.760978] Subtest coherency: SKIP (0.000s)
[692.815486] [099/132] (331s left) gem_exec_schedule (pi-common)
[692.994146] Starting subtest: pi-common
[692.996207] Starting dynamic subtest: rcs0
[693.019017] Dynamic subtest rcs0: SUCCESS (0.027s)
[693.033899] Starting dynamic subtest: bcs0
[693.045335] Dynamic subtest bcs0: SUCCESS (0.026s)
[693.059726] Starting dynamic subtest: vcs0
[693.071016] Dynamic subtest vcs0: SUCCESS (0.025s)
[693.083315] Starting dynamic subtest: vcs1
[693.098812] Dynamic subtest vcs1: SUCCESS (0.027s)
[693.113104] Starting dynamic subtest: vecs0
[693.124521] Dynamic subtest vecs0: SUCCESS (0.025s)
[693.138812] Starting dynamic subtest: ccs0
[693.149858] Dynamic subtest ccs0: SUCCESS (0.025s)
[693.152089] Subtest pi-common: SUCCESS (0.159s)
[693.351095] [100/132] (330s left) kms_psr (fbc-psr-cursor-render)
[693.493323] Starting subtest: fbc-psr-cursor-render
[693.495703] Starting dynamic subtest: eDP-1
[693.500143] Dynamic subtest eDP-1: SKIP (0.000s)
[693.504256] Subtest fbc-psr-cursor-render: SKIP (0.002s)
[693.601730] [101/132] (330s left) gem_spin_batch (legacy-resubmit-new)
[693.785201] Starting subtest: legacy-resubmit-new
[693.787794] Starting dynamic subtest: default
[693.797753] Dynamic subtest default: SUCCESS (0.012s)
[693.809952] Starting dynamic subtest: render
[693.812316] Dynamic subtest render: SUCCESS (0.007s)
[693.822067] Starting dynamic subtest: bsd
[693.824086] Dynamic subtest bsd: SUCCESS (0.009s)
[693.834101] Starting dynamic subtest: bsd1
[693.836374] Dynamic subtest bsd1: SUCCESS (0.007s)
[693.846363] Starting dynamic subtest: bsd2
[693.848919] Dynamic subtest bsd2: SUCCESS (0.006s)
[693.858458] Starting dynamic subtest: blt
[693.860460] Dynamic subtest blt: SUCCESS (0.007s)
[693.869566] Starting dynamic subtest: vebox
[693.871585] Dynamic subtest vebox: SUCCESS (0.005s)
[693.873715] Subtest legacy-resubmit-new: SUCCESS (0.065s)
[695.916874] [102/132] (328s left) kms_psr (psr-cursor-plane-onoff)
[696.016229] Starting subtest: psr-cursor-plane-onoff
[696.018560] Starting dynamic subtest: eDP-1
[697.691599] Dynamic subtest eDP-1: SUCCESS (1.675s)
[697.693975] Subtest psr-cursor-plane-onoff: SUCCESS (1.676s)
[698.551665] [103/132] (325s left) gem_busy (close-race)
[698.623794] Starting subtest: close-race
[721.880230] Subtest close-race: SUCCESS (23.255s)
[722.229172] [104/132] (302s left) api_intel_allocator (simple-allocator)
[722.324593] Starting subtest: simple-allocator
[722.326899] Starting dynamic subtest: basic
[722.332332] Dynamic subtest basic: SUCCESS (0.007s)
[722.347875] Starting dynamic subtest: parallel-one
[722.500436] Dynamic subtest parallel-one: SUCCESS (0.169s)
[722.512114] Starting dynamic subtest: print
[722.514446] Dynamic subtest print: SUCCESS (0.000s)
[722.524204] Starting dynamic subtest: reuse
[722.526317] Dynamic subtest reuse: SUCCESS (0.000s)
[722.535592] Starting dynamic subtest: reserve
[722.537811] Dynamic subtest reserve: SUCCESS (0.000s)
[722.547075] Starting dynamic subtest: fork-reopen-allocator
[722.549293] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[722.551454] Subtest simple-allocator: SUCCESS (0.191s)
[722.617602] [105/132] (301s left) kms_psr (pr-dpms)
[722.725411] Starting subtest: pr-dpms
[722.729559] Subtest pr-dpms: SKIP (0.000s)
[722.773073] [106/132] (301s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[722.869801] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[722.872067] Starting dynamic subtest: pipe-A
[722.891357] Dynamic subtest pipe-A: SKIP (0.018s)
[722.901233] Starting dynamic subtest: pipe-B
[722.923066] Dynamic subtest pipe-B: SKIP (0.031s)
[722.932539] Starting dynamic subtest: pipe-C
[722.955889] Dynamic subtest pipe-C: SKIP (0.031s)
[722.965829] Starting dynamic subtest: pipe-D
[722.985770] Dynamic subtest pipe-D: SKIP (0.031s)
[722.990162] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.113s)
[723.073161] [107/132] (301s left) gem_workarounds (basic-read)
[723.145340] Starting subtest: basic-read
[723.156662] Subtest basic-read: SUCCESS (0.011s)
[723.248081] [108/132] (301s left) kms_async_flips (invalid-async-flip-atomic)
[723.341157] Starting subtest: invalid-async-flip-atomic
[723.721592] Starting dynamic subtest: pipe-A-eDP-1
[724.508619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[724.868830] Starting dynamic subtest: pipe-B-eDP-1
[725.643868] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[726.010567] Starting dynamic subtest: pipe-C-eDP-1
[726.775620] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[727.130033] Starting dynamic subtest: pipe-D-eDP-1
[727.901219] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[727.903596] Subtest invalid-async-flip-atomic: SUCCESS (4.563s)
[729.033913] [109/132] (295s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[729.144820] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[733.746069] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.604s)
[734.845734] [110/132] (289s left) gem_eio (in-flight-contexts-1us)
[735.072343] Starting subtest: in-flight-contexts-1us
[748.917606] Subtest in-flight-contexts-1us: SUCCESS (13.844s)
[749.065057] [111/132] (275s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[749.154815] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[749.157081] Starting dynamic subtest: pipe-A-eDP-1
[749.180589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[749.191783] Starting dynamic subtest: pipe-B-eDP-1
[749.213104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[749.222441] Starting dynamic subtest: pipe-C-eDP-1
[749.243289] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[749.252345] Starting dynamic subtest: pipe-D-eDP-1
[749.274455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[749.278887] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[751.398930] [112/132] (273s left) gem_exec_schedule (fifo)
[751.477853] Starting subtest: fifo
[751.480223] Starting dynamic subtest: rcs0
[751.571319] Dynamic subtest rcs0: SUCCESS (0.104s)
[751.584253] Starting dynamic subtest: vcs0
[751.654048] Dynamic subtest vcs0: SUCCESS (0.081s)
[751.667818] Starting dynamic subtest: vcs1
[751.736073] Dynamic subtest vcs1: SUCCESS (0.082s)
[751.748646] Starting dynamic subtest: vecs0
[751.825788] Dynamic subtest vecs0: SUCCESS (0.089s)
[751.838772] Starting dynamic subtest: ccs0
[751.937920] Dynamic subtest ccs0: SUCCESS (0.111s)
[751.940457] Subtest fifo: SUCCESS (0.472s)
[752.985922] [113/132] (271s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[753.088063] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[753.092253] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[753.172437] [114/132] (271s left) gem_exec_flush (basic-wb-ro-before-default)
[753.243238] Starting subtest: basic-wb-ro-before-default
[758.703602] Subtest basic-wb-ro-before-default: SUCCESS (5.463s)
[758.871915] [115/132] (266s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[758.983101] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[758.987628] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[759.033634] [116/132] (265s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[759.152032] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[759.156574] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[759.237199] [117/132] (265s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[759.334626] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[759.337033] Starting dynamic subtest: pipe-A-eDP-1
[759.420730] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[759.433186] Starting dynamic subtest: pipe-B-eDP-1
[760.597747] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[760.602411] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.267s)
[761.761395] [118/132] (263s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[761.868247] Starting subtest: y-tiled-64bpp-rotate-180
[761.872103] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[761.943990] [119/132] (263s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[762.042813] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[762.047291] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[762.106604] [120/132] (262s left) gen9_exec_parse (allowed-all)
[762.191078] Subtest allowed-all: SKIP (0.000s)
[762.263233] [121/132] (262s left) kms_getfb (getfb-reject-nv12)
[762.377801] Starting subtest: getfb-reject-nv12
[762.380080] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[762.460973] [122/132] (262s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[762.835892] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[763.684816] [123/132] (261s left) drm_buddy (drm_buddy)
[763.726841] Starting subtest: drm_buddy
[763.731428] Subtest drm_buddy: SKIP (0.001s)
[763.773260] [124/132] (261s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[763.844657] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[763.846639] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[763.922095] [125/132] (261s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[764.020570] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[764.033711] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[764.089944] [126/132] (261s left) i915_hangman (engine-engine-hang)
[764.161739] Starting subtest: engine-engine-hang
[764.163776] Starting dynamic subtest: rcs0
[765.879159] Dynamic subtest rcs0: SUCCESS (1.717s)
[765.894049] Starting dynamic subtest: bcs0
[767.862499] Dynamic subtest bcs0: SUCCESS (1.980s)
[767.874641] Starting dynamic subtest: vcs0
[769.846855] Dynamic subtest vcs0: SUCCESS (1.981s)
[769.858777] Starting dynamic subtest: vcs1
[771.895795] Dynamic subtest vcs1: SUCCESS (2.046s)
[771.908744] Starting dynamic subtest: vecs0
[773.878768] Dynamic subtest vecs0: SUCCESS (1.980s)
[773.895854] Starting dynamic subtest: ccs0
[775.862408] Dynamic subtest ccs0: SUCCESS (1.980s)
[775.865491] Subtest engine-engine-hang: SUCCESS (11.702s)
[775.984387] [127/132] (249s left) gem_mmap_gtt (basic-wc)
[776.045579] Subtest basic-wc: SKIP (0.000s)
[776.118247] [128/132] (249s left) fbdev (info)
[776.156737] Starting subtest: info
[776.159197] Subtest info: SUCCESS (0.000s)
[776.211187] [129/132] (249s left) gem_ctx_shared (q-promotion)
[776.279944] Starting subtest: Q-promotion
[776.282551] Starting dynamic subtest: rcs0
[776.461720] Dynamic subtest rcs0: SUCCESS (0.180s)
[776.475143] Starting dynamic subtest: vcs0
[776.591603] Dynamic subtest vcs0: SUCCESS (0.129s)
[776.610435] Starting dynamic subtest: vcs1
[776.710520] Dynamic subtest vcs1: SUCCESS (0.118s)
[776.729137] Starting dynamic subtest: vecs0
[776.825566] Dynamic subtest vecs0: SUCCESS (0.114s)
[776.843687] Starting dynamic subtest: ccs0
[776.969689] Dynamic subtest ccs0: SUCCESS (0.142s)
[776.972545] Subtest Q-promotion: SUCCESS (0.688s)
[778.005518] [130/132] (247s left) kms_sequence (queue-busy)
[778.105149] Starting subtest: queue-busy
[778.107065] Starting dynamic subtest: pipe-A-eDP-1
[780.047459] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[780.058493] Starting dynamic subtest: pipe-B-eDP-1
[782.615089] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[782.626070] Starting dynamic subtest: pipe-C-eDP-1
[785.216635] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[785.227714] Starting dynamic subtest: pipe-D-eDP-1
[787.760384] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[787.762316] Subtest queue-busy: SUCCESS (9.655s)
[788.620278] [131/132] (236s left) syncobj_timeline (single-wait-all-available-submitted)
[788.671355] Starting subtest: single-wait-all-available-submitted
[788.673670] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[788.762013] [132/132] (236s left) kms_vblank (ts-continuation-modeset-hang)
[788.849206] Starting subtest: ts-continuation-modeset-hang
[788.851060] Starting dynamic subtest: pipe-A-eDP-1
[815.660429] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.807s)
[815.687818] Starting dynamic subtest: pipe-D-eDP-1
[840.669680] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.004s)
[840.672077] Subtest ts-continuation-modeset-hang: SUCCESS (51.819s)
[841.451726] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_pm_rc6_residency
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: prime_mmap
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: i915_selftest
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_ppgtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: gem_exec_flush
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: kms_dsc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: gem_mmap
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_wait
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_ctx_engines
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: vgem_slow
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: kms_plane_alpha_blend
results: parsing output: 57/ for test: sysfs_preempt_timeout
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: kms_plane_multiple
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_chamelium_edid
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_wait
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_basic
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_prime
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_caching
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: kms_joiner
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: prime_self_import
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_workarounds
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: drm_buddy
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_hangman
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: kms_sequence
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_vblank
Done.