[43.580237] Initializing watchdogs [43.580302] /dev/watchdog0 [43.594260] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [43.599120] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [43.601496] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [43.603440] [001/131] (960s left) gem_userptr_blits (sync-unmap-cycles) [43.744313] Starting subtest: sync-unmap-cycles [49.151932] Subtest sync-unmap-cycles: SUCCESS (5.373s) [49.231400] [002/131] (954s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [49.331664] Starting subtest: fbc-rgb565-draw-mmap-wc [50.520584] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.189s) [50.623899] [003/131] (953s left) kms_lease (lease-invalid-connector) [50.714822] Starting subtest: lease-invalid-connector [50.715559] Starting dynamic subtest: pipe-A-HDMI-A-1 [50.716316] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [50.721272] Starting dynamic subtest: pipe-B-HDMI-A-1 [50.721982] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [50.726454] Starting dynamic subtest: pipe-C-HDMI-A-1 [50.727154] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [50.731872] Starting dynamic subtest: pipe-D-HDMI-A-1 [50.732598] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [50.733300] Subtest lease-invalid-connector: SUCCESS (0.004s) [50.765292] [004/131] (953s left) gem_exec_whisper (basic-fds) [50.813046] Starting subtest: basic-fds [53.472300] Subtest basic-fds: SUCCESS (2.659s) [53.656700] [005/131] (950s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [53.755473] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [53.756860] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [53.834478] [006/131] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [53.925758] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [53.927193] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [54.027550] [007/131] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [54.120538] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [54.121931] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s) [54.211939] [008/131] (950s left) kms_pm_backlight (fade-with-dpms) [54.300252] Subtest fade-with-dpms: SKIP (0.000s) [54.335108] [009/131] (950s left) kms_addfb_basic (addfb25-y-tiled-legacy) [54.424676] Starting subtest: addfb25-y-tiled-legacy [54.425415] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [54.485820] [010/131] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [54.578836] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [54.580305] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [54.666697] [011/131] (949s left) kms_vrr (max-min) [54.756597] Starting subtest: max-min [54.758755] Subtest max-min: SKIP (0.000s) [54.811522] [012/131] (949s left) kms_psr (fbc-psr2-cursor-blt) [54.899605] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [54.936298] [013/131] (949s left) syncobj_timeline (wait-all-for-submit-complex) [54.972971] Starting subtest: wait-all-for-submit-complex [55.198083] Subtest wait-all-for-submit-complex: SUCCESS (0.216s) [55.258648] [014/131] (949s left) kms_cursor_crc (cursor-offscreen-64x64) [55.350521] Starting subtest: cursor-offscreen-64x64 [55.355759] Starting dynamic subtest: pipe-A-HDMI-A-1 [56.636669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.281s) [56.666430] Starting dynamic subtest: pipe-D-HDMI-A-1 [57.876242] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.214s) [57.876939] Subtest cursor-offscreen-64x64: SUCCESS (2.525s) [58.003488] [015/131] (946s left) kms_big_fb (x-tiled-addfb) [58.105836] Starting subtest: x-tiled-addfb [58.106587] Subtest x-tiled-addfb: SUCCESS (0.000s) [58.192074] [016/131] (946s left) gem_sync (basic-store-all) [58.237885] Starting subtest: basic-store-all [60.398022] Subtest basic-store-all: SUCCESS (2.160s) [60.574362] [017/131] (944s left) i915_pm_rpm (gem-idle) [61.982964] Starting subtest: gem-idle [68.243832] Subtest gem-idle: SUCCESS (6.261s) [68.384735] [018/131] (936s left) kms_dsc (dsc-with-bpc-formats) [68.473543] Starting subtest: dsc-with-bpc-formats [68.507072] Subtest dsc-with-bpc-formats: SKIP (0.003s) [68.531859] [019/131] (936s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [68.618715] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [68.619453] Starting dynamic subtest: pipe-A-HDMI-A-1 [69.383981] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.761s) [69.392836] Starting dynamic subtest: pipe-B-HDMI-A-1 [69.775434] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.389s) [69.787356] Starting dynamic subtest: pipe-C-HDMI-A-1 [70.175597] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.398s) [70.187449] Starting dynamic subtest: pipe-D-HDMI-A-1 [70.583867] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.406s) [70.584897] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (1.962s) [70.800040] [020/131] (933s left) drm_read (short-buffer-nonblock) [70.912397] Starting subtest: short-buffer-nonblock [70.913207] Subtest short-buffer-nonblock: SUCCESS (0.000s) [71.002957] [021/131] (933s left) kms_vblank (ts-continuation-idle-hang) [71.089511] Starting subtest: ts-continuation-idle-hang [71.090229] Starting dynamic subtest: pipe-A-HDMI-A-1 [84.666444] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.574s) [84.675700] Starting dynamic subtest: pipe-D-HDMI-A-1 [98.470100] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.797s) [98.470823] Subtest ts-continuation-idle-hang: SUCCESS (27.378s) [98.608477] [022/131] (906s left) gem_mmap_offset (clear-via-pagefault) [98.645368] Starting subtest: clear-via-pagefault [98.646124] Starting dynamic subtest: smem0 [124.124206] Dynamic subtest smem0: SUCCESS (25.469s) [124.124962] Subtest clear-via-pagefault: SUCCESS (25.469s) [124.392387] [023/131] (880s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [124.433542] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [124.434303] Starting dynamic subtest: smem [124.519507] Dynamic subtest smem: SUCCESS (0.086s) [124.520290] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.086s) [124.687134] [024/131] (880s left) kms_cursor_legacy (torture-move) [124.780476] Starting subtest: torture-move [124.781157] Starting dynamic subtest: pipe-A [130.292866] Dynamic subtest pipe-A: SUCCESS (5.512s) [130.298608] Starting dynamic subtest: pipe-B [135.808025] Dynamic subtest pipe-B: SUCCESS (5.482s) [135.815371] Starting dynamic subtest: pipe-C [141.521267] Dynamic subtest pipe-C: SUCCESS (5.739s) [141.526928] Starting dynamic subtest: pipe-D [147.063878] Dynamic subtest pipe-D: SUCCESS (5.517s) [147.071163] Starting dynamic subtest: all-pipes [152.602188] Dynamic subtest all-pipes: SUCCESS (5.538s) [152.603327] Subtest torture-move: SUCCESS (27.788s) [152.657687] [025/131] (852s left) gem_exec_reloc (basic-wc-cpu-active) [152.698753] Starting subtest: basic-wc-cpu-active [152.825257] Subtest basic-wc-cpu-active: SUCCESS (0.118s) [152.934299] [026/131] (852s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [153.023666] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [153.024447] Starting dynamic subtest: pipe-A-valid-mode [153.086592] Dynamic subtest pipe-A-valid-mode: SKIP (0.062s) [153.088109] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.063s) [153.177708] [027/131] (851s left) perf (gen12-oa-tlb-invalidate) [153.251936] Starting subtest: gen12-oa-tlb-invalidate [153.252712] Starting dynamic subtest: 0-rcs0 [163.339247] Dynamic subtest 0-rcs0: SUCCESS (10.054s) [163.340416] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.054s) [163.388160] [028/131] (841s left) gen7_exec_parse (cmd-crossing-page) [163.446220] Subtest cmd-crossing-page: SKIP (0.000s) [163.481328] [029/131] (841s left) perf_pmu (interrupts) [163.519220] Starting subtest: interrupts [164.630093] Subtest interrupts: SUCCESS (1.099s) [164.697641] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [164.699283] [030/131] (840s left) syncobj_timeline (invalid-signal-bad-pad) [164.735291] Starting subtest: invalid-signal-bad-pad [164.736014] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [164.794842] [031/131] (840s left) gem_ctx_shared (single-timeline) [164.838530] Starting subtest: single-timeline [164.844334] Subtest single-timeline: SUCCESS (0.004s) [165.029015] [032/131] (840s left) kms_plane_multiple (tiling-x) [165.118603] Starting subtest: tiling-x [165.120335] Starting dynamic subtest: pipe-A-HDMI-A-1 [165.668036] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.548s) [165.674683] Starting dynamic subtest: pipe-B-HDMI-A-1 [166.248866] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.580s) [166.255491] Starting dynamic subtest: pipe-C-HDMI-A-1 [166.806739] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.556s) [166.814500] Starting dynamic subtest: pipe-D-HDMI-A-1 [167.355721] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.548s) [167.356492] Subtest tiling-x: SUCCESS (2.237s) [167.486623] [033/131] (837s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [167.585874] Starting subtest: psr-1p-pri-indfb-multidraw [167.587318] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [167.676589] [034/131] (837s left) syncobj_timeline (invalid-transfer-non-existent-point) [167.713090] Starting subtest: invalid-transfer-non-existent-point [167.713871] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [167.775156] [035/131] (837s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [167.862779] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [167.863487] Starting dynamic subtest: pipe-A [168.426617] Dynamic subtest pipe-A: SUCCESS (0.564s) [168.434273] Starting dynamic subtest: pipe-B [169.044336] Dynamic subtest pipe-B: SUCCESS (0.617s) [169.053618] Starting dynamic subtest: pipe-C [169.653089] Dynamic subtest pipe-C: SUCCESS (0.608s) [169.661264] Starting dynamic subtest: pipe-D [170.270903] Dynamic subtest pipe-D: SUCCESS (0.617s) [170.271641] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.409s) [170.486344] [036/131] (834s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [170.588233] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [170.589682] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [170.688767] [037/131] (834s left) api_intel_bb (object-noreloc-purge-cache-simple) [170.725786] Starting subtest: object-noreloc-purge-cache-simple [170.728916] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.003s) [170.841508] [038/131] (834s left) kms_async_flips (crc) [170.930768] Starting subtest: crc [171.053540] Starting dynamic subtest: pipe-A-HDMI-A-1 [173.205237] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.143s) [173.334484] Starting dynamic subtest: pipe-B-HDMI-A-1 [175.442447] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.105s) [175.544092] Starting dynamic subtest: pipe-C-HDMI-A-1 [177.662294] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.115s) [177.774755] Starting dynamic subtest: pipe-D-HDMI-A-1 [179.890498] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.113s) [179.891347] Subtest crc: SUCCESS (8.952s) [180.085529] [039/131] (825s left) drm_fdinfo (virtual-busy) [180.129034] Starting subtest: virtual-busy [182.813895] Subtest virtual-busy: SUCCESS (2.684s) [182.875594] [040/131] (822s left) kms_addfb_basic (bad-pitch-65536) [182.912613] Starting subtest: bad-pitch-65536 [182.913342] Subtest bad-pitch-65536: SUCCESS (0.000s) [183.071249] [041/131] (822s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [183.160948] Starting subtest: basic-busy-flip-before-cursor-legacy [183.162440] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [183.218351] [042/131] (822s left) gem_spin_batch (user-each) [183.265779] Starting subtest: user-each [186.626090] Subtest user-each: SUCCESS (3.349s) [186.803587] [043/131] (818s left) gem_render_copy (yf-tiled-to-vebox-linear) [186.847549] Starting subtest: yf-tiled-to-vebox-linear [186.848331] Starting dynamic subtest: smem [186.913766] Dynamic subtest smem: SUCCESS (0.066s) [186.914531] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.066s) [187.097958] [044/131] (818s left) perf_pmu (all-busy-idle-check-all) [187.136425] Starting subtest: all-busy-idle-check-all [187.757129] Subtest all-busy-idle-check-all: SUCCESS (0.620s) [187.828938] [045/131] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [187.923780] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [187.925188] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [188.013202] [046/131] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [188.107113] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [188.108557] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [188.194982] [047/131] (817s left) api_intel_allocator (two-level-inception) [188.232963] Starting subtest: two-level-inception [193.696405] Subtest two-level-inception: SUCCESS (5.429s) [193.784839] [048/131] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [193.878773] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [193.880166] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [193.981720] [049/131] (811s left) gem_workarounds (reset-context) [194.029594] Starting subtest: reset-context [194.038463] Subtest reset-context: SUCCESS (0.008s) [194.141228] [050/131] (811s left) gem_close_race (multigpu-basic-process) [194.188438] Starting subtest: multigpu-basic-process [194.189817] Subtest multigpu-basic-process: SKIP (0.000s) [194.366295] [051/131] (811s left) kms_color (invalid-degamma-lut-sizes) [194.454760] Starting subtest: invalid-degamma-lut-sizes [194.455458] Starting dynamic subtest: pipe-A [194.515795] Dynamic subtest pipe-A: SUCCESS (0.061s) [194.521825] Starting dynamic subtest: pipe-B [194.522551] Dynamic subtest pipe-B: SUCCESS (0.001s) [194.528392] Starting dynamic subtest: pipe-C [194.529115] Dynamic subtest pipe-C: SUCCESS (0.001s) [194.534904] Starting dynamic subtest: pipe-D [194.535620] Dynamic subtest pipe-D: SUCCESS (0.001s) [194.536332] Subtest invalid-degamma-lut-sizes: SUCCESS (0.068s) [194.630864] [052/131] (811s left) sysfs_preempt_timeout (timeout) [194.670980] Starting subtest: timeout [194.673096] Starting dynamic subtest: vecs0 [195.550481] Dynamic subtest vecs0: SUCCESS (0.878s) [195.559620] Starting dynamic subtest: vcs0 [196.469716] Dynamic subtest vcs0: SUCCESS (0.918s) [196.478433] Starting dynamic subtest: bcs0 [197.395993] Dynamic subtest bcs0: SUCCESS (0.924s) [197.406247] Starting dynamic subtest: rcs0 [198.395920] Dynamic subtest rcs0: SUCCESS (0.997s) [198.413655] Starting dynamic subtest: vcs1 [199.353732] Dynamic subtest vcs1: SUCCESS (0.955s) [199.354906] Subtest timeout: SUCCESS (4.683s) [199.420862] [053/131] (806s left) syncobj_wait (wait-all-complex) [199.458180] Starting subtest: wait-all-complex [199.681703] Subtest wait-all-complex: SUCCESS (0.214s) [199.741318] [054/131] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [199.835778] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [199.837161] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [199.941091] [055/131] (806s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [200.027780] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [200.028486] Starting dynamic subtest: pipe-A-HDMI-A-1 [200.034629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [200.040495] Starting dynamic subtest: pipe-B-HDMI-A-1 [200.046600] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [200.052393] Starting dynamic subtest: pipe-C-HDMI-A-1 [200.058456] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [200.064585] Starting dynamic subtest: pipe-D-HDMI-A-1 [200.070547] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [200.071212] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SUCCESS (0.007s) [200.269020] [056/131] (805s left) gem_partial_pwrite_pread (reads-display) [200.310494] Starting subtest: reads-display [201.838160] Subtest reads-display: SUCCESS (1.528s) [201.963390] [057/131] (804s left) i915_fb_tiling (basic-x-tiling) [201.999865] Starting subtest: basic-x-tiling [202.000613] Subtest basic-x-tiling: SUCCESS (0.000s) [202.084381] [058/131] (804s left) i915_pm_rc6_residency (rc6-idle) [202.120502] Starting subtest: rc6-idle [202.124798] Starting dynamic subtest: gt0-rcs0 [214.369414] Dynamic subtest gt0-rcs0: SUCCESS (12.217s) [214.378174] Starting dynamic subtest: gt0-bcs0 [226.585789] Dynamic subtest gt0-bcs0: SUCCESS (12.217s) [226.594901] Starting dynamic subtest: gt0-vcs0 [238.804789] Dynamic subtest gt0-vcs0: SUCCESS (12.218s) [238.813936] Starting dynamic subtest: gt0-vecs0 [251.022770] Dynamic subtest gt0-vecs0: SUCCESS (12.217s) [251.023851] Subtest rc6-idle: SUCCESS (48.876s) [251.113541] [059/131] (755s left) kms_pm_rpm (modeset-non-lpsp) [252.522630] Starting subtest: modeset-non-lpsp [253.727351] Subtest modeset-non-lpsp: SKIP (1.204s) [253.892290] [060/131] (752s left) gem_exec_schedule (pi-distinct-iova) [254.070027] Starting subtest: pi-distinct-iova [254.071098] Starting dynamic subtest: rcs0 [254.091776] Dynamic subtest rcs0: SUCCESS (0.021s) [254.098117] Starting dynamic subtest: bcs0 [254.109301] Dynamic subtest bcs0: SUCCESS (0.017s) [254.115950] Starting dynamic subtest: vcs0 [254.128449] Dynamic subtest vcs0: SUCCESS (0.018s) [254.134895] Starting dynamic subtest: vcs1 [254.147092] Dynamic subtest vcs1: SUCCESS (0.018s) [254.153824] Starting dynamic subtest: vecs0 [254.167894] Dynamic subtest vecs0: SUCCESS (0.019s) [254.168811] Subtest pi-distinct-iova: SUCCESS (0.098s) [254.343650] [061/131] (751s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [254.430880] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [254.432280] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [254.581210] [062/131] (751s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [254.626541] Starting subtest: etime-multi-wait-all-submitted-signaled [254.727673] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s) [254.802509] [063/131] (751s left) gem_mmap_wc (set-cache-level) [254.839290] Starting subtest: set-cache-level [254.841241] Subtest set-cache-level: SUCCESS (0.001s) [254.919581] [064/131] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [255.013202] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [255.014679] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [255.104669] [065/131] (751s left) gem_ctx_engines (execute-one) [255.151485] Starting subtest: execute-one [256.216771] Subtest execute-one: SUCCESS (1.057s) [256.393617] [066/131] (750s left) kms_psr (psr-sprite-render) [256.484794] Subtest psr-sprite-render: SKIP (0.000s) [256.524428] [067/131] (749s left) gem_exec_reloc (basic-wc-gtt) [256.565284] Starting subtest: basic-wc-gtt [256.570430] Subtest basic-wc-gtt: SUCCESS (0.005s) [256.680412] [068/131] (749s left) kms_cursor_crc (cursor-sliding-512x512) [256.773485] Starting subtest: cursor-sliding-512x512 [256.776087] Subtest cursor-sliding-512x512: SKIP (0.001s) [256.873609] [069/131] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [256.966814] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [256.968319] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [257.065053] [070/131] (749s left) kms_fbcon_fbt (fbc-suspend) [257.105863] Starting subtest: fbc-suspend [303.344394] Subtest fbc-suspend: SUCCESS (16.086s) [304.397400] [071/131] (733s left) gem_exec_params (invalid-fence-in) [304.438306] Starting subtest: invalid-fence-in [304.440134] Subtest invalid-fence-in: SUCCESS (0.001s) [304.538416] [072/131] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [304.632528] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [304.634013] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [304.717247] [073/131] (733s left) gem_exec_schedule (implicit-read-write) [304.764655] Starting subtest: implicit-read-write [304.765405] Starting dynamic subtest: rcs0 [304.820272] Dynamic subtest rcs0: SUCCESS (0.055s) [304.831775] Starting dynamic subtest: bcs0 [304.877399] Dynamic subtest bcs0: SUCCESS (0.055s) [304.890905] Starting dynamic subtest: vcs0 [304.936807] Dynamic subtest vcs0: SUCCESS (0.057s) [304.948857] Starting dynamic subtest: vcs1 [304.994512] Dynamic subtest vcs1: SUCCESS (0.056s) [305.007047] Starting dynamic subtest: vecs0 [305.057265] Dynamic subtest vecs0: SUCCESS (0.061s) [305.061051] Subtest implicit-read-write: SUCCESS (0.294s) [305.356108] [074/131] (732s left) kms_psr2_sf (pr-cursor-plane-update-sf) [305.451565] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [305.498132] [075/131] (732s left) gem_exec_fence (submit3) [305.672180] Starting subtest: submit3 [305.672969] Starting dynamic subtest: rcs0 [305.677398] Dynamic subtest rcs0: SUCCESS (0.006s) [305.685033] Starting dynamic subtest: bcs0 [305.685764] Dynamic subtest bcs0: SUCCESS (0.003s) [305.693761] Starting dynamic subtest: vcs0 [305.694532] Dynamic subtest vcs0: SUCCESS (0.003s) [305.701931] Starting dynamic subtest: vcs1 [305.702637] Dynamic subtest vcs1: SUCCESS (0.003s) [305.709513] Starting dynamic subtest: vecs0 [305.710215] Dynamic subtest vecs0: SUCCESS (0.003s) [305.710909] Subtest submit3: SUCCESS (0.023s) [306.170901] [076/131] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [306.265965] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [306.267384] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [306.374035] [077/131] (731s left) kms_chamelium_frames (hdmi-crc-fast) [306.518504] Subtest hdmi-crc-fast: SKIP (0.000s) [306.611855] [078/131] (731s left) kms_flip (blocking-absolute-wf_vblank) [306.705756] Starting subtest: blocking-absolute-wf_vblank [306.707937] Starting dynamic subtest: A-HDMI-A1 [314.411595] Dynamic subtest A-HDMI-A1: SUCCESS (7.683s) [314.419818] Starting dynamic subtest: B-HDMI-A1 [322.085841] Dynamic subtest B-HDMI-A1: SUCCESS (7.660s) [322.092424] Starting dynamic subtest: C-HDMI-A1 [329.755864] Dynamic subtest C-HDMI-A1: SUCCESS (7.663s) [329.762296] Starting dynamic subtest: D-HDMI-A1 [337.393039] Dynamic subtest D-HDMI-A1: SUCCESS (7.659s) [337.396590] Subtest blocking-absolute-wf_vblank: SUCCESS (30.682s) [337.554989] [079/131] (700s left) gem_ppgtt (blt-vs-render-ctx0) [337.595015] Starting subtest: blt-vs-render-ctx0 [370.409983] Subtest blt-vs-render-ctx0: SUCCESS (32.800s) [370.540384] [080/131] (667s left) gem_exec_reloc (basic-write-gtt-noreloc) [370.626688] Starting subtest: basic-write-gtt-noreloc [370.629738] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s) [370.742798] [081/131] (667s left) syncobj_wait (invalid-signal-zero-handles) [370.790305] Starting subtest: invalid-signal-zero-handles [370.791104] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [370.855318] [082/131] (667s left) gem_ctx_persistence (legacy-engines-hang) [370.895435] Starting subtest: legacy-engines-hang [370.896285] Starting dynamic subtest: render [370.959215] Dynamic subtest render: SUCCESS (0.063s) [370.979333] Starting dynamic subtest: bsd1 [371.003346] Dynamic subtest bsd1: SUCCESS (0.042s) [371.021586] Starting dynamic subtest: bsd2 [371.057240] Dynamic subtest bsd2: SUCCESS (0.051s) [371.076206] Starting dynamic subtest: blt [371.106438] Dynamic subtest blt: SUCCESS (0.047s) [371.124558] Starting dynamic subtest: vebox [371.170281] Dynamic subtest vebox: SUCCESS (0.061s) [371.171644] Subtest legacy-engines-hang: SUCCESS (0.276s) [371.241159] [083/131] (667s left) prime_busy (hang-wait) [371.281196] Starting subtest: hang-wait [371.281951] Starting dynamic subtest: rcs0 [384.603392] Dynamic subtest rcs0: SUCCESS (13.284s) [384.613050] Starting dynamic subtest: bcs0 [391.746875] Dynamic subtest bcs0: SUCCESS (7.166s) [391.757041] Starting dynamic subtest: vcs0 [398.747469] Dynamic subtest vcs0: SUCCESS (6.972s) [398.757541] Starting dynamic subtest: vcs1 [405.788449] Dynamic subtest vcs1: SUCCESS (7.037s) [405.798360] Starting dynamic subtest: vecs0 [412.737593] Dynamic subtest vecs0: SUCCESS (6.974s) [412.738577] Subtest hang-wait: SUCCESS (41.443s) [412.863997] [084/131] (625s left) syncobj_basic (bad-destroy-pad) [412.901564] Starting subtest: bad-destroy-pad [412.902565] Subtest bad-destroy-pad: SUCCESS (0.000s) [412.972811] [085/131] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [413.068237] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [413.069754] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [413.162889] [086/131] (625s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [413.252022] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [413.252789] Starting dynamic subtest: pipe-A-valid-mode [413.313529] Dynamic subtest pipe-A-valid-mode: SKIP (0.059s) [413.315023] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.061s) [413.415028] [087/131] (625s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [413.510201] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [413.550239] [088/131] (624s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [413.637592] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [413.640077] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [413.697689] [089/131] (624s left) syncobj_timeline (multi-wait-signaled) [413.742716] Starting subtest: multi-wait-signaled [413.743436] Subtest multi-wait-signaled: SUCCESS (0.000s) [413.800164] [090/131] (624s left) kms_pm_rpm (universal-planes) [415.218607] Starting subtest: universal-planes [415.219870] Starting dynamic subtest: plane-32 [423.595980] Dynamic subtest plane-32: SUCCESS (8.375s) [423.608844] Starting dynamic subtest: plane-41 [431.982488] Dynamic subtest plane-41: SUCCESS (8.383s) [431.995407] Starting dynamic subtest: plane-50 [440.273792] Dynamic subtest plane-50: SUCCESS (8.288s) [440.288326] Starting dynamic subtest: plane-59 [448.549986] Dynamic subtest plane-59: SUCCESS (8.273s) [448.562446] Starting dynamic subtest: plane-68 [456.726303] Dynamic subtest plane-68: SUCCESS (8.173s) [456.738091] Starting dynamic subtest: plane-77 [465.007341] Dynamic subtest plane-77: SUCCESS (8.278s) [465.020330] Starting dynamic subtest: plane-86 [473.370129] Dynamic subtest plane-86: SUCCESS (8.359s) [473.387377] Starting dynamic subtest: plane-95 [481.642352] Dynamic subtest plane-95: SUCCESS (8.269s) [481.643609] Subtest universal-planes: SUCCESS (66.417s) [481.811445] [091/131] (556s left) kms_big_fb (y-tiled-32bpp-rotate-270) [481.911665] Starting subtest: y-tiled-32bpp-rotate-270 [483.601168] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.688s) [483.775758] [092/131] (554s left) kms_tiled_display (basic-test-pattern-with-chamelium) [483.906187] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [483.945964] [093/131] (554s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [484.038900] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [485.151180] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.113s) [485.270839] [094/131] (553s left) drm_fdinfo (isolation) [485.309390] Starting subtest: isolation [485.310242] Starting dynamic subtest: rcs0 [485.837224] Dynamic subtest rcs0: SUCCESS (0.527s) [485.850681] Starting dynamic subtest: bcs0 [486.374205] Dynamic subtest bcs0: SUCCESS (0.534s) [486.384541] Starting dynamic subtest: vcs0 [486.904146] Dynamic subtest vcs0: SUCCESS (0.528s) [486.916918] Starting dynamic subtest: vcs1 [487.428912] Dynamic subtest vcs1: SUCCESS (0.523s) [487.442764] Starting dynamic subtest: vecs0 [487.952056] Dynamic subtest vecs0: SUCCESS (0.520s) [487.953198] Subtest isolation: SUCCESS (2.642s) [488.018020] [095/131] (550s left) gem_fenced_exec_thrash (no-spare-fences-busy) [488.056362] Starting subtest: no-spare-fences-busy [490.222293] Subtest no-spare-fences-busy: SUCCESS (2.165s) [490.363973] [096/131] (548s left) kms_hdr (bpc-switch-dpms) [490.453825] Starting subtest: bpc-switch-dpms [490.456116] Subtest bpc-switch-dpms: SKIP (0.001s) [490.512013] [097/131] (548s left) kms_frontbuffer_tracking (psr-2p-rte) [490.602821] Starting subtest: psr-2p-rte [490.604338] Subtest psr-2p-rte: SKIP (0.000s) [490.697690] [098/131] (548s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [490.795110] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [491.126817] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.332s) [491.267390] [099/131] (547s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [491.356720] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [491.357503] Starting dynamic subtest: pipe-A-valid-mode [491.413628] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s) [491.415125] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.057s) [491.523833] [100/131] (547s left) gem_lmem_swapping (heavy-verify-random-ccs) [491.567752] Subtest heavy-verify-random-ccs: SKIP (0.000s) [491.608146] [101/131] (547s left) kms_chamelium_frames (dp-crc-fast) [491.746248] Subtest dp-crc-fast: SKIP (0.000s) [491.829474] [102/131] (547s left) kms_psr (psr2-no-drrs) [491.922241] Subtest psr2-no-drrs: SKIP (0.000s) [491.961087] [103/131] (547s left) kms_big_fb (x-tiled-16bpp-rotate-0) [492.055941] Starting subtest: x-tiled-16bpp-rotate-0 [493.391895] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.335s) [493.560911] [104/131] (545s left) kms_psr (fbc-psr2-sprite-blt) [493.651512] Subtest fbc-psr2-sprite-blt: SKIP (0.000s) [493.695324] [105/131] (545s left) gem_exec_balancer (persistence) [493.866651] Starting subtest: persistence [494.928540] Subtest persistence: SUCCESS (1.055s) [494.977762] [106/131] (544s left) gem_partial_pwrite_pread (writes-after-reads) [495.019787] Starting subtest: writes-after-reads [506.520466] Subtest writes-after-reads: SUCCESS (11.499s) [506.644863] [107/131] (532s left) kms_cursor_crc (cursor-alpha-opaque) [506.734716] Starting subtest: cursor-alpha-opaque [506.736579] Starting dynamic subtest: pipe-A-HDMI-A-1 [507.028556] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.293s) [507.038305] Starting dynamic subtest: pipe-D-HDMI-A-1 [507.279819] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.248s) [507.280696] Subtest cursor-alpha-opaque: SUCCESS (0.546s) [507.434595] [108/131] (531s left) gem_exec_params (invalid-ring) [507.481024] Starting subtest: invalid-ring [507.481811] Subtest invalid-ring: SUCCESS (0.000s) [507.577532] [109/131] (531s left) gem_exec_fence (syncobj-timeline-invalid-flags) [508.044006] Starting subtest: syncobj-timeline-invalid-flags [508.045227] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [508.220891] [110/131] (531s left) gem_pread (self) [508.257299] Starting subtest: self [508.273986] Subtest self: SUCCESS (0.017s) [508.365542] [111/131] (531s left) kms_plane_alpha_blend (constant-alpha-max) [508.458502] Starting subtest: constant-alpha-max [508.558463] Starting dynamic subtest: pipe-A-HDMI-A-1 [509.066482] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.506s) [509.076976] Starting dynamic subtest: pipe-D-HDMI-A-1 [509.603046] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.535s) [509.603864] Subtest constant-alpha-max: SUCCESS (1.145s) [509.741830] [112/131] (529s left) kms_atomic_transition (modeset-transition-nonblocking) [509.837379] Starting subtest: modeset-transition-nonblocking [509.838188] Starting dynamic subtest: 1x-outputs [511.022943] Dynamic subtest 1x-outputs: SUCCESS (1.186s) [511.049831] Subtest modeset-transition-nonblocking: SUCCESS (1.213s) [511.169966] [113/131] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [511.267118] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [512.445135] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.179s) [512.562866] [114/131] (526s left) gem_eio (wait-immediate) [512.610504] Starting subtest: wait-immediate [512.762311] Subtest wait-immediate: SUCCESS (0.151s) [512.881556] [115/131] (526s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [512.970558] Starting subtest: primary-yf-tiled-reflect-x-0 [513.021008] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.049s) [513.107478] [116/131] (526s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [513.201165] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [513.203889] Starting dynamic subtest: A-HDMI-A1 [513.884321] Dynamic subtest A-HDMI-A1: SUCCESS (0.680s) [513.894906] Starting dynamic subtest: B-HDMI-A1 [514.500209] Dynamic subtest B-HDMI-A1: SUCCESS (0.614s) [514.508209] Starting dynamic subtest: C-HDMI-A1 [515.137467] Dynamic subtest C-HDMI-A1: SUCCESS (0.636s) [515.145091] Starting dynamic subtest: D-HDMI-A1 [515.773421] Dynamic subtest D-HDMI-A1: SUCCESS (0.635s) [515.775284] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.573s) [515.899943] [117/131] (523s left) core_getstats [515.998987] [118/131] (523s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [516.089717] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [516.090459] Starting dynamic subtest: pipe-A-HDMI-A-1 [516.108662] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [516.116294] Starting dynamic subtest: pipe-B-HDMI-A-1 [516.134989] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [516.142508] Starting dynamic subtest: pipe-C-HDMI-A-1 [516.160484] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [516.168036] Starting dynamic subtest: pipe-D-HDMI-A-1 [516.186441] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [516.187880] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.013s) [516.325369] [119/131] (523s left) kms_psr (fbc-psr-sprite-mmap-gtt) [516.416503] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [516.461193] [120/131] (523s left) perf_pmu (rc6-suspend) [516.501384] Starting subtest: rc6-suspend [539.250651] Subtest rc6-suspend: SUCCESS (7.529s) [542.632721] [121/131] (515s left) kms_invalid_mode (zero-vdisplay) [542.733753] Starting subtest: zero-vdisplay [542.734469] Starting dynamic subtest: pipe-A-HDMI-A-1 [542.787010] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s) [542.797702] Starting dynamic subtest: pipe-B-HDMI-A-1 [542.798481] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [542.806026] Starting dynamic subtest: pipe-C-HDMI-A-1 [542.806783] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [542.814234] Starting dynamic subtest: pipe-D-HDMI-A-1 [542.815004] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [542.815776] Subtest zero-vdisplay: SUCCESS (0.061s) [542.925065] [122/131] (515s left) kms_flip (2x-modeset-vs-vblank-race) [543.015205] Starting subtest: 2x-modeset-vs-vblank-race [543.023399] Subtest 2x-modeset-vs-vblank-race: SKIP (0.009s) [543.090968] [123/131] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [543.183912] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [543.185393] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [543.287118] [124/131] (514s left) gem_ctx_persistence (heartbeat-close) [543.328478] Starting subtest: heartbeat-close [543.524650] Subtest heartbeat-close: SUCCESS (0.195s) [543.601720] [125/131] (514s left) gem_basic (create-close) [543.639400] Starting subtest: create-close [543.641004] Subtest create-close: SUCCESS (0.000s) [543.727535] [126/131] (514s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [543.764661] Starting subtest: cpuset-basic-small-copy-odd [547.482349] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.717s) [547.585517] [127/131] (510s left) gem_exec_schedule (u-semaphore-user) [547.688094] Starting subtest: u-semaphore-user [547.693915] Subtest u-semaphore-user: SUCCESS (0.006s) [548.000993] [128/131] (510s left) gem_exec_reloc (basic-write-wc-noreloc) [548.041197] Starting subtest: basic-write-wc-noreloc [548.043419] Subtest basic-write-wc-noreloc: SUCCESS (0.002s) [548.159606] [129/131] (510s left) kms_busy (extended-pageflip-hang-newfb) [548.251789] Starting subtest: extended-pageflip-hang-newfb [548.253608] Starting dynamic subtest: pipe-A [562.148778] Dynamic subtest pipe-A: SUCCESS (13.891s) [562.159773] Starting dynamic subtest: pipe-D [575.955125] Dynamic subtest pipe-D: SUCCESS (13.798s) [575.955966] Subtest extended-pageflip-hang-newfb: SUCCESS (27.695s) [576.079538] [130/131] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [576.176953] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [576.178427] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [576.299955] [131/131] (482s left) kms_flip (2x-busy-flip) [576.387566] Starting subtest: 2x-busy-flip [576.396582] Subtest 2x-busy-flip: SKIP (0.009s) [576.462612] Closing watchdogs Done.