[68.066412] Initializing watchdogs [68.066495] /dev/watchdog0 [68.095842] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [68.110773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [68.115862] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [68.118756] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [69.614083] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [69.615938] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [69.779686] [002/132] (958s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [69.830908] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [69.831851] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [69.973593] [003/132] (958s left) api_intel_allocator (reserve-simple) [70.016153] Starting subtest: reserve-simple [70.032293] Subtest reserve-simple: SUCCESS (0.016s) [70.268850] [004/132] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [71.761714] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [71.763928] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [71.997272] [005/132] (956s left) kms_getfb (getfb2-handle-zero) [73.492136] Starting subtest: getfb2-handle-zero [73.493097] Subtest getfb2-handle-zero: SUCCESS (0.000s) [73.753176] [006/132] (955s left) perf (disabled-read-error) [73.876644] Starting subtest: disabled-read-error [73.917091] Subtest disabled-read-error: SUCCESS (0.040s) [73.992703] [007/132] (955s left) kms_pm_dc (dc5-dpms-negative) [76.485323] Starting subtest: dc5-dpms-negative [80.715352] Subtest dc5-dpms-negative: SUCCESS (4.226s) [80.840295] [008/132] (948s left) gem_ccs (ctrl-surf-copy-new-ctx) [80.889158] Starting subtest: ctrl-surf-copy-new-ctx [80.890908] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [81.047163] [009/132] (948s left) kms_setmode (invalid-clone-single-crtc-stealing) [81.089902] Starting subtest: invalid-clone-single-crtc-stealing [81.092467] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [81.232930] [010/132] (948s left) gem_exec_balancer (bonded-pair) [81.288833] Starting subtest: bonded-pair [81.291107] Subtest bonded-pair: SKIP (0.000s) [81.711315] [011/132] (947s left) kms_psr (psr-dpms) [83.196566] Subtest psr-dpms: SKIP (0.000s) [83.271819] [012/132] (946s left) api_intel_bb (object-noreloc-purge-cache-simple) [83.316113] Starting subtest: object-noreloc-purge-cache-simple [83.336619] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.020s) [83.587424] [013/132] (946s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [85.069985] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [85.072072] Starting dynamic subtest: pipe-A-HDMI-A-4 [85.080469] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [85.088443] Starting dynamic subtest: pipe-B-HDMI-A-4 [85.096945] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [85.104901] Starting dynamic subtest: pipe-C-HDMI-A-4 [85.113824] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [85.121958] Starting dynamic subtest: pipe-D-HDMI-A-4 [85.131143] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [85.132934] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [85.378479] [014/132] (944s left) sriov_basic (bind-unbind-vf) [85.422341] Subtest bind-unbind-vf: SKIP (0.000s) [85.485617] [015/132] (944s left) i915_pm_rps (engine-order) [85.536943] Starting subtest: engine-order [93.351213] Subtest engine-order: SUCCESS (7.812s) [93.608196] [016/132] (936s left) kms_psr (pr-primary-mmap-cpu) [95.093228] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [95.171083] [017/132] (934s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [96.654131] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [96.719606] [018/132] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [98.208507] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [98.210238] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [98.471222] [019/132] (931s left) kms_color (ctm-max) [99.955808] Starting subtest: ctm-max [99.956886] Starting dynamic subtest: pipe-A-HDMI-A-4 [100.639784] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.685s) [100.648615] Starting dynamic subtest: pipe-B-HDMI-A-4 [101.168906] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.528s) [101.178584] Starting dynamic subtest: pipe-C-HDMI-A-4 [101.692198] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.523s) [101.701046] Starting dynamic subtest: pipe-D-HDMI-A-4 [102.224586] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.532s) [102.225437] Subtest ctm-max: SUCCESS (2.269s) [102.416320] [020/132] (927s left) i915_selftest (mock) [103.580494] Starting subtest: mock [103.581491] Starting dynamic subtest: sanitycheck [104.445921] Dynamic subtest sanitycheck: SUCCESS (0.865s) [104.453960] Starting dynamic subtest: shmem [105.378569] Dynamic subtest shmem: SUCCESS (0.930s) [105.408171] Starting dynamic subtest: fence [113.130573] Dynamic subtest fence: SUCCESS (7.751s) [113.161781] Starting dynamic subtest: scatterlist [115.054565] Dynamic subtest scatterlist: SUCCESS (1.923s) [115.066606] Starting dynamic subtest: syncmap [117.964869] Dynamic subtest syncmap: SUCCESS (2.909s) [117.977116] Starting dynamic subtest: uncore [118.881490] Dynamic subtest uncore: SUCCESS (0.915s) [118.914799] Starting dynamic subtest: ring [119.814525] Dynamic subtest ring: SUCCESS (0.931s) [119.841327] Starting dynamic subtest: engine [120.750563] Dynamic subtest engine: SUCCESS (0.934s) [120.781799] Starting dynamic subtest: timelines [126.197945] Dynamic subtest timelines: SUCCESS (5.447s) [126.207275] Starting dynamic subtest: requests [129.079373] Dynamic subtest requests: SUCCESS (2.881s) [129.087452] Starting dynamic subtest: objects [130.085395] Dynamic subtest objects: SUCCESS (1.005s) [130.096624] Starting dynamic subtest: phys [131.143922] Dynamic subtest phys: SUCCESS (1.058s) [131.153608] Starting dynamic subtest: dmabuf [132.179794] Dynamic subtest dmabuf: SUCCESS (1.035s) [132.188896] Starting dynamic subtest: vma [142.484663] Dynamic subtest vma: SUCCESS (10.304s) [142.493816] Starting dynamic subtest: evict [144.645135] Dynamic subtest evict: SUCCESS (2.160s) [144.654978] Starting dynamic subtest: gtt [148.559972] Dynamic subtest gtt: SUCCESS (3.914s) [148.570400] Starting dynamic subtest: hugepages [149.787817] Dynamic subtest hugepages: SUCCESS (1.227s) [149.795463] Starting dynamic subtest: memory_region [154.034762] Dynamic subtest memory_region: SUCCESS (4.247s) [154.035733] Subtest mock: SUCCESS (50.453s) [154.091071] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [154.092985] [021/132] (876s left) kms_flip (2x-absolute-wf_vblank) [158.816038] Starting subtest: 2x-absolute-wf_vblank [158.833578] Subtest 2x-absolute-wf_vblank: SKIP (0.018s) [159.101803] [FACT kms_flip (2x-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true [159.108234] [022/132] (871s left) syncobj_wait (invalid-reset-illegal-handle) [159.152515] Starting subtest: invalid-reset-illegal-handle [159.153383] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [159.336291] [023/132] (871s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [160.833900] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [160.835620] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [161.083591] [024/132] (869s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [162.576236] Starting subtest: extended-pageflip-modeset-hang-oldfb [162.578509] Starting dynamic subtest: pipe-A [170.376194] Dynamic subtest pipe-A: SUCCESS (7.798s) [170.388396] Starting dynamic subtest: pipe-D [178.095404] Dynamic subtest pipe-D: SUCCESS (7.715s) [178.096300] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.520s) [178.353554] [025/132] (852s left) gem_lmem_swapping (smem-oom) [182.709553] Starting subtest: smem-oom [182.710475] Starting dynamic subtest: lmem0 [203.356097] Dynamic subtest lmem0: CRASH (20.483s) [203.357238] Subtest smem-oom: SUCCESS (20.486s) [204.948838] Dynamic subtest lmem0: FAIL (22.227s) [204.949745] Subtest smem-oom: FAIL (22.227s) [206.050932] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true [206.053972] [026/132] (824s left) kms_setmode (basic-clone-single-crtc) [209.443754] Starting subtest: basic-clone-single-crtc [209.446529] Subtest basic-clone-single-crtc: SKIP (0.000s) [209.624420] [FACT kms_setmode (basic-clone-single-crtc)] new: kernel.kmod_is_loaded.i915: true [209.627608] [027/132] (821s left) kms_cursor_crc (cursor-sliding-256x85) [211.389414] Starting subtest: cursor-sliding-256x85 [211.404859] Starting dynamic subtest: pipe-A-HDMI-A-4 [215.828335] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.423s) [215.863111] Starting dynamic subtest: pipe-D-HDMI-A-4 [220.158476] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.306s) [220.159345] Subtest cursor-sliding-256x85: SUCCESS (8.769s) [220.546736] [028/132] (810s left) kms_cursor_crc (cursor-offscreen-32x32) [222.116557] Starting subtest: cursor-offscreen-32x32 [222.170015] Subtest cursor-offscreen-32x32: SKIP (0.052s) [222.641745] [029/132] (808s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [224.132752] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [224.196628] [030/132] (806s left) kms_vblank (wait-idle) [225.680307] Starting subtest: wait-idle [225.681301] Starting dynamic subtest: pipe-A-HDMI-A-4 [228.030112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.348s) [228.044165] Starting dynamic subtest: pipe-D-HDMI-A-4 [230.224259] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.190s) [230.225118] Subtest wait-idle: SUCCESS (4.544s) [230.423065] [031/132] (800s left) kms_pm_rpm (pm-caching) [233.939231] Starting subtest: pm-caching [233.943619] Subtest pm-caching: SKIP (0.000s) [234.928157] [032/132] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [236.435942] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [236.437846] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [236.695388] [033/132] (794s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [238.179537] Starting subtest: plane-all-modeset-transition-fencing [238.180394] Starting dynamic subtest: pipe-A-HDMI-A-4 [249.767117] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.582s) [249.822395] Starting dynamic subtest: pipe-B-HDMI-A-4 [257.804792] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (7.992s) [257.821280] Subtest plane-all-modeset-transition-fencing: SUCCESS (19.641s) [258.107331] [034/132] (773s left) syncobj_timeline (etime-multi-wait-all-submitted) [258.154130] Starting subtest: etime-multi-wait-all-submitted [258.263615] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s) [258.406447] [035/132] (773s left) gem_ringfill (engines-basic) [258.859325] Starting subtest: engines-basic [258.861256] Starting dynamic subtest: rcs0 [258.940290] Dynamic subtest rcs0: SUCCESS (0.083s) [258.955565] Starting dynamic subtest: bcs0 [258.981239] Dynamic subtest bcs0: SUCCESS (0.040s) [259.008517] Starting dynamic subtest: vcs0 [259.028202] Dynamic subtest vcs0: SUCCESS (0.046s) [259.050147] Starting dynamic subtest: vcs1 [259.073107] Dynamic subtest vcs1: SUCCESS (0.044s) [259.091845] Starting dynamic subtest: vecs0 [259.116096] Dynamic subtest vecs0: SUCCESS (0.042s) [259.117243] Subtest engines-basic: SUCCESS (0.260s) [259.343317] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true [259.346010] [036/132] (772s left) gem_mmap (basic-small-bo) [259.390581] Subtest basic-small-bo: SKIP (0.000s) [259.463416] [037/132] (772s left) kms_vblank (query-forked-busy) [260.947250] Starting subtest: query-forked-busy [260.949476] Starting dynamic subtest: pipe-A-HDMI-A-4 [263.483028] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.533s) [263.549037] Starting dynamic subtest: pipe-D-HDMI-A-4 [265.988967] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.481s) [265.991306] Subtest query-forked-busy: SUCCESS (5.042s) [266.225872] [038/132] (765s left) kms_lease (lease-invalid-connector) [267.711856] Starting subtest: lease-invalid-connector [267.712797] Starting dynamic subtest: pipe-A-HDMI-A-4 [267.713640] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s) [267.725104] Starting dynamic subtest: pipe-B-HDMI-A-4 [267.726067] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s) [267.737125] Starting dynamic subtest: pipe-C-HDMI-A-4 [267.738135] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s) [267.748987] Starting dynamic subtest: pipe-D-HDMI-A-4 [267.749907] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s) [267.750861] Subtest lease-invalid-connector: SUCCESS (0.006s) [267.904794] [039/132] (763s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [269.392312] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [269.394719] Starting dynamic subtest: pipe-A-HDMI-A-4 [269.403980] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [269.415658] Starting dynamic subtest: pipe-B-HDMI-A-4 [269.424987] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [269.436356] Starting dynamic subtest: pipe-C-HDMI-A-4 [269.446097] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [269.457281] Starting dynamic subtest: pipe-D-HDMI-A-4 [269.467120] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [269.469242] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s) [269.672811] [040/132] (762s left) kms_lease (multimaster-lease) [271.155328] Starting subtest: multimaster-lease [271.159267] Subtest multimaster-lease: SUCCESS (0.004s) [271.332660] [041/132] (760s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [272.822690] Starting subtest: plane-upscale-20x20-with-modifiers [272.823516] Starting dynamic subtest: pipe-A [273.596599] Dynamic subtest pipe-A: SUCCESS (0.775s) [273.611776] Starting dynamic subtest: pipe-B [274.354876] Dynamic subtest pipe-B: SUCCESS (0.757s) [274.369446] Starting dynamic subtest: pipe-C [275.112199] Dynamic subtest pipe-C: SUCCESS (0.756s) [275.130523] Starting dynamic subtest: pipe-D [275.885533] Dynamic subtest pipe-D: SUCCESS (0.773s) [275.886516] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (3.064s) [276.157030] [042/132] (755s left) kms_plane (plane-panning-bottom-right-suspend) [277.643266] Starting subtest: plane-panning-bottom-right-suspend [277.645811] Starting dynamic subtest: pipe-A [299.220350] Dynamic subtest pipe-A: SUCCESS (10.665s) [299.235073] Starting dynamic subtest: pipe-B [321.207988] Dynamic subtest pipe-B: SUCCESS (10.087s) [321.208901] Subtest plane-panning-bottom-right-suspend: SUCCESS (20.757s) [327.420545] [043/132] (710s left) gem_exec_suspend (basic-s0) [327.477190] Starting subtest: basic-S0 [327.478047] Starting dynamic subtest: smem [347.209130] Dynamic subtest smem: SUCCESS (5.380s) [347.222354] Starting dynamic subtest: lmem0 [367.196403] Dynamic subtest lmem0: SUCCESS (5.193s) [367.197440] Subtest basic-S0: SUCCESS (10.575s) [371.540181] [044/132] (670s left) gem_userptr_blits (huge-split) [371.610819] Starting subtest: huge-split [371.629825] Subtest huge-split: SUCCESS (0.020s) [371.829194] [045/132] (670s left) gen9_exec_parse (cmd-crossing-page) [371.879016] Subtest cmd-crossing-page: SKIP (0.000s) [371.969704] [046/132] (670s left) kms_properties (crtc-properties-atomic) [373.458681] Starting subtest: crtc-properties-atomic [373.459626] Starting dynamic subtest: pipe-A-HDMI-A-4 [373.769552] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.308s) [373.801176] Starting dynamic subtest: pipe-B-HDMI-A-4 [374.066695] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.292s) [374.081905] Starting dynamic subtest: pipe-C-HDMI-A-4 [374.318682] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.250s) [374.333765] Starting dynamic subtest: pipe-D-HDMI-A-4 [374.605130] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.281s) [374.606016] Subtest crtc-properties-atomic: SUCCESS (1.144s) [374.863966] [047/132] (667s left) gem_ctx_isolation (preservation-reset) [375.048077] Starting subtest: preservation-reset [375.050298] Starting dynamic subtest: rcs0 [375.722280] Dynamic subtest rcs0: SUCCESS (0.675s) [375.736552] Starting dynamic subtest: bcs0 [376.393893] Dynamic subtest bcs0: SUCCESS (0.670s) [376.408112] Starting dynamic subtest: vcs0 [377.083750] Dynamic subtest vcs0: SUCCESS (0.688s) [377.098096] Starting dynamic subtest: vcs1 [377.808521] Dynamic subtest vcs1: SUCCESS (0.723s) [377.822923] Starting dynamic subtest: vecs0 [378.465516] Dynamic subtest vecs0: SUCCESS (0.655s) [378.466560] Subtest preservation-reset: SUCCESS (3.420s) [378.688356] [048/132] (663s left) kms_atomic_interruptible (universal-setplane-primary) [380.176955] Starting subtest: universal-setplane-primary [380.179497] Starting dynamic subtest: pipe-A-HDMI-A-4 [386.421058] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.240s) [386.421895] Subtest universal-setplane-primary: SUCCESS (6.242s) [386.659163] [049/132] (656s left) kms_big_fb (y-tiled-64bpp-rotate-0) [388.170784] Starting subtest: y-tiled-64bpp-rotate-0 [390.462953] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.288s) [390.734660] [050/132] (652s left) kms_plane_cursor (viewport) [392.220264] Starting subtest: viewport [392.222255] Starting dynamic subtest: pipe-A-HDMI-A-4-size-64 [395.360388] Dynamic subtest pipe-A-HDMI-A-4-size-64: SUCCESS (3.139s) [395.447235] Starting dynamic subtest: pipe-A-HDMI-A-4-size-128 [398.543455] Dynamic subtest pipe-A-HDMI-A-4-size-128: SUCCESS (3.116s) [398.627344] Starting dynamic subtest: pipe-A-HDMI-A-4-size-256 [401.810941] Dynamic subtest pipe-A-HDMI-A-4-size-256: SUCCESS (3.199s) [401.936855] Starting dynamic subtest: pipe-B-HDMI-A-4-size-64 [405.078739] Dynamic subtest pipe-B-HDMI-A-4-size-64: SUCCESS (3.157s) [405.144696] Starting dynamic subtest: pipe-B-HDMI-A-4-size-128 [408.229630] Dynamic subtest pipe-B-HDMI-A-4-size-128: SUCCESS (3.099s) [408.292827] Starting dynamic subtest: pipe-B-HDMI-A-4-size-256 [411.428814] Dynamic subtest pipe-B-HDMI-A-4-size-256: SUCCESS (3.149s) [411.517845] Starting dynamic subtest: pipe-C-HDMI-A-4-size-64 [414.784114] Dynamic subtest pipe-C-HDMI-A-4-size-64: SUCCESS (3.280s) [414.853571] Starting dynamic subtest: pipe-C-HDMI-A-4-size-128 [418.068706] Dynamic subtest pipe-C-HDMI-A-4-size-128: SUCCESS (3.233s) [418.132003] Starting dynamic subtest: pipe-C-HDMI-A-4-size-256 [421.284379] Dynamic subtest pipe-C-HDMI-A-4-size-256: SUCCESS (3.166s) [421.391201] Starting dynamic subtest: pipe-D-HDMI-A-4-size-64 [424.608715] Dynamic subtest pipe-D-HDMI-A-4-size-64: SUCCESS (3.231s) [424.672017] Starting dynamic subtest: pipe-D-HDMI-A-4-size-128 [427.807834] Dynamic subtest pipe-D-HDMI-A-4-size-128: SUCCESS (3.149s) [427.875936] Starting dynamic subtest: pipe-D-HDMI-A-4-size-256 [431.008551] Dynamic subtest pipe-D-HDMI-A-4-size-256: SUCCESS (3.149s) [431.081974] Subtest viewport: SUCCESS (38.862s) [431.314466] [051/132] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [432.806626] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [435.832667] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.025s) [436.073714] [052/132] (606s left) gem_ctx_shared (q-out-order) [436.133222] Starting subtest: Q-out-order [436.134250] Starting dynamic subtest: rcs0 [436.329857] Dynamic subtest rcs0: SUCCESS (0.190s) [436.344827] Starting dynamic subtest: bcs0 [436.460283] Dynamic subtest bcs0: SUCCESS (0.131s) [436.475347] Starting dynamic subtest: vcs0 [436.588043] Dynamic subtest vcs0: SUCCESS (0.126s) [436.603488] Starting dynamic subtest: vcs1 [436.724655] Dynamic subtest vcs1: SUCCESS (0.135s) [436.739999] Starting dynamic subtest: vecs0 [436.862367] Dynamic subtest vecs0: SUCCESS (0.136s) [436.863257] Subtest Q-out-order: SUCCESS (0.727s) [437.243219] [053/132] (605s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [438.734949] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [438.813031] [054/132] (604s left) kms_colorop (plane-xr30-xr30-pq_inv_eotf) [441.743782] Subtest plane-XR30-XR30-pq_inv_eotf: SKIP (0.000s) [441.938914] [055/132] (601s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [443.424335] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [443.426100] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [443.670853] [056/132] (599s left) kms_properties (plane-properties-atomic) [445.157005] Starting subtest: plane-properties-atomic [445.159593] Starting dynamic subtest: pipe-A-HDMI-A-4 [445.636723] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.478s) [445.653127] Starting dynamic subtest: pipe-B-HDMI-A-4 [446.097702] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.458s) [446.114064] Starting dynamic subtest: pipe-C-HDMI-A-4 [446.567720] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.467s) [446.584235] Starting dynamic subtest: pipe-D-HDMI-A-4 [447.036875] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.467s) [447.037740] Subtest plane-properties-atomic: SUCCESS (1.881s) [447.277646] [057/132] (596s left) gem_exec_fence (syncobj-export) [447.726220] Starting subtest: syncobj-export [447.747460] Subtest syncobj-export: SUCCESS (0.021s) [448.255518] [058/132] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [449.746457] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [449.748371] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [450.004522] [059/132] (593s left) gem_mmap_offset (blt-coherency) [450.049572] Starting subtest: blt-coherency [450.077660] Subtest blt-coherency: SUCCESS (0.028s) [450.309297] [060/132] (593s left) syncobj_wait (multi-wait-all-submitted-signaled) [450.353915] Starting subtest: multi-wait-all-submitted-signaled [450.464065] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s) [450.663420] [061/132] (593s left) syncobj_wait (invalid-reset-zero-handles) [450.708079] Starting subtest: invalid-reset-zero-handles [450.708921] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [450.900798] [062/132] (593s left) gem_exec_reloc (basic-gtt) [450.951260] Subtest basic-gtt: SKIP (0.000s) [451.049163] [063/132] (593s left) kms_psr (fbc-psr2-cursor-blt) [452.534201] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [452.614357] [064/132] (591s left) kms_draw_crc (draw-method-mmap-wc) [454.103691] Starting subtest: draw-method-mmap-wc [454.105438] Subtest draw-method-mmap-wc: SKIP (0.000s) [454.323373] [065/132] (589s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [455.810580] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [455.811634] Starting dynamic subtest: pipe-A-valid-mode [458.416682] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.605s) [458.417521] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (2.608s) [458.629628] [066/132] (585s left) gem_exec_fence (basic-wait) [458.801878] Starting subtest: basic-wait [458.802806] Starting dynamic subtest: rcs0 [458.920161] Dynamic subtest rcs0: SUCCESS (0.116s) [458.981849] Starting dynamic subtest: bcs0 [458.988476] Dynamic subtest bcs0: SUCCESS (0.062s) [459.010032] Starting dynamic subtest: vcs0 [459.040581] Dynamic subtest vcs0: SUCCESS (0.050s) [459.069627] Starting dynamic subtest: vcs1 [459.096502] Dynamic subtest vcs1: SUCCESS (0.053s) [459.120926] Starting dynamic subtest: vecs0 [459.153640] Dynamic subtest vecs0: SUCCESS (0.055s) [459.157173] Subtest basic-wait: SUCCESS (0.353s) [459.857524] [067/132] (584s left) gem_softpin (noreloc) [459.911417] Starting subtest: noreloc [465.484251] Subtest noreloc: SUCCESS (5.570s) [465.664671] [068/132] (578s left) dmabuf_sync_file (import-basic) [465.718371] Starting subtest: import-basic [465.720885] Subtest import-basic: SUCCESS (0.003s) [465.919841] [069/132] (578s left) kms_chamelium_audio (hdmi-audio-edid) [467.458887] Subtest hdmi-audio-edid: SKIP (0.000s) [467.579773] [070/132] (577s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [467.624380] Starting subtest: wait-all-for-submit-delayed-submit [467.729935] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [467.960877] [071/132] (576s left) kms_colorop (plane-xr24-xr24-pq_eotf) [470.890301] Subtest plane-XR24-XR24-pq_eotf: SKIP (0.000s) [471.088366] [072/132] (573s left) gem_exec_schedule (preemptive-hang) [471.286371] Starting subtest: preemptive-hang [471.288580] Starting dynamic subtest: rcs0 [480.999115] Dynamic subtest rcs0: SUCCESS (9.718s) [481.015985] Starting dynamic subtest: bcs0 [490.022015] Dynamic subtest bcs0: SUCCESS (9.021s) [490.037283] Starting dynamic subtest: vcs0 [499.052955] Dynamic subtest vcs0: SUCCESS (9.029s) [499.069854] Starting dynamic subtest: vcs1 [508.013038] Dynamic subtest vcs1: SUCCESS (8.958s) [508.028011] Starting dynamic subtest: vecs0 [517.029068] Dynamic subtest vecs0: SUCCESS (9.015s) [517.029994] Subtest preemptive-hang: SUCCESS (45.752s) [517.357101] [073/132] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [518.848827] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [518.850725] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [519.101772] [074/132] (526s left) syncobj_timeline (invalid-transfer-non-existent-point) [519.148833] Starting subtest: invalid-transfer-non-existent-point [519.149671] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [519.343191] [075/132] (525s left) kms_addfb_basic (clobberred-modifier) [519.386977] Starting subtest: clobberred-modifier [519.388717] Subtest clobberred-modifier: SKIP (0.000s) [521.053803] [076/132] (524s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [522.545827] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [522.547750] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [522.791885] [077/132] (522s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [524.283695] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [526.787644] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.503s) [527.059388] [078/132] (518s left) gem_eio (in-flight-internal-10ms) [527.218684] Starting subtest: in-flight-internal-10ms [528.788157] Subtest in-flight-internal-10ms: SUCCESS (1.569s) [530.452372] [079/132] (515s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [531.955670] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [533.050823] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.091s) [533.272839] [080/132] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [534.764516] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [534.766412] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [535.015313] [081/132] (511s left) kms_getfb (getfb-handle-valid) [536.501211] Starting subtest: getfb-handle-valid [536.502113] Subtest getfb-handle-valid: SUCCESS (0.000s) [536.775456] [082/132] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [538.267427] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [538.269354] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [538.512766] [083/132] (507s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [540.016112] Starting subtest: cursorB-vs-flipB-atomic-transitions [540.017932] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s) [540.227509] [084/132] (506s left) kms_psr (psr2-cursor-render) [541.711867] Subtest psr2-cursor-render: SKIP (0.000s) [541.794297] [085/132] (504s left) gem_flink_basic (double-flink) [541.839281] Starting subtest: double-flink [541.840096] Subtest double-flink: SUCCESS (0.000s) [542.058798] [086/132] (504s left) gem_basic (multigpu-create-close) [542.102989] Starting subtest: multigpu-create-close [542.104699] Subtest multigpu-create-close: SKIP (0.000s) [542.256175] [087/132] (504s left) gem_ctx_persistence (file) [542.308324] Starting subtest: file [542.425099] Subtest file: SUCCESS (0.117s) [542.690831] [088/132] (504s left) kms_cursor_legacy (torture-bo) [544.176366] Starting subtest: torture-bo [544.177334] Starting dynamic subtest: pipe-A [549.675086] Dynamic subtest pipe-A: SUCCESS (5.495s) [549.690735] Starting dynamic subtest: pipe-B [555.140229] Dynamic subtest pipe-B: SUCCESS (5.463s) [555.155480] Starting dynamic subtest: pipe-C [560.587101] Dynamic subtest pipe-C: SUCCESS (5.446s) [560.603556] Starting dynamic subtest: pipe-D [566.044779] Dynamic subtest pipe-D: SUCCESS (5.456s) [566.060736] Starting dynamic subtest: all-pipes [571.504639] Dynamic subtest all-pipes: SUCCESS (5.458s) [571.506289] Subtest torture-bo: SUCCESS (27.326s) [571.725092] [089/132] (475s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [573.233496] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [573.235231] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [573.445078] [090/132] (473s left) gem_exec_schedule (semaphore-codependency) [573.506305] Starting subtest: semaphore-codependency [573.538385] Subtest semaphore-codependency: SUCCESS (0.032s) [573.988779] [091/132] (473s left) kms_setmode (invalid-clone-exclusive-crtc) [574.033785] Starting subtest: invalid-clone-exclusive-crtc [574.036509] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [574.247575] [092/132] (473s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [575.737751] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [575.739659] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [575.939570] [093/132] (471s left) kms_color (ctm-0-25) [577.443330] Starting subtest: ctm-0-25 [577.444372] Starting dynamic subtest: pipe-A-HDMI-A-4 [578.999620] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.557s) [579.014997] Starting dynamic subtest: pipe-B-HDMI-A-4 [580.402144] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.401s) [580.417411] Starting dynamic subtest: pipe-C-HDMI-A-4 [581.823451] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.420s) [581.838641] Starting dynamic subtest: pipe-D-HDMI-A-4 [583.245881] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.420s) [583.246839] Subtest ctm-0-25: SUCCESS (5.804s) [583.491721] [094/132] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [584.983187] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [584.984759] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [585.249385] [095/132] (462s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [586.735082] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [586.737629] Starting dynamic subtest: pipe-A-HDMI-A-4 [586.760661] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [586.775946] Starting dynamic subtest: pipe-B-HDMI-A-4 [586.799612] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [586.814845] Starting dynamic subtest: pipe-C-HDMI-A-4 [586.839291] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [586.854429] Starting dynamic subtest: pipe-D-HDMI-A-4 [586.878572] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [586.880118] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.021s) [587.029132] [096/132] (460s left) kms_atomic (plane-overlay-legacy) [588.515172] Starting subtest: plane-overlay-legacy [588.516091] Starting dynamic subtest: pipe-A-HDMI-A-4 [588.974619] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.459s) [588.975510] Subtest plane-overlay-legacy: SUCCESS (0.461s) [589.238016] [097/132] (458s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [590.723398] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [590.724430] Starting dynamic subtest: pipe-A-valid-mode [591.551402] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.826s) [591.552393] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.829s) [591.771959] [098/132] (456s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [593.260107] Starting subtest: async-flip-with-page-flip-events-tiled [593.501675] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs [595.794569] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs: SUCCESS (2.289s) [595.817330] Starting dynamic subtest: pipe-A-HDMI-A-4-y [597.992812] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.193s) [598.035855] Starting dynamic subtest: pipe-A-HDMI-A-4-y [600.009748] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.012s) [600.032084] Starting dynamic subtest: pipe-A-HDMI-A-4-x [602.225200] Dynamic subtest pipe-A-HDMI-A-4-x: SUCCESS (2.209s) [602.421851] Starting dynamic subtest: pipe-B-HDMI-A-4-y-rc-ccs [604.645840] Dynamic subtest pipe-B-HDMI-A-4-y-rc-ccs: SUCCESS (2.234s) [604.671595] Starting dynamic subtest: pipe-B-HDMI-A-4-y [606.844668] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.192s) [606.895181] Starting dynamic subtest: pipe-B-HDMI-A-4-y [608.861842] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.011s) [608.886084] Starting dynamic subtest: pipe-B-HDMI-A-4-x [611.076896] Dynamic subtest pipe-B-HDMI-A-4-x: SUCCESS (2.208s) [611.285403] Starting dynamic subtest: pipe-C-HDMI-A-4-y-rc-ccs [613.529888] Dynamic subtest pipe-C-HDMI-A-4-y-rc-ccs: SUCCESS (2.254s) [613.552507] Starting dynamic subtest: pipe-C-HDMI-A-4-y [615.712139] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.176s) [615.737297] Starting dynamic subtest: pipe-C-HDMI-A-4-y [617.728781] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.009s) [617.752643] Starting dynamic subtest: pipe-C-HDMI-A-4-x [619.926961] Dynamic subtest pipe-C-HDMI-A-4-x: SUCCESS (2.192s) [620.110483] Starting dynamic subtest: pipe-D-HDMI-A-4-y-rc-ccs [622.346481] Dynamic subtest pipe-D-HDMI-A-4-y-rc-ccs: SUCCESS (2.246s) [622.371595] Starting dynamic subtest: pipe-D-HDMI-A-4-y [624.546732] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.192s) [624.568187] Starting dynamic subtest: pipe-D-HDMI-A-4-y [626.562811] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.009s) [626.583498] Starting dynamic subtest: pipe-D-HDMI-A-4-x [628.759773] Dynamic subtest pipe-D-HDMI-A-4-x: SUCCESS (2.191s) [628.760720] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.499s) [629.168858] [099/132] (418s left) kms_cursor_crc (cursor-random-512x512) [630.924458] Starting subtest: cursor-random-512x512 [630.927786] Subtest cursor-random-512x512: SKIP (0.001s) [631.232737] [100/132] (416s left) syncobj_basic (bad-create-flags) [631.277448] Starting subtest: bad-create-flags [631.280752] Subtest bad-create-flags: SUCCESS (0.000s) [631.434911] [101/132] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [632.925551] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [632.927288] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [633.197856] [102/132] (415s left) gem_exec_params (sol-reset-invalid) [633.248366] Starting subtest: sol-reset-invalid [633.251583] Subtest sol-reset-invalid: SUCCESS (0.003s) [633.496590] [103/132] (415s left) kms_sequence (get-forked-busy) [634.982664] Starting subtest: get-forked-busy [634.983589] Starting dynamic subtest: pipe-A-HDMI-A-4 [637.680914] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.697s) [637.704363] Starting dynamic subtest: pipe-B-HDMI-A-4 [640.181796] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.496s) [640.212515] Starting dynamic subtest: pipe-C-HDMI-A-4 [642.713705] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.526s) [642.747458] Starting dynamic subtest: pipe-D-HDMI-A-4 [645.246957] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.521s) [645.248270] Subtest get-forked-busy: SUCCESS (10.263s) [645.491677] [104/132] (403s left) gem_exec_params (readonly) [645.541506] Starting subtest: readonly [645.543918] Subtest readonly: SUCCESS (0.002s) [645.723828] [105/132] (403s left) kms_setmode (invalid-clone-single-crtc) [645.769578] Starting subtest: invalid-clone-single-crtc [645.772423] Subtest invalid-clone-single-crtc: SKIP (0.000s) [645.976525] [106/132] (402s left) gem_exec_reloc (basic-write-read) [646.027865] Subtest basic-write-read: SKIP (0.000s) [646.164204] [107/132] (402s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [647.668359] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [647.670209] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [647.911793] [108/132] (401s left) syncobj_wait (signal) [647.958086] Starting subtest: signal [647.958992] Subtest signal: SUCCESS (0.000s) [648.147930] [109/132] (401s left) kms_chamelium_edid (vga-edid-read) [649.672551] Subtest vga-edid-read: SKIP (0.000s) [649.790076] [110/132] (399s left) syncobj_wait (multi-wait-signaled) [649.836498] Starting subtest: multi-wait-signaled [649.837481] Subtest multi-wait-signaled: SUCCESS (0.001s) [650.008832] [111/132] (399s left) kms_prop_blob (blob-prop-core) [650.054689] Starting subtest: blob-prop-core [650.055563] Subtest blob-prop-core: SUCCESS (0.000s) [650.259427] [112/132] (399s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [651.763821] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [651.765414] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [651.966147] [113/132] (397s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [653.458294] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [656.089362] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.631s) [656.347381] [114/132] (393s left) perf_pmu (semaphore-busy) [656.397188] Starting subtest: semaphore-busy [656.398108] Starting dynamic subtest: rcs0 [658.070049] Dynamic subtest rcs0: SUCCESS (1.669s) [658.086424] Starting dynamic subtest: bcs0 [659.704687] Dynamic subtest bcs0: SUCCESS (1.629s) [659.720240] Starting dynamic subtest: vcs0 [661.335683] Dynamic subtest vcs0: SUCCESS (1.626s) [661.351243] Starting dynamic subtest: vcs1 [662.967465] Dynamic subtest vcs1: SUCCESS (1.627s) [662.983072] Starting dynamic subtest: vecs0 [664.598664] Dynamic subtest vecs0: SUCCESS (1.626s) [664.599628] Subtest semaphore-busy: SUCCESS (8.201s) [664.792280] [115/132] (384s left) perf_pmu (busy-idle) [664.840724] Starting subtest: busy-idle [664.841642] Starting dynamic subtest: rcs0 [665.548095] Dynamic subtest rcs0: SUCCESS (0.706s) [665.574756] Starting dynamic subtest: bcs0 [666.214111] Dynamic subtest bcs0: SUCCESS (0.658s) [666.240558] Starting dynamic subtest: vcs0 [666.886059] Dynamic subtest vcs0: SUCCESS (0.664s) [666.912684] Starting dynamic subtest: vcs1 [667.557027] Dynamic subtest vcs1: SUCCESS (0.663s) [667.583685] Starting dynamic subtest: vecs0 [668.228120] Dynamic subtest vecs0: SUCCESS (0.663s) [668.237114] Subtest busy-idle: SUCCESS (3.390s) [668.420722] [116/132] (381s left) kms_big_fb (linear-8bpp-rotate-270) [669.925581] Starting subtest: linear-8bpp-rotate-270 [670.026795] Subtest linear-8bpp-rotate-270: SKIP (0.099s) [670.230862] [117/132] (379s left) i915_drm_fdinfo (most-busy-idle-check-all) [670.302638] Starting subtest: most-busy-idle-check-all [670.303711] Starting dynamic subtest: rcs0 [670.319704] Dynamic subtest rcs0: SKIP (0.023s) [670.335448] Starting dynamic subtest: bcs0 [670.337625] Dynamic subtest bcs0: SKIP (0.001s) [670.352596] Starting dynamic subtest: vcs0 [670.354709] Dynamic subtest vcs0: SKIP (0.001s) [670.369769] Starting dynamic subtest: vcs1 [670.371919] Dynamic subtest vcs1: SKIP (0.001s) [670.386829] Starting dynamic subtest: vecs0 [670.389702] Dynamic subtest vecs0: SKIP (0.000s) [670.391631] Subtest most-busy-idle-check-all: SKIP (0.032s) [670.458230] [118/132] (379s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [670.584904] Starting subtest: yf-tiled-ccs-to-yf-tiled [670.586368] Starting dynamic subtest: smem [670.679669] Dynamic subtest smem: SUCCESS (0.094s) [670.696096] Starting dynamic subtest: lmem0 [671.619001] Dynamic subtest lmem0: SUCCESS (0.935s) [671.620121] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (1.032s) [671.911753] [119/132] (378s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [673.398275] Starting subtest: primary-yf-tiled-reflect-x-180 [673.488605] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.091s) [673.725238] [120/132] (376s left) gem_lmem_swapping (heavy-verify-multi) [678.110012] Starting subtest: heavy-verify-multi [678.111651] Starting dynamic subtest: lmem0 [694.373566] Dynamic subtest lmem0: SUCCESS (16.261s) [694.374618] Subtest heavy-verify-multi: SUCCESS (16.263s) [695.757225] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [695.758356] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true [695.761332] [121/132] (354s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [700.523025] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [700.524987] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [700.773091] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [700.776582] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true [700.783037] [122/132] (349s left) kms_big_fb (x-tiled-64bpp-rotate-180) [702.290179] Starting subtest: x-tiled-64bpp-rotate-180 [704.979751] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.688s) [705.260207] [123/132] (345s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [705.304269] Starting subtest: invalid-multi-wait-unsubmitted-signaled [705.305054] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s) [705.433433] [124/132] (345s left) gem_softpin (allocator-basic-reserve) [705.489377] Starting subtest: allocator-basic-reserve [705.763524] Subtest allocator-basic-reserve: SUCCESS (0.271s) [705.948367] [125/132] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [707.438705] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [707.440621] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [707.666661] [126/132] (343s left) gem_eio (wait-wedge-immediate) [707.834894] Starting subtest: wait-wedge-immediate [708.818718] Subtest wait-wedge-immediate: SUCCESS (0.984s) [710.479372] [127/132] (340s left) kms_flip (2x-flip-vs-rmfb-interruptible) [711.969441] Starting subtest: 2x-flip-vs-rmfb-interruptible [711.988241] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.018s) [712.207389] [128/132] (338s left) kms_flip (flip-vs-suspend) [713.691860] Starting subtest: flip-vs-suspend [713.700287] Starting dynamic subtest: A-HDMI-A4 [755.433245] Dynamic subtest A-HDMI-A4: SUCCESS (19.767s) [755.451330] Starting dynamic subtest: B-HDMI-A4 [798.377103] Dynamic subtest B-HDMI-A4: SUCCESS (19.896s) [798.420320] Starting dynamic subtest: C-HDMI-A4 [841.408030] Dynamic subtest C-HDMI-A4: SUCCESS (19.498s) [841.436328] Starting dynamic subtest: D-HDMI-A4 [884.354950] Dynamic subtest D-HDMI-A4: SUCCESS (19.425s) [884.356262] Subtest flip-vs-suspend: SUCCESS (78.615s) [890.624896] [129/132] (166s left) i915_hangman (engine-error-state-capture) [890.689711] Starting subtest: engine-error-state-capture [890.690607] Starting dynamic subtest: rcs0 [892.508346] Dynamic subtest rcs0: SUCCESS (1.819s) [892.524521] Starting dynamic subtest: bcs0 [896.475815] Dynamic subtest bcs0: SUCCESS (3.966s) [896.492401] Starting dynamic subtest: vcs0 [900.508785] Dynamic subtest vcs0: SUCCESS (4.032s) [900.527925] Starting dynamic subtest: vcs1 [904.472734] Dynamic subtest vcs1: SUCCESS (3.962s) [904.490974] Starting dynamic subtest: vecs0 [908.505659] Dynamic subtest vecs0: SUCCESS (4.031s) [908.508540] Subtest engine-error-state-capture: SUCCESS (17.817s) [908.714603] [130/132] (148s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [910.204122] Starting subtest: fbc-2p-pri-indfb-multidraw [910.205919] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [910.477411] [131/132] (146s left) gem_pread (exhaustion) [910.523450] Subtest exhaustion: SKIP (0.000s) [910.607230] [132/132] (146s left) gem_eio (in-flight-suspend) [910.762205] Starting subtest: in-flight-suspend [953.019534] Subtest in-flight-suspend: SUCCESS (17.352s) [957.631157] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: api_intel_allocator results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_getfb results: parsing output: 5/ for test: perf results: parsing output: 6/ for test: kms_pm_dc results: parsing output: 7/ for test: gem_ccs results: parsing output: 8/ for test: kms_setmode results: parsing output: 9/ for test: gem_exec_balancer results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: api_intel_bb results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: sriov_basic results: parsing output: 14/ for test: i915_pm_rps results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_color results: parsing output: 19/ for test: i915_selftest results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_busy results: parsing output: 24/ for test: gem_lmem_swapping results: parsing output: 25/ for test: kms_setmode results: parsing output: 26/ for test: kms_cursor_crc results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: kms_psr2_sf results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: kms_pm_rpm results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_atomic_transition results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: gem_ringfill results: parsing output: 35/ for test: gem_mmap results: parsing output: 36/ for test: kms_vblank results: parsing output: 37/ for test: kms_lease results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: kms_plane_scaling results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: gem_exec_suspend results: parsing output: 43/ for test: gem_userptr_blits results: parsing output: 44/ for test: gen9_exec_parse results: parsing output: 45/ for test: kms_properties results: parsing output: 46/ for test: gem_ctx_isolation results: parsing output: 47/ for test: kms_atomic_interruptible results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_plane_cursor results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_ctx_shared results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: kms_colorop results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_properties results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_mmap_offset results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_draw_crc results: parsing output: 64/ for test: kms_flip_scaled_crc results: parsing output: 65/ for test: gem_exec_fence results: parsing output: 66/ for test: gem_softpin results: parsing output: 67/ for test: dmabuf_sync_file results: parsing output: 68/ for test: kms_chamelium_audio results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: kms_colorop results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_eio results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_getfb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: gem_flink_basic results: parsing output: 85/ for test: gem_basic results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_setmode results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_color results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: kms_atomic results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: kms_async_flips results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: syncobj_basic results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_params results: parsing output: 102/ for test: kms_sequence results: parsing output: 103/ for test: gem_exec_params results: parsing output: 104/ for test: kms_setmode results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: syncobj_wait results: parsing output: 108/ for test: kms_chamelium_edid results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_prop_blob results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: perf_pmu results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: i915_drm_fdinfo results: parsing output: 117/ for test: gem_render_copy results: parsing output: 118/ for test: kms_rotation_crc results: parsing output: 119/ for test: gem_lmem_swapping results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: gem_softpin results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_eio results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: i915_hangman results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_pread results: parsing output: 131/ for test: gem_eio Done.