[64.806063] Initializing watchdogs [64.806135] /dev/watchdog0 [64.827386] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [64.839552] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.843618] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.846284] [001/132] (960s left) gem_exec_params (invalid-bsd2-flag-on-render) [64.933416] Starting subtest: invalid-bsd2-flag-on-render [64.934270] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [65.097568] [002/132] (960s left) gem_exec_params (rel-constants-invalid-rel-gen5) [65.180872] Starting subtest: rel-constants-invalid-rel-gen5 [65.181707] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [65.332426] [003/132] (960s left) kms_chamelium_frames (dp-frame-dump) [66.893204] Subtest dp-frame-dump: SKIP (0.000s) [67.006643] [004/132] (958s left) gem_lmem_swapping (basic) [72.414197] Starting subtest: basic [72.415036] Starting dynamic subtest: lmem0 [95.408969] Dynamic subtest lmem0: SUCCESS (22.998s) [95.409946] Subtest basic: SUCCESS (22.999s) [97.495722] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true [97.497547] [005/132] (928s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [101.237576] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [101.342648] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [101.431684] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)] new: kernel.kmod_is_loaded.i915: true [101.434089] [006/132] (924s left) gem_mmap_gtt (hang) [101.512067] Subtest hang: SKIP (0.000s) [101.578532] [007/132] (924s left) gem_ringfill (basic-all) [102.046862] Starting subtest: basic-all [103.560117] Subtest basic-all: SUCCESS (1.513s) [103.723502] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [103.725360] [008/132] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [105.241263] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [107.689222] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.448s) [107.879209] [009/132] (917s left) kms_frontbuffer_tracking (psr-suspend) [109.403563] Starting subtest: psr-suspend [109.405239] Subtest psr-suspend: SKIP (0.000s) [109.547920] [010/132] (916s left) kms_psr (fbc-psr2-primary-blt) [111.088660] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [111.153552] [011/132] (914s left) gem_partial_pwrite_pread (writes-after-reads) [111.263041] Subtest writes-after-reads: SKIP (0.000s) [111.365015] [012/132] (914s left) kms_prop_blob (blob-multiple) [111.446987] Starting subtest: blob-multiple [111.481566] Subtest blob-multiple: SUCCESS (0.035s) [111.633478] [013/132] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [113.155427] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [113.157118] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [113.361786] [014/132] (912s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [114.901493] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [116.206730] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.305s) [116.380137] [015/132] (909s left) kms_lease (atomic-implicit-crtc) [117.893984] Starting subtest: atomic-implicit-crtc [117.894919] Starting dynamic subtest: pipe-A-HDMI-A-3 [117.899219] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s) [117.908781] Starting dynamic subtest: pipe-B-HDMI-A-3 [117.913126] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.012s) [117.923420] Starting dynamic subtest: pipe-C-HDMI-A-3 [117.928081] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.012s) [117.938503] Starting dynamic subtest: pipe-D-HDMI-A-3 [117.943489] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.013s) [117.944448] Subtest atomic-implicit-crtc: SUCCESS (0.044s) [118.095988] [016/132] (908s left) kms_psr (psr2-sprite-mmap-cpu) [119.625356] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s) [119.694149] [017/132] (906s left) perf_pmu (invalid-open) [119.787615] Starting subtest: invalid-open [119.788580] Subtest invalid-open: SUCCESS (0.000s) [119.947543] [018/132] (906s left) kms_psr (pr-primary-blt) [121.488262] Subtest pr-primary-blt: SKIP (0.000s) [121.560325] [019/132] (904s left) syncobj_wait (multi-wait-for-submit-signaled) [121.654468] Starting subtest: multi-wait-for-submit-signaled [121.655424] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [121.802938] [020/132] (904s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [123.331178] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [123.332149] Starting dynamic subtest: pipe-A [123.439805] Dynamic subtest pipe-A: SUCCESS (0.108s) [123.458996] Starting dynamic subtest: pipe-B [123.640259] Dynamic subtest pipe-B: SUCCESS (0.200s) [123.650111] Starting dynamic subtest: pipe-C [123.766242] Dynamic subtest pipe-C: SUCCESS (0.126s) [123.775924] Starting dynamic subtest: pipe-D [123.894064] Dynamic subtest pipe-D: SUCCESS (0.128s) [123.895036] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.563s) [124.082258] [021/132] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [125.619586] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [125.621273] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [125.775269] [022/132] (900s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [127.307142] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [127.365522] [023/132] (899s left) kms_dp_link_training (uhbr-sst) [128.887281] Starting subtest: uhbr-sst [128.889013] Subtest uhbr-sst: SKIP (0.000s) [129.075777] [024/132] (897s left) kms_content_protection (type1) [130.700041] Starting subtest: type1 [130.704302] Subtest type1: SKIP (0.003s) [130.877801] [025/132] (896s left) gem_exec_whisper (basic-normal) [131.014979] Starting subtest: basic-normal [134.120425] Subtest basic-normal: SUCCESS (3.104s) [134.323503] [026/132] (892s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [135.855383] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [135.857203] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [136.021786] [027/132] (891s left) kms_invalid_mode (bad-vsync-start) [137.557015] Starting subtest: bad-vsync-start [137.557974] Starting dynamic subtest: pipe-A-HDMI-A-3 [137.613393] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.056s) [137.623601] Starting dynamic subtest: pipe-B-HDMI-A-3 [137.624650] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [137.634579] Starting dynamic subtest: pipe-C-HDMI-A-3 [137.635497] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [137.645747] Starting dynamic subtest: pipe-D-HDMI-A-3 [137.646647] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [137.647602] Subtest bad-vsync-start: SUCCESS (0.062s) [137.810569] [028/132] (889s left) kms_pm_rpm (dpms-non-lpsp) [142.082112] Starting subtest: dpms-non-lpsp [142.231144] Subtest dpms-non-lpsp: SUCCESS (0.149s) [143.083129] [029/132] (884s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [144.609911] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [144.610843] Starting dynamic subtest: pipe-A-HDMI-A-3 [144.619364] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [144.629987] Starting dynamic subtest: pipe-B-HDMI-A-3 [144.638948] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [144.649974] Starting dynamic subtest: pipe-C-HDMI-A-3 [144.658625] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [144.669571] Starting dynamic subtest: pipe-D-HDMI-A-3 [144.678809] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [144.680486] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s) [144.887930] [030/132] (882s left) gem_mmap_offset (mmap-unmap) [144.971248] Starting subtest: mmap-unmap [144.972202] Starting dynamic subtest: lmem0 [146.106082] Dynamic subtest lmem0: SUCCESS (1.134s) [146.115759] Starting dynamic subtest: smem0 [147.694671] Dynamic subtest smem0: SUCCESS (1.588s) [147.695574] Subtest mmap-unmap: SUCCESS (2.723s) [147.902031] [031/132] (879s left) i915_pm_rpm (gem-execbuf-stress-pc8) [151.983538] Starting subtest: gem-execbuf-stress-pc8 [152.194066] Subtest gem-execbuf-stress-pc8: SKIP (0.209s) [153.086050] [032/132] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [154.603433] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [154.605136] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [154.735099] [033/132] (872s left) kms_cursor_edge_walk (64x64-top-edge) [156.279153] Starting subtest: 64x64-top-edge [156.280122] Starting dynamic subtest: pipe-A-HDMI-A-3 [159.661327] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.381s) [159.671644] Starting dynamic subtest: pipe-D-HDMI-A-3 [162.880257] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.218s) [162.881165] Subtest 64x64-top-edge: SUCCESS (6.601s) [163.091654] [034/132] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [164.609985] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [164.611680] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [164.739895] [035/132] (863s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [166.281482] Starting subtest: cursorA-vs-flipB-toggle [166.283210] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [166.413527] [036/132] (861s left) gem_busy (close-race) [166.532517] Starting subtest: close-race [188.960536] Subtest close-race: SUCCESS (22.428s) [189.489156] [037/132] (838s left) kms_plane_multiple (tiling-x) [191.125952] Starting subtest: tiling-x [191.126946] Starting dynamic subtest: pipe-A-HDMI-A-3 [192.107994] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.982s) [192.122528] Starting dynamic subtest: pipe-B-HDMI-A-3 [192.987426] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.879s) [193.001066] Starting dynamic subtest: pipe-C-HDMI-A-3 [193.832356] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.843s) [193.843519] Starting dynamic subtest: pipe-D-HDMI-A-3 [194.608869] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.775s) [194.609800] Subtest tiling-x: SUCCESS (3.484s) [194.819653] [038/132] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [196.344261] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [196.345980] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [196.511458] [039/132] (831s left) gem_exec_reloc (basic-write-cpu-noreloc) [196.616843] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [196.715038] [040/132] (831s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [198.246419] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [198.248209] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [198.410276] [041/132] (829s left) gem_exec_schedule (semaphore-noskip) [198.532211] Starting subtest: semaphore-noskip [199.357850] Subtest semaphore-noskip: SUCCESS (0.825s) [199.781295] [042/132] (828s left) prime_mmap (test_dup) [199.880482] Starting subtest: test_dup [199.881495] Starting dynamic subtest: test_dup-smem [199.944256] Dynamic subtest test_dup-smem: SUCCESS (0.064s) [199.956515] Starting dynamic subtest: test_dup-lmem0 [200.206371] Dynamic subtest test_dup-lmem0: SUCCESS (0.261s) [200.207380] Subtest test_dup: SUCCESS (0.326s) [200.310369] [043/132] (828s left) gem_lmem_swapping (verify) [205.200792] Starting subtest: verify [205.201749] Starting dynamic subtest: lmem0 [255.052461] Dynamic subtest lmem0: SUCCESS (49.851s) [255.053479] Subtest verify: SUCCESS (49.852s) [257.419633] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [257.420905] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true [257.422816] [044/132] (771s left) syncobj_wait (single-wait-submitted) [261.537140] Starting subtest: single-wait-submitted [261.638675] Subtest single-wait-submitted: SUCCESS (0.102s) [261.739062] [FACT syncobj_wait (single-wait-submitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [261.742172] [FACT syncobj_wait (single-wait-submitted)] new: kernel.kmod_is_loaded.i915: true [261.745634] [045/132] (766s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [263.292284] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [263.294240] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [263.400731] [046/132] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [264.967249] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [267.816822] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.850s) [267.976745] [047/132] (760s left) prime_mmap (test_forked) [268.055569] Starting subtest: test_forked [268.056471] Starting dynamic subtest: test_forked-smem [268.116591] Dynamic subtest test_forked-smem: SUCCESS (0.061s) [268.125379] Starting dynamic subtest: test_forked-lmem0 [268.335535] Dynamic subtest test_forked-lmem0: SUCCESS (0.218s) [268.336553] Subtest test_forked: SUCCESS (0.280s) [268.471574] [048/132] (760s left) gem_fence_thrash (bo-write-verify-y) [268.520314] Starting subtest: bo-write-verify-y [268.558259] Subtest bo-write-verify-y: SKIP (0.037s) [268.641072] [049/132] (760s left) i915_selftest (live) [269.508875] Starting subtest: live [269.509913] Starting dynamic subtest: sanitycheck [271.201830] Dynamic subtest sanitycheck: SUCCESS (1.693s) [271.210210] Starting dynamic subtest: uncore [272.966951] Dynamic subtest uncore: SUCCESS (1.764s) [272.976699] Starting dynamic subtest: workarounds [289.783957] Dynamic subtest workarounds: FAIL (16.614s) [289.791266] Starting dynamic subtest: gt_engines [292.030038] Dynamic subtest gt_engines: SUCCESS (2.447s) [292.037966] Starting dynamic subtest: gt_timelines [316.922388] Dynamic subtest gt_timelines: SUCCESS (24.891s) [316.932185] Starting dynamic subtest: gt_contexts [318.966912] Dynamic subtest gt_contexts: SUCCESS (2.044s) [318.976308] Starting dynamic subtest: gt_lrc [325.787967] Dynamic subtest gt_lrc: SUCCESS (6.820s) [325.798843] Starting dynamic subtest: gt_mocs [329.217098] Dynamic subtest gt_mocs: SUCCESS (3.428s) [329.225399] Starting dynamic subtest: gt_pm [333.592954] Dynamic subtest gt_pm: SUCCESS (4.375s) [333.601172] Starting dynamic subtest: gt_heartbeat [335.331100] Dynamic subtest gt_heartbeat: SUCCESS (1.737s) [335.340214] Starting dynamic subtest: gt_tlb [349.234023] Dynamic subtest gt_tlb: SUCCESS (13.902s) [349.243953] Starting dynamic subtest: requests [363.367042] Dynamic subtest requests: SUCCESS (14.132s) [363.377027] Starting dynamic subtest: migrate [368.755893] Dynamic subtest migrate: SUCCESS (5.388s) [368.765312] Starting dynamic subtest: active [370.749243] Dynamic subtest active: SUCCESS (1.992s) [370.759573] Starting dynamic subtest: objects [374.118885] Dynamic subtest objects: SUCCESS (3.368s) [374.129240] Starting dynamic subtest: mman [381.847910] Dynamic subtest mman: SUCCESS (7.728s) [381.856809] Starting dynamic subtest: dmabuf [384.062206] Dynamic subtest dmabuf: SUCCESS (2.213s) [384.072221] Starting dynamic subtest: vma [386.220119] Dynamic subtest vma: SUCCESS (2.157s) [386.232262] Starting dynamic subtest: coherency [390.941908] Dynamic subtest coherency: SUCCESS (4.720s) [390.950139] Starting dynamic subtest: gtt [400.723026] Dynamic subtest gtt: SUCCESS (9.779s) [400.735116] Starting dynamic subtest: gem [402.918971] Dynamic subtest gem: SUCCESS (2.195s) [402.928164] Starting dynamic subtest: evict [406.355983] Dynamic subtest evict: SUCCESS (3.436s) [406.365124] Starting dynamic subtest: hugepages [425.532867] Dynamic subtest hugepages: SUCCESS (19.175s) [425.542194] Starting dynamic subtest: gem_contexts [461.813024] Dynamic subtest gem_contexts: SUCCESS (36.278s) [461.826277] Starting dynamic subtest: client [464.324170] Dynamic subtest client: SUCCESS (2.510s) [464.337551] Starting dynamic subtest: gem_migrate [468.603868] Dynamic subtest gem_migrate: SUCCESS (4.278s) [468.615635] Starting dynamic subtest: reset [470.792315] Dynamic subtest reset: SUCCESS (2.187s) [470.805935] Starting dynamic subtest: memory_region [474.495033] Dynamic subtest memory_region: SUCCESS (3.701s) [474.508071] Starting dynamic subtest: hangcheck [505.114993] Dynamic subtest hangcheck: SUCCESS (30.618s) [505.123523] Starting dynamic subtest: execlists [506.930132] Dynamic subtest execlists: SUCCESS (1.814s) [506.938407] Starting dynamic subtest: ring_submission [508.760065] Dynamic subtest ring_submission: SUCCESS (1.829s) [508.770183] Starting dynamic subtest: perf [510.877184] Dynamic subtest perf: SUCCESS (2.116s) [510.887361] Starting dynamic subtest: slpc [518.697899] Dynamic subtest slpc: SUCCESS (7.819s) [518.706137] Starting dynamic subtest: guc [521.785927] Dynamic subtest guc: SUCCESS (3.087s) [521.794080] Starting dynamic subtest: guc_multi_lrc [523.748679] Dynamic subtest guc_multi_lrc: SUCCESS (1.961s) [523.759074] Starting dynamic subtest: guc_hang [526.501936] Dynamic subtest guc_hang: SUCCESS (2.753s) [526.511287] Starting dynamic subtest: late_gt_pm [528.548857] Dynamic subtest late_gt_pm: SUCCESS (2.045s) [528.549822] Subtest live: FAIL (259.035s) [528.586722] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [528.588331] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [528.590586] [050/132] (500s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [533.969053] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [533.971211] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [534.162603] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [534.167308] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: kernel.kmod_is_loaded.i915: true [534.171764] [051/132] (494s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [534.309700] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [534.312665] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [534.482255] [052/132] (494s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [534.624061] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [534.625140] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [534.797711] [053/132] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [536.397926] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [536.399986] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [536.544720] [054/132] (492s left) kms_vrr (flip-basic) [538.145968] Starting subtest: flip-basic [538.148931] Subtest flip-basic: SKIP (0.000s) [538.288379] [055/132] (491s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [539.866072] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [539.867920] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [540.039251] [056/132] (489s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [541.613281] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [541.614252] Starting dynamic subtest: pipe-A-HDMI-A-3 [541.623927] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [541.637233] Starting dynamic subtest: pipe-B-HDMI-A-3 [541.646946] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [541.660065] Starting dynamic subtest: pipe-C-HDMI-A-3 [541.669863] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [541.684494] Starting dynamic subtest: pipe-D-HDMI-A-3 [541.694237] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [541.696508] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s) [541.933222] [057/132] (487s left) kms_plane (pixel-format-linear-modifier-source-clamping) [543.507507] Starting subtest: pixel-format-linear-modifier-source-clamping [543.542376] Starting dynamic subtest: pipe-A-plane-0 [550.208192] Dynamic subtest pipe-A-plane-0: SUCCESS (6.666s) [550.223297] Starting dynamic subtest: pipe-A-plane-3 [553.275382] Dynamic subtest pipe-A-plane-3: SUCCESS (3.066s) [553.447696] Starting dynamic subtest: pipe-B-plane-0 [559.339263] Dynamic subtest pipe-B-plane-0: SUCCESS (5.900s) [559.367376] Starting dynamic subtest: pipe-B-plane-3 [562.405373] Dynamic subtest pipe-B-plane-3: SUCCESS (3.064s) [562.465257] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (18.957s) [562.706222] [058/132] (466s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [564.236368] Starting subtest: 2x-wf_vblank-ts-check-interruptible [564.252410] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s) [564.354543] [059/132] (465s left) kms_big_fb (y-tiled-16bpp-rotate-180) [565.911500] Starting subtest: y-tiled-16bpp-rotate-180 [565.913408] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [566.087748] [060/132] (463s left) kms_flip (basic-flip-vs-dpms) [567.632840] Starting subtest: basic-flip-vs-dpms [567.640229] Starting dynamic subtest: A-HDMI-A3 [568.499957] Dynamic subtest A-HDMI-A3: SUCCESS (0.858s) [568.512230] Starting dynamic subtest: B-HDMI-A3 [569.282188] Dynamic subtest B-HDMI-A3: SUCCESS (0.780s) [569.299513] Starting dynamic subtest: C-HDMI-A3 [570.106410] Dynamic subtest C-HDMI-A3: SUCCESS (0.822s) [570.123893] Starting dynamic subtest: D-HDMI-A3 [570.930128] Dynamic subtest D-HDMI-A3: SUCCESS (0.821s) [570.931234] Subtest basic-flip-vs-dpms: SUCCESS (3.297s) [571.198276] [061/132] (458s left) kms_pm_rpm (pm-caching) [575.071908] Starting subtest: pm-caching [575.074547] Subtest pm-caching: SKIP (0.000s) [576.072611] [062/132] (453s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [577.668415] Starting subtest: compare-crc-sanitycheck-nv12 [577.671238] Starting dynamic subtest: pipe-A-HDMI-A-3 [578.394317] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.723s) [578.407028] Starting dynamic subtest: pipe-B-HDMI-A-3 [579.015033] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.619s) [579.030953] Starting dynamic subtest: pipe-C-HDMI-A-3 [579.624178] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.606s) [579.638481] Starting dynamic subtest: pipe-D-HDMI-A-3 [580.210214] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.583s) [580.211189] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.541s) [580.414804] [063/132] (449s left) kms_color (deep-color) [581.964607] Starting subtest: deep-color [581.973897] Subtest deep-color: SKIP (0.004s) [582.158095] [064/132] (447s left) kms_big_fb (x-tiled-8bpp-rotate-0) [583.750441] Starting subtest: x-tiled-8bpp-rotate-0 [585.913187] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.162s) [586.143359] [065/132] (444s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [587.707802] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s) [587.797578] [066/132] (442s left) gem_mmap (basic) [587.911578] Subtest basic: SKIP (0.000s) [588.014349] [067/132] (442s left) gen9_exec_parse (bb-secure) [588.146104] Subtest bb-secure: SKIP (0.000s) [588.230576] [068/132] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [589.801455] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [589.803307] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [589.967847] [069/132] (440s left) i915_drm_fdinfo (virtual-busy-idle) [590.079030] Starting subtest: virtual-busy-idle [590.081064] Subtest virtual-busy-idle: SKIP (0.000s) [590.235252] [070/132] (440s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [591.814810] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [591.816950] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [592.078700] [071/132] (438s left) drm_read (empty-block) [593.788144] Starting subtest: empty-block [594.787476] Subtest empty-block: SUCCESS (1.000s) [594.998377] [072/132] (435s left) perf_pmu (busy-accuracy-98) [595.108363] Starting subtest: busy-accuracy-98 [595.109381] Starting dynamic subtest: rcs0 [598.180176] Dynamic subtest rcs0: SUCCESS (3.070s) [598.191203] Starting dynamic subtest: bcs0 [601.236152] Dynamic subtest bcs0: SUCCESS (3.055s) [601.246893] Starting dynamic subtest: vcs0 [604.290938] Dynamic subtest vcs0: SUCCESS (3.054s) [604.301588] Starting dynamic subtest: vcs1 [607.345368] Dynamic subtest vcs1: SUCCESS (3.053s) [607.356273] Starting dynamic subtest: vecs0 [610.401434] Dynamic subtest vecs0: SUCCESS (3.055s) [610.412123] Starting dynamic subtest: vecs1 [613.456499] Dynamic subtest vecs1: SUCCESS (3.054s) [613.467125] Starting dynamic subtest: ccs0 [616.513375] Dynamic subtest ccs0: SUCCESS (3.056s) [616.514271] Subtest busy-accuracy-98: SUCCESS (21.404s) [616.681952] [073/132] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [618.202468] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [618.204296] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [618.374386] [074/132] (412s left) kms_cursor_crc (cursor-rapid-movement-256x256) [620.222386] Starting subtest: cursor-rapid-movement-256x256 [620.230247] Starting dynamic subtest: pipe-A-HDMI-A-3 [620.642866] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.414s) [620.689342] Starting dynamic subtest: pipe-D-HDMI-A-3 [621.044117] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.367s) [621.045069] Subtest cursor-rapid-movement-256x256: SUCCESS (0.821s) [621.446199] [075/132] (409s left) gem_ccs (block-copy-uncompressed) [621.559303] Starting subtest: block-copy-uncompressed [621.561852] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [621.617679] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.057s) [621.632788] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0 [621.637915] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.019s) [621.653174] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem [621.747515] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.108s) [621.763023] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0 [621.860280] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.111s) [621.875632] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [621.880804] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s) [621.896047] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0 [621.900328] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.018s) [621.915636] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem [622.008530] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.107s) [622.023952] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0 [622.117742] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.108s) [622.133204] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [622.138209] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s) [622.153307] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0 [622.157206] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.018s) [622.172394] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem [622.268451] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s) [622.283642] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0 [622.375260] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.105s) [622.390622] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [622.395554] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s) [622.410793] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0 [622.414878] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.018s) [622.430100] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem [622.529513] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.113s) [622.544939] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0 [622.638031] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.107s) [622.639054] Subtest block-copy-uncompressed: SUCCESS (1.079s) [622.814079] [076/132] (408s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [624.374098] Starting subtest: fbcpsr-shrfb-scaledprimary [624.376269] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [624.556910] [077/132] (406s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [626.209265] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [626.351136] [078/132] (404s left) prime_vgem (fence-write-hang) [626.496408] Subtest fence-write-hang: SKIP (0.000s) [626.653379] [079/132] (404s left) kms_cursor_crc (cursor-offscreen-256x256) [628.577455] Starting subtest: cursor-offscreen-256x256 [628.584057] Starting dynamic subtest: pipe-A-HDMI-A-3 [631.090392] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.505s) [631.133900] Starting dynamic subtest: pipe-D-HDMI-A-3 [633.513351] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.389s) [633.514299] Subtest cursor-offscreen-256x256: SUCCESS (4.936s) [633.811832] [080/132] (397s left) kms_async_flips (invalid-async-flip-atomic) [635.329055] Starting subtest: invalid-async-flip-atomic [635.532140] Starting dynamic subtest: pipe-A-HDMI-A-3 [635.896523] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.364s) [636.048979] Starting dynamic subtest: pipe-B-HDMI-A-3 [636.151328] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.113s) [636.306650] Starting dynamic subtest: pipe-C-HDMI-A-3 [636.419923] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.123s) [636.570598] Starting dynamic subtest: pipe-D-HDMI-A-3 [636.670569] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.110s) [636.672341] Subtest invalid-async-flip-atomic: SUCCESS (1.345s) [637.067196] [081/132] (394s left) kms_tiled_display (basic-test-pattern-with-chamelium) [639.317995] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [639.391633] [082/132] (392s left) kms_async_flips (async-flip-hang) [640.936977] Starting subtest: async-flip-hang [641.142139] Starting dynamic subtest: pipe-A-HDMI-A-3 [667.523226] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.380s) [667.692740] Starting dynamic subtest: pipe-B-HDMI-A-3 [692.461542] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (24.777s) [692.599646] Starting dynamic subtest: pipe-C-HDMI-A-3 [707.508465] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (14.918s) [707.659300] Starting dynamic subtest: pipe-D-HDMI-A-3 [731.509609] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (23.859s) [731.510485] Subtest async-flip-hang: SUCCESS (90.571s) [731.804957] [083/132] (299s left) gem_exec_reloc (basic-cpu-active) [731.892403] Subtest basic-cpu-active: SKIP (0.000s) [731.957502] [084/132] (299s left) kms_force_connector_basic (prune-stale-modes) [732.119298] Starting subtest: prune-stale-modes [732.142364] Subtest prune-stale-modes: SUCCESS (0.024s) [733.787086] [085/132] (297s left) gem_exec_suspend (basic) [733.890879] Starting subtest: basic [733.891801] Starting dynamic subtest: smem [735.121915] Dynamic subtest smem: SUCCESS (1.230s) [735.135969] Starting dynamic subtest: lmem0 [736.406671] Dynamic subtest lmem0: SUCCESS (1.284s) [736.407725] Subtest basic: SUCCESS (2.517s) [736.667638] [086/132] (295s left) gem_ctx_persistence (legacy-engines-persistence) [736.776040] Starting subtest: legacy-engines-persistence [736.777008] Starting dynamic subtest: render [737.607863] Dynamic subtest render: SUCCESS (0.831s) [737.623519] Starting dynamic subtest: bsd1 [738.360982] Dynamic subtest bsd1: SUCCESS (0.751s) [738.376812] Starting dynamic subtest: bsd2 [739.106718] Dynamic subtest bsd2: SUCCESS (0.742s) [739.121762] Starting dynamic subtest: blt [739.900844] Dynamic subtest blt: SUCCESS (0.790s) [739.915613] Starting dynamic subtest: vebox [740.668095] Dynamic subtest vebox: SUCCESS (0.763s) [740.672664] Subtest legacy-engines-persistence: SUCCESS (3.894s) [740.851858] [087/132] (291s left) gem_exec_reloc (basic-concurrent0) [740.943418] Subtest basic-concurrent0: SKIP (0.000s) [741.024929] [088/132] (290s left) kms_psr (psr-sprite-plane-onoff) [742.541524] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [742.617393] [089/132] (289s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [744.163201] Starting subtest: fbc-rgb101010-draw-mmap-gtt [744.164952] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [744.337655] [090/132] (287s left) syncobj_timeline (invalid-query-bad-pad) [744.444765] Starting subtest: invalid-query-bad-pad [744.445651] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [744.612519] [091/132] (287s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [746.142901] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [746.144919] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [746.309817] [092/132] (286s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [747.859272] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [749.196905] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.337s) [749.382198] [093/132] (283s left) gem_exec_balancer (smoke) [749.489563] Starting subtest: smoke [773.766798] Subtest smoke: SUCCESS (24.276s) [774.744259] [094/132] (257s left) gem_pread (self) [774.833408] Subtest self: SKIP (0.000s) [774.929701] [095/132] (257s left) kms_flip (2x-flip-vs-panning-vs-hang) [776.473501] Starting subtest: 2x-flip-vs-panning-vs-hang [776.489501] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.016s) [776.648276] [096/132] (255s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [778.195653] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [778.197693] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s) [778.361487] [097/132] (254s left) drm_mm (drm_mm) [778.454824] Starting subtest: drm_mm [778.537942] Starting dynamic subtest: drm_test_mm_init [778.605363] Dynamic subtest drm_test_mm_init: SUCCESS (0.068s) [778.636490] Starting dynamic subtest: drm_test_mm_debug [778.678849] Dynamic subtest drm_test_mm_debug: SUCCESS (0.070s) [778.709435] Starting dynamic subtest: drm_test_mm_align32 [778.752758] Dynamic subtest drm_test_mm_align32: SUCCESS (0.072s) [778.782467] Starting dynamic subtest: drm_test_mm_align64 [778.821044] Dynamic subtest drm_test_mm_align64: SUCCESS (0.066s) [778.852203] Starting dynamic subtest: drm_test_mm_lowest [778.901905] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.077s) [778.932163] Starting dynamic subtest: drm_test_mm_highest [778.978941] Dynamic subtest drm_test_mm_highest: SUCCESS (0.075s) [778.980288] Subtest drm_mm: SUCCESS (0.525s) [779.209779] [098/132] (253s left) gem_mmap_wc (set-cache-level) [779.323022] Subtest set-cache-level: SKIP (0.000s) [779.419209] [099/132] (253s left) i915_drm_fdinfo (busy-idle-check-all) [779.530471] Starting subtest: busy-idle-check-all [779.531507] Starting dynamic subtest: rcs0 [779.574795] Dynamic subtest rcs0: SKIP (0.042s) [779.591200] Starting dynamic subtest: bcs0 [779.593258] Dynamic subtest bcs0: SKIP (0.001s) [779.609409] Starting dynamic subtest: vcs0 [779.611565] Dynamic subtest vcs0: SKIP (0.001s) [779.627727] Starting dynamic subtest: vcs1 [779.630054] Dynamic subtest vcs1: SKIP (0.001s) [779.646081] Starting dynamic subtest: vecs0 [779.648302] Dynamic subtest vecs0: SKIP (0.001s) [779.664581] Starting dynamic subtest: vecs1 [779.666525] Dynamic subtest vecs1: SKIP (0.001s) [779.682673] Starting dynamic subtest: ccs0 [779.684956] Dynamic subtest ccs0: SKIP (0.001s) [779.687058] Subtest busy-idle-check-all: SKIP (0.058s) [779.758685] [100/132] (253s left) gem_create (hog-create) [779.877119] Starting subtest: hog-create [779.878636] Starting dynamic subtest: lmem0 [812.179394] Dynamic subtest lmem0: SUCCESS (32.301s) [812.201874] Starting dynamic subtest: smem0 [844.440240] Dynamic subtest smem0: SUCCESS (32.258s) [844.441190] Subtest hog-create: SUCCESS (64.562s) [844.701447] [101/132] (188s left) api_intel_bb (full-batch) [844.803274] Starting subtest: full-batch [844.843427] Subtest full-batch: SUCCESS (0.040s) [845.019528] [102/132] (188s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [846.550850] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [846.552634] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [846.697682] [103/132] (186s left) kms_cursor_legacy (forked-bo) [848.251588] Starting subtest: forked-bo [848.252513] Starting dynamic subtest: pipe-A [853.668848] Dynamic subtest pipe-A: SUCCESS (5.415s) [853.690058] Starting dynamic subtest: pipe-B [859.100561] Dynamic subtest pipe-B: SUCCESS (5.430s) [859.121043] Starting dynamic subtest: pipe-C [864.525037] Dynamic subtest pipe-C: SUCCESS (5.422s) [864.547561] Starting dynamic subtest: pipe-D [869.956609] Dynamic subtest pipe-D: SUCCESS (5.428s) [869.981401] Starting dynamic subtest: all-pipes [875.385307] Dynamic subtest all-pipes: SUCCESS (5.426s) [875.386254] Subtest forked-bo: SUCCESS (27.134s) [875.556705] [104/132] (157s left) prime_mmap (test_correct) [875.660491] Starting subtest: test_correct [875.661478] Starting dynamic subtest: test_correct-smem [875.726534] Dynamic subtest test_correct-smem: SUCCESS (0.065s) [875.742419] Starting dynamic subtest: test_correct-lmem0 [875.997854] Dynamic subtest test_correct-lmem0: SUCCESS (0.269s) [875.998819] Subtest test_correct: SUCCESS (0.338s) [876.140072] [105/132] (157s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [877.694585] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [877.696632] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [877.879739] [106/132] (155s left) gem_exec_balancer (full-late-pulse) [878.034492] Starting subtest: full-late-pulse [881.417348] Subtest full-late-pulse: SUCCESS (3.383s) [881.951802] [107/132] (151s left) kms_cdclk (plane-scaling) [883.500571] Starting subtest: plane-scaling [883.501542] Starting dynamic subtest: pipe-A-HDMI-A-3 [883.567498] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.065s) [883.584351] Starting dynamic subtest: pipe-B-HDMI-A-3 [883.586373] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s) [883.602980] Starting dynamic subtest: pipe-C-HDMI-A-3 [883.605056] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s) [883.621495] Starting dynamic subtest: pipe-D-HDMI-A-3 [883.623501] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s) [883.625466] Subtest plane-scaling: SKIP (0.083s) [883.763692] [108/132] (149s left) gem_userptr_blits (input-checking) [883.887419] Starting subtest: input-checking [883.888423] Subtest input-checking: SUCCESS (0.000s) [884.067549] [109/132] (149s left) gem_spin_batch (spin-each) [884.184937] Starting subtest: spin-each [887.606743] Subtest spin-each: SUCCESS (3.422s) [887.886543] [110/132] (145s left) sw_sync (sync_multi_consumer) [887.937499] Starting subtest: sync_multi_consumer [888.305756] Subtest sync_multi_consumer: SUCCESS (0.369s) [888.388320] [111/132] (145s left) gem_exec_reloc (basic-wc-gtt-active) [888.485992] Subtest basic-wc-gtt-active: SKIP (0.000s) [888.563084] [112/132] (145s left) gem_userptr_blits (nohangcheck) [888.670150] Starting subtest: nohangcheck [889.016009] Subtest nohangcheck: SUCCESS (0.346s) [889.181995] [113/132] (144s left) kms_plane (plane-position-hole) [890.702500] Starting subtest: plane-position-hole [891.091676] Starting dynamic subtest: pipe-A-plane-1 [891.493205] Dynamic subtest pipe-A-plane-1: SUCCESS (0.401s) [891.508284] Starting dynamic subtest: pipe-A-plane-2 [891.865968] Dynamic subtest pipe-A-plane-2: SUCCESS (0.372s) [891.880382] Starting dynamic subtest: pipe-A-plane-3 [892.255452] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s) [892.270163] Starting dynamic subtest: pipe-A-plane-4 [892.639441] Dynamic subtest pipe-A-plane-4: SUCCESS (0.383s) [892.654213] Starting dynamic subtest: pipe-A-plane-5 [892.661565] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s) [892.972913] Starting dynamic subtest: pipe-B-plane-1 [893.343035] Dynamic subtest pipe-B-plane-1: SUCCESS (0.383s) [893.357743] Starting dynamic subtest: pipe-B-plane-2 [893.727940] Dynamic subtest pipe-B-plane-2: SUCCESS (0.384s) [893.744690] Starting dynamic subtest: pipe-B-plane-3 [894.114740] Dynamic subtest pipe-B-plane-3: SUCCESS (0.385s) [894.128258] Starting dynamic subtest: pipe-B-plane-4 [894.492427] Dynamic subtest pipe-B-plane-4: SUCCESS (0.377s) [894.505579] Starting dynamic subtest: pipe-B-plane-5 [894.513424] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s) [894.514330] Subtest plane-position-hole: SUCCESS (3.812s) [894.771523] [114/132] (139s left) sw_sync (sync_expired_merge) [894.829445] Starting subtest: sync_expired_merge [895.903791] Subtest sync_expired_merge: SUCCESS (1.074s) [895.996560] [115/132] (138s left) gem_ctx_persistence (engines-mixed-process) [896.107915] Starting subtest: engines-mixed-process [896.108944] Starting dynamic subtest: rcs0 [897.923185] Dynamic subtest rcs0: SUCCESS (1.815s) [897.938851] Starting dynamic subtest: bcs0 [899.910176] Dynamic subtest bcs0: SUCCESS (1.985s) [899.926098] Starting dynamic subtest: vcs0 [901.889201] Dynamic subtest vcs0: SUCCESS (1.977s) [901.903518] Starting dynamic subtest: vcs1 [903.862953] Dynamic subtest vcs1: SUCCESS (1.972s) [903.877180] Starting dynamic subtest: vecs0 [905.858776] Dynamic subtest vecs0: SUCCESS (1.994s) [905.873226] Starting dynamic subtest: vecs1 [907.896786] Dynamic subtest vecs1: SUCCESS (2.037s) [907.911273] Starting dynamic subtest: ccs0 [909.886995] Dynamic subtest ccs0: SUCCESS (1.989s) [909.887860] Subtest engines-mixed-process: SUCCESS (13.780s) [910.028942] [116/132] (124s left) kms_addfb_basic (bad-pitch-999) [910.118625] Starting subtest: bad-pitch-999 [910.119450] Subtest bad-pitch-999: SUCCESS (0.000s) [911.721797] [117/132] (122s left) gem_exec_fence (submit3) [911.951258] Starting subtest: submit3 [911.953795] Subtest submit3: SKIP (0.000s) [912.713529] [118/132] (121s left) syncobj_timeline (single-wait-for-submit-available-signaled) [912.801933] Starting subtest: single-wait-for-submit-available-signaled [912.802881] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [912.950477] [119/132] (121s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [913.036515] Starting subtest: etime-single-wait-all-for-submit-submitted [913.143130] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [913.265880] [120/132] (121s left) gem_exec_schedule (noreorder) [913.480795] Starting subtest: noreorder [913.481694] Starting dynamic subtest: rcs0 [913.572287] Dynamic subtest rcs0: SUCCESS (0.091s) [913.587602] Starting dynamic subtest: bcs0 [913.629936] Dynamic subtest bcs0: SUCCESS (0.056s) [913.662411] Starting dynamic subtest: vcs0 [913.701849] Dynamic subtest vcs0: SUCCESS (0.069s) [913.737331] Starting dynamic subtest: vcs1 [913.770402] Dynamic subtest vcs1: SUCCESS (0.066s) [913.796189] Starting dynamic subtest: vecs0 [913.843544] Dynamic subtest vecs0: SUCCESS (0.071s) [913.876895] Starting dynamic subtest: vecs1 [913.914630] Dynamic subtest vecs1: SUCCESS (0.069s) [913.945661] Starting dynamic subtest: ccs0 [913.986616] Dynamic subtest ccs0: SUCCESS (0.070s) [913.987947] Subtest noreorder: SUCCESS (0.507s) [914.272606] [121/132] (120s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [915.796070] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [915.797882] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [915.951047] [122/132] (118s left) gem_eio (wait-wedge-immediate) [916.273918] Starting subtest: wait-wedge-immediate [917.886212] Subtest wait-wedge-immediate: SUCCESS (1.613s) [919.437351] [123/132] (115s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [919.539447] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s) [919.628382] [124/132] (115s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [921.195998] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [922.350548] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (1.156s) [922.587558] [125/132] (112s left) sysfs_heartbeat_interval (nopreempt) [922.739012] Starting subtest: nopreempt [922.742041] Starting dynamic subtest: vecs0 [927.316381] Dynamic subtest vecs0: SUCCESS (4.575s) [927.336689] Starting dynamic subtest: ccs0 [931.772440] Dynamic subtest ccs0: SUCCESS (4.454s) [931.789880] Starting dynamic subtest: vcs0 [936.098333] Dynamic subtest vcs0: SUCCESS (4.324s) [936.123072] Starting dynamic subtest: bcs0 [940.511206] Dynamic subtest bcs0: SUCCESS (4.411s) [940.528370] Starting dynamic subtest: vecs1 [944.855410] Dynamic subtest vecs1: SUCCESS (4.343s) [944.873014] Starting dynamic subtest: rcs0 [949.362383] Dynamic subtest rcs0: SUCCESS (4.505s) [949.379675] Starting dynamic subtest: vcs1 [953.716371] Dynamic subtest vcs1: SUCCESS (4.352s) [953.717406] Subtest nopreempt: SUCCESS (30.977s) [953.924269] [126/132] ( 81s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [955.464563] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [955.465506] Starting dynamic subtest: pipe-A-HDMI-A-3 [955.474255] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [955.489673] Starting dynamic subtest: pipe-B-HDMI-A-3 [955.498881] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [955.514280] Starting dynamic subtest: pipe-C-HDMI-A-3 [955.523170] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [955.538490] Starting dynamic subtest: pipe-D-HDMI-A-3 [955.548505] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [955.550505] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [955.763656] [127/132] ( 79s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [957.305604] Starting subtest: flip-vs-cursor-busy-crc-atomic [958.048532] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.742s) [958.337918] [128/132] ( 76s left) kms_psr (fbc-psr-cursor-plane-onoff) [959.940046] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [960.063518] [129/132] ( 75s left) gem_pxp (protected-raw-src-copy-not-readible) [962.736260] Starting subtest: protected-raw-src-copy-not-readible [962.738291] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [962.856088] [130/132] ( 72s left) perf (missing-sample-flags) [963.341986] Starting subtest: missing-sample-flags [963.342925] Subtest missing-sample-flags: SUCCESS (0.000s) [963.406259] [131/132] ( 72s left) syncobj_wait (wait-all-delayed-signal) [963.497983] Starting subtest: wait-all-delayed-signal [963.600607] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [963.748679] [132/132] ( 71s left) template (b) [963.838789] Starting subtest: B [963.839721] Subtest B: SUCCESS (0.000s) [964.019591] Closing watchdogs results: parsing output: 0/ for test: gem_exec_params results: parsing output: 1/ for test: gem_exec_params results: parsing output: 2/ for test: kms_chamelium_frames results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_mmap_gtt results: parsing output: 6/ for test: gem_ringfill results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: gem_partial_pwrite_pread results: parsing output: 11/ for test: kms_prop_blob results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_lease results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_dp_link_training results: parsing output: 23/ for test: kms_content_protection results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_invalid_mode results: parsing output: 27/ for test: kms_pm_rpm results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: gem_mmap_offset results: parsing output: 30/ for test: i915_pm_rpm results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_cursor_edge_walk results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: gem_busy results: parsing output: 36/ for test: kms_plane_multiple results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_exec_reloc results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: prime_mmap results: parsing output: 42/ for test: gem_lmem_swapping results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: prime_mmap results: parsing output: 47/ for test: gem_fence_thrash results: parsing output: 48/ for test: i915_selftest results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: syncobj_wait results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_vrr results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_plane results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: kms_pm_rpm results: parsing output: 61/ for test: kms_pipe_crc_basic results: parsing output: 62/ for test: kms_color results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_psr2_sf results: parsing output: 65/ for test: gem_mmap results: parsing output: 66/ for test: gen9_exec_parse results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: i915_drm_fdinfo results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: drm_read results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: gem_ccs results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_chamelium_hpd results: parsing output: 77/ for test: prime_vgem results: parsing output: 78/ for test: kms_cursor_crc results: parsing output: 79/ for test: kms_async_flips results: parsing output: 80/ for test: kms_tiled_display results: parsing output: 81/ for test: kms_async_flips results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: kms_force_connector_basic results: parsing output: 84/ for test: gem_exec_suspend results: parsing output: 85/ for test: gem_ctx_persistence results: parsing output: 86/ for test: gem_exec_reloc results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: gem_exec_balancer results: parsing output: 93/ for test: gem_pread results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: drm_mm results: parsing output: 97/ for test: gem_mmap_wc results: parsing output: 98/ for test: i915_drm_fdinfo results: parsing output: 99/ for test: gem_create results: parsing output: 100/ for test: api_intel_bb results: parsing output: 101/ for test: kms_flip_scaled_crc results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: prime_mmap results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: kms_cdclk results: parsing output: 107/ for test: gem_userptr_blits results: parsing output: 108/ for test: gem_spin_batch results: parsing output: 109/ for test: sw_sync results: parsing output: 110/ for test: gem_exec_reloc results: parsing output: 111/ for test: gem_userptr_blits results: parsing output: 112/ for test: kms_plane results: parsing output: 113/ for test: sw_sync results: parsing output: 114/ for test: gem_ctx_persistence results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: gem_exec_fence results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gem_exec_schedule results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_eio results: parsing output: 122/ for test: sriov_basic results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: sysfs_heartbeat_interval results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_pxp results: parsing output: 129/ for test: perf results: parsing output: 130/ for test: syncobj_wait results: parsing output: 131/ for test: template Done.