[109.145358] Initializing watchdogs [109.145430] /dev/watchdog0 [109.153611] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [111.181507] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [111.183351] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [111.267570] [002/131] (958s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [113.295112] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [113.296008] Starting dynamic subtest: pipe-A-HDMI-A-3 [113.305544] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [113.311462] Starting dynamic subtest: pipe-B-HDMI-A-3 [113.321063] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [113.327562] Starting dynamic subtest: pipe-C-HDMI-A-3 [113.336882] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [113.342478] Starting dynamic subtest: pipe-D-HDMI-A-3 [113.352273] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [113.354044] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.004s) [113.480918] [003/131] (956s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [115.523159] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [115.541169] [004/131] (954s left) kms_cursor_crc (cursor-random-256x256) [117.726553] Starting subtest: cursor-random-256x256 [117.730377] Starting dynamic subtest: pipe-A-HDMI-A-3 [122.190646] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.459s) [122.221443] Starting dynamic subtest: pipe-D-HDMI-A-3 [126.578294] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.361s) [126.579166] Subtest cursor-random-256x256: SUCCESS (8.850s) [126.811949] [005/131] (942s left) kms_joiner (invalid-modeset-force-big-joiner) [128.843992] Starting subtest: invalid-modeset-force-big-joiner [128.845883] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [128.908535] [006/131] (940s left) gem_pxp (regular-baseline-src-copy-readible) [131.579378] Subtest regular-baseline-src-copy-readible: SKIP (0.000s) [131.642161] [007/131] (938s left) kms_vblank (query-busy) [133.652167] Starting subtest: query-busy [133.653134] Starting dynamic subtest: pipe-A-HDMI-A-3 [136.099387] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.446s) [136.107692] Starting dynamic subtest: pipe-D-HDMI-A-3 [138.446198] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.344s) [138.447041] Subtest query-busy: SUCCESS (4.794s) [138.556678] [008/131] (931s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [138.630037] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [138.630951] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [138.737133] [009/131] (931s left) gem_busy (semaphore) [139.000651] Subtest semaphore: SKIP (0.000s) [139.269644] [010/131] (930s left) kms_psr (fbc-psr2-cursor-plane-move) [141.316312] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [141.334192] [011/131] (928s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [143.335202] Starting subtest: fbc-rgb101010-draw-render [146.193099] Subtest fbc-rgb101010-draw-render: SUCCESS (2.859s) [146.317657] [012/131] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [148.326550] Starting subtest: psr-2p-scndscrn-spr-indfb-move [148.328232] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [148.411930] [013/131] (921s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [148.561355] Starting subtest: multi-wait-all-for-submit-submitted-signaled [148.663188] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s) [148.749372] [014/131] (921s left) gem_ctx_persistence (legacy-engines-hang) [148.858287] Starting subtest: legacy-engines-hang [148.859222] Starting dynamic subtest: render [148.945525] Dynamic subtest render: SUCCESS (0.087s) [148.954069] Starting dynamic subtest: bsd1 [149.048542] Dynamic subtest bsd1: SUCCESS (0.102s) [149.064848] Starting dynamic subtest: bsd2 [149.108075] Dynamic subtest bsd2: SUCCESS (0.058s) [149.129669] Starting dynamic subtest: blt [149.134972] Dynamic subtest blt: SUCCESS (0.026s) [149.153452] Starting dynamic subtest: vebox [149.260058] Dynamic subtest vebox: SUCCESS (0.124s) [149.261741] Subtest legacy-engines-hang: SUCCESS (0.401s) [149.385655] [015/131] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [151.411982] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [151.413765] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [151.496777] [016/131] (918s left) gem_softpin (evict-active-interruptible) [151.659015] Starting subtest: evict-active-interruptible [151.674676] Subtest evict-active-interruptible: SUCCESS (0.016s) [151.800034] [017/131] (918s left) gem_mmap_gtt (cpuset-big-copy-odd) [151.902865] Subtest cpuset-big-copy-odd: SKIP (0.000s) [151.936508] [018/131] (918s left) sw_sync (sync_merge_invalid) [151.993383] Starting subtest: sync_merge_invalid [152.010979] Subtest sync_merge_invalid: SUCCESS (0.018s) [152.071846] [019/131] (918s left) syncobj_timeline (wait-all-delayed-signal) [152.160400] Starting subtest: wait-all-delayed-signal [152.263659] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [152.329941] [020/131] (917s left) i915_pm_rpm (gem-execbuf-stress) [157.125263] Starting subtest: gem-execbuf-stress [157.126949] Starting dynamic subtest: lmem0 [170.665725] Dynamic subtest lmem0: SUCCESS (13.540s) [170.692198] Starting dynamic subtest: extra-wait-lmem0 [234.627396] Dynamic subtest extra-wait-lmem0: SUCCESS (63.962s) [234.634304] Starting dynamic subtest: smem0 [247.561737] Dynamic subtest smem0: SUCCESS (12.933s) [247.585191] Starting dynamic subtest: extra-wait-smem0 [309.675895] Dynamic subtest extra-wait-smem0: SUCCESS (62.111s) [309.677603] Subtest gem-execbuf-stress: SUCCESS (152.548s) [310.783646] [021/131] (759s left) sw_sync (sync_multi_producer_single_consumer) [310.839399] Starting subtest: sync_multi_producer_single_consumer [311.914742] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [311.949682] [022/131] (758s left) syncobj_wait (signal) [312.018513] Starting subtest: signal [312.019501] Subtest signal: SUCCESS (0.000s) [312.123667] [023/131] (758s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [314.158493] Starting subtest: plane-downscale-factor-0-25-with-modifiers [314.166364] Starting dynamic subtest: pipe-A [314.560983] Dynamic subtest pipe-A: SKIP (0.402s) [314.567978] Starting dynamic subtest: pipe-B [315.157756] Dynamic subtest pipe-B: SKIP (0.595s) [315.164641] Starting dynamic subtest: pipe-C [315.751510] Dynamic subtest pipe-C: SKIP (0.595s) [315.758513] Starting dynamic subtest: pipe-D [316.347462] Dynamic subtest pipe-D: SKIP (0.595s) [316.349194] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (2.187s) [316.433883] [024/131] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [318.452885] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [318.454534] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [318.542506] [025/131] (751s left) kms_busy (extended-pageflip-hang-oldfb) [320.632507] Starting subtest: extended-pageflip-hang-oldfb [320.635186] Starting dynamic subtest: pipe-A [320.827244] Dynamic subtest pipe-A: SUCCESS (0.193s) [320.839268] Starting dynamic subtest: pipe-D [320.979745] Dynamic subtest pipe-D: SUCCESS (0.149s) [320.980569] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.348s) [321.145419] [026/131] (749s left) kms_plane_lowres (tiling-y) [323.164094] Starting subtest: tiling-y [323.165951] Subtest tiling-y: SKIP (0.000s) [323.226709] [027/131] (747s left) kms_color (deep-color) [325.293684] Starting subtest: deep-color [325.302227] Subtest deep-color: SKIP (0.003s) [325.361719] [028/131] (744s left) kms_chamelium_color (ctm-red-to-blue) [327.451425] Subtest ctm-red-to-blue: SKIP (0.000s) [327.471229] [029/131] (742s left) kms_flip (2x-absolute-wf_vblank-interruptible) [329.472276] Starting subtest: 2x-absolute-wf_vblank-interruptible [329.486036] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.013s) [329.544871] [030/131] (740s left) perf_pmu (multi-client) [329.665274] Starting subtest: multi-client [329.666483] Starting dynamic subtest: rcs0 [330.755324] Dynamic subtest rcs0: SUCCESS (1.088s) [330.766173] Starting dynamic subtest: bcs0 [331.810840] Dynamic subtest bcs0: SUCCESS (1.053s) [331.823685] Starting dynamic subtest: vcs0 [332.862293] Dynamic subtest vcs0: SUCCESS (1.049s) [332.873077] Starting dynamic subtest: vcs1 [333.917267] Dynamic subtest vcs1: SUCCESS (1.052s) [333.928141] Starting dynamic subtest: vecs0 [334.972731] Dynamic subtest vecs0: SUCCESS (1.053s) [334.983317] Starting dynamic subtest: vecs1 [336.026543] Dynamic subtest vecs1: SUCCESS (1.051s) [336.037437] Starting dynamic subtest: ccs0 [337.080311] Dynamic subtest ccs0: SUCCESS (1.051s) [337.082376] Subtest multi-client: SUCCESS (7.415s) [337.195274] [031/131] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [339.204462] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [339.206270] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [339.304994] [032/131] (731s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [341.395135] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [341.396046] Starting dynamic subtest: pipe-A-HDMI-A-3 [343.598100] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.203s) [343.607552] Starting dynamic subtest: pipe-B-HDMI-A-3 [343.615267] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.004s) [343.623243] Starting dynamic subtest: pipe-C-HDMI-A-3 [343.631255] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.005s) [343.639185] Starting dynamic subtest: pipe-D-HDMI-A-3 [343.647144] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.006s) [343.647993] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SUCCESS (2.224s) [343.895320] [033/131] (726s left) kms_hdr (static-swap) [345.916936] Starting subtest: static-swap [345.919568] Subtest static-swap: SKIP (0.000s) [345.978044] [034/131] (724s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [348.057894] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [350.031047] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.974s) [350.159415] [035/131] (720s left) gem_eio (in-flight-suspend) [350.440477] Starting subtest: in-flight-suspend [391.924544] Subtest in-flight-suspend: SUCCESS (11.932s) [394.949318] [036/131] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [396.973656] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [396.975330] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [397.067117] [037/131] (703s left) gem_softpin (allocator-fork) [397.215359] Starting subtest: allocator-fork [399.494515] Subtest allocator-fork: SUCCESS (2.279s) [399.621114] [038/131] (701s left) gem_exec_balancer (parallel-bb-first) [399.987368] Starting subtest: parallel-bb-first [401.308481] Subtest parallel-bb-first: SUCCESS (1.321s) [401.425145] [039/131] (699s left) gem_exec_reloc (basic-gtt-active) [401.506941] Subtest basic-gtt-active: SKIP (0.000s) [401.591680] [040/131] (699s left) gem_exec_whisper (basic-contexts-forked) [401.704343] Starting subtest: basic-contexts-forked [424.260006] Subtest basic-contexts-forked: SUCCESS (22.460s) [424.465145] [041/131] (676s left) gem_exec_fence (syncobj-timeline-repeat) [425.121075] Starting subtest: syncobj-timeline-repeat [425.521179] Subtest syncobj-timeline-repeat: SUCCESS (0.400s) [425.760871] [042/131] (675s left) gem_lmem_swapping (heavy-verify-multi) [431.697457] Starting subtest: heavy-verify-multi [431.698338] Starting dynamic subtest: lmem0 [444.255952] Dynamic subtest lmem0: SUCCESS (12.548s) [444.256957] Subtest heavy-verify-multi: SUCCESS (12.550s) [446.282528] [043/131] (655s left) gem_eio (unwedge-stress) [450.416437] Starting subtest: unwedge-stress [456.723461] Subtest unwedge-stress: FAIL (6.237s) [458.684855] [044/131] (642s left) gem_exec_schedule (implicit-read-write) [458.834473] Starting subtest: implicit-read-write [458.835493] Starting dynamic subtest: rcs0 [459.122692] Dynamic subtest rcs0: SUCCESS (0.287s) [459.132350] Starting dynamic subtest: bcs0 [459.317834] Dynamic subtest bcs0: SUCCESS (0.194s) [459.327645] Starting dynamic subtest: vcs0 [459.532596] Dynamic subtest vcs0: SUCCESS (0.214s) [459.542535] Starting dynamic subtest: vcs1 [459.741391] Dynamic subtest vcs1: SUCCESS (0.208s) [459.751425] Starting dynamic subtest: vecs0 [459.953367] Dynamic subtest vecs0: SUCCESS (0.211s) [459.963231] Starting dynamic subtest: vecs1 [460.163953] Dynamic subtest vecs1: SUCCESS (0.209s) [460.173941] Starting dynamic subtest: ccs0 [460.368343] Dynamic subtest ccs0: SUCCESS (0.203s) [460.369473] Subtest implicit-read-write: SUCCESS (1.533s) [460.690669] [045/131] (640s left) gem_exec_fence (basic-await) [460.899434] Starting subtest: basic-await [460.900406] Starting dynamic subtest: rcs0 [461.019885] Dynamic subtest rcs0: SUCCESS (0.120s) [461.031161] Starting dynamic subtest: bcs0 [461.119820] Dynamic subtest bcs0: SUCCESS (0.099s) [461.131096] Starting dynamic subtest: vcs0 [461.217185] Dynamic subtest vcs0: SUCCESS (0.096s) [461.228213] Starting dynamic subtest: vcs1 [461.314147] Dynamic subtest vcs1: SUCCESS (0.096s) [461.325243] Starting dynamic subtest: vecs0 [461.412066] Dynamic subtest vecs0: SUCCESS (0.097s) [461.423271] Starting dynamic subtest: vecs1 [461.508988] Dynamic subtest vecs1: SUCCESS (0.096s) [461.520822] Starting dynamic subtest: ccs0 [461.609057] Dynamic subtest ccs0: SUCCESS (0.099s) [461.610021] Subtest basic-await: SUCCESS (0.710s) [462.360477] [046/131] (639s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [464.398944] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [465.619725] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.220s) [465.751543] [047/131] (635s left) kms_rotation_crc (primary-rotation-180) [467.784167] Starting subtest: primary-rotation-180 [478.004531] Subtest primary-rotation-180: SUCCESS (10.215s) [478.211749] [048/131] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [480.230158] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [480.231969] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [480.320804] [049/131] (621s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [482.431533] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [482.458171] [050/131] (619s left) gem_wait (invalid-flags) [482.539607] Starting subtest: invalid-flags [482.540519] Subtest invalid-flags: SUCCESS (0.000s) [482.798785] [051/131] (618s left) gem_eio (create) [483.091106] Starting subtest: create [483.550038] Subtest create: SUCCESS (0.459s) [485.567607] [052/131] (616s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [487.646208] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [487.647967] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [487.743748] [053/131] (613s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [489.838876] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [489.861500] [054/131] (611s left) gem_softpin (evict-prime-sanity-check) [489.942214] Starting subtest: evict-prime-sanity-check [489.943160] Starting dynamic subtest: rcs0 [491.122464] Dynamic subtest rcs0: SUCCESS (1.179s) [491.137161] Starting dynamic subtest: bcs0 [492.257378] Dynamic subtest bcs0: SUCCESS (1.133s) [492.273817] Starting dynamic subtest: vcs0 [493.406553] Dynamic subtest vcs0: SUCCESS (1.147s) [493.422099] Starting dynamic subtest: vcs1 [494.544532] Dynamic subtest vcs1: SUCCESS (1.136s) [494.559198] Starting dynamic subtest: vecs0 [495.684365] Dynamic subtest vecs0: SUCCESS (1.138s) [495.698236] Starting dynamic subtest: vecs1 [496.803289] Dynamic subtest vecs1: SUCCESS (1.117s) [496.814091] Starting dynamic subtest: ccs0 [497.928349] Dynamic subtest ccs0: SUCCESS (1.123s) [497.940170] Starting dynamic subtest: all [499.055499] Dynamic subtest all: SUCCESS (1.125s) [499.056535] Subtest evict-prime-sanity-check: SUCCESS (9.109s) [499.134751] [055/131] (602s left) perf (non-zero-reason) [499.471550] Starting subtest: non-zero-reason [499.472424] Starting dynamic subtest: 0-rcs0 [502.479228] Dynamic subtest 0-rcs0: FAIL (2.727s) [502.480447] Subtest non-zero-reason: FAIL (2.727s) [502.513933] [056/131] (599s left) kms_vrr (flip-suspend) [504.626487] Starting subtest: flip-suspend [504.630527] Subtest flip-suspend: SKIP (0.000s) [504.720295] [057/131] (597s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [506.841322] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [506.843355] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [506.931989] [058/131] (594s left) gem_exec_schedule (thriceslice) [507.128758] Starting subtest: thriceslice [507.129673] Starting dynamic subtest: rcs0 [507.160164] Dynamic subtest rcs0: SUCCESS (0.031s) [507.170767] Starting dynamic subtest: bcs0 [507.189086] Dynamic subtest bcs0: SUCCESS (0.028s) [507.200046] Starting dynamic subtest: vcs0 [507.218527] Dynamic subtest vcs0: SUCCESS (0.028s) [507.230932] Starting dynamic subtest: vcs1 [507.250886] Dynamic subtest vcs1: SUCCESS (0.031s) [507.265694] Starting dynamic subtest: vecs0 [507.281912] Dynamic subtest vecs0: SUCCESS (0.030s) [507.298235] Starting dynamic subtest: vecs1 [507.339004] Dynamic subtest vecs1: SUCCESS (0.056s) [507.370472] Starting dynamic subtest: ccs0 [507.400918] Dynamic subtest ccs0: SUCCESS (0.060s) [507.402419] Subtest thriceslice: SUCCESS (0.273s) [507.771856] [059/131] (594s left) gen7_exec_parse (cmd-crossing-page) [507.900140] Subtest cmd-crossing-page: SKIP (0.000s) [507.931951] [060/131] (594s left) kms_content_protection (srm) [510.038035] Starting subtest: srm [510.345842] Subtest srm: SKIP (0.304s) [510.552459] [061/131] (591s left) gem_ctx_exec (basic-invalid-context) [510.680525] Starting subtest: basic-invalid-context [510.685654] Subtest basic-invalid-context: SUCCESS (0.005s) [510.835174] [062/131] (591s left) kms_cursor_crc (cursor-rapid-movement-512x512) [513.110914] Starting subtest: cursor-rapid-movement-512x512 [513.112682] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [513.330336] [063/131] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [515.412176] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [515.413963] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [515.504936] [064/131] (586s left) kms_big_fb (linear-16bpp-rotate-90) [517.650159] Starting subtest: linear-16bpp-rotate-90 [517.709612] Subtest linear-16bpp-rotate-90: SKIP (0.059s) [517.858678] [065/131] (584s left) kms_cursor_crc (cursor-size-change) [519.971202] Starting subtest: cursor-size-change [519.972205] Starting dynamic subtest: pipe-A-HDMI-A-3 [520.812406] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.841s) [520.824348] Starting dynamic subtest: pipe-D-HDMI-A-3 [521.488426] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.674s) [521.489289] Subtest cursor-size-change: SUCCESS (1.519s) [521.884181] [066/131] (580s left) api_intel_allocator (reopen-fork) [522.007404] Starting subtest: reopen-fork [525.492460] Subtest reopen-fork: SUCCESS (3.487s) [525.580736] [067/131] (576s left) i915_module_load (resize-bar) [525.681966] Starting subtest: resize-bar [589.480268] Subtest resize-bar: SUCCESS (63.796s) [589.532509] [068/131] (512s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [596.115663] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [596.223068] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [596.283748] [069/131] (505s left) kms_pipe_crc_basic (hang-read-crc) [598.310126] Starting subtest: hang-read-crc [598.311059] Starting dynamic subtest: pipe-A-HDMI-A-3 [599.595910] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.284s) [599.606233] Starting dynamic subtest: pipe-B-HDMI-A-3 [600.644207] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.046s) [600.654662] Starting dynamic subtest: pipe-C-HDMI-A-3 [601.738429] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.093s) [601.750124] Starting dynamic subtest: pipe-D-HDMI-A-3 [602.880513] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.138s) [602.881619] Subtest hang-read-crc: SUCCESS (4.569s) [603.027484] [070/131] (499s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [605.054200] Starting subtest: cursorB-vs-flipA-atomic-transitions [605.057244] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [605.131052] [071/131] (497s left) kms_psr (psr2-basic) [607.208549] Subtest psr2-basic: SKIP (0.000s) [607.238697] [072/131] (495s left) perf (missing-sample-flags) [607.595070] Starting subtest: missing-sample-flags [607.595961] Subtest missing-sample-flags: SUCCESS (0.000s) [607.637141] [073/131] (494s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [609.735134] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [609.736139] Starting dynamic subtest: pipe-A-HDMI-A-3 [609.744838] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [609.754611] Starting dynamic subtest: pipe-B-HDMI-A-3 [609.763216] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [609.772731] Starting dynamic subtest: pipe-C-HDMI-A-3 [609.781138] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [609.790723] Starting dynamic subtest: pipe-D-HDMI-A-3 [609.799561] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [609.801307] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [609.955906] [074/131] (492s left) gem_exec_schedule (preempt-hang) [610.248852] Starting subtest: preempt-hang [610.249844] Starting dynamic subtest: rcs0 [610.549983] Dynamic subtest rcs0: SUCCESS (0.310s) [610.559797] Starting dynamic subtest: bcs0 [610.853319] Dynamic subtest bcs0: SUCCESS (0.303s) [610.863484] Starting dynamic subtest: vcs0 [611.158719] Dynamic subtest vcs0: SUCCESS (0.304s) [611.169110] Starting dynamic subtest: vcs1 [611.493849] Dynamic subtest vcs1: SUCCESS (0.334s) [611.503772] Starting dynamic subtest: vecs0 [611.838354] Dynamic subtest vecs0: SUCCESS (0.343s) [611.848442] Starting dynamic subtest: vecs1 [612.169160] Dynamic subtest vecs1: SUCCESS (0.330s) [612.179221] Starting dynamic subtest: ccs0 [612.520345] Dynamic subtest ccs0: SUCCESS (0.350s) [612.521257] Subtest preempt-hang: SUCCESS (2.281s) [612.815872] [075/131] (489s left) gem_ctx_persistence (heartbeat-hang) [612.952966] Starting subtest: heartbeat-hang [612.955126] Subtest heartbeat-hang: SKIP (0.000s) [613.051368] [076/131] (489s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [615.100266] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [615.101187] Starting dynamic subtest: pipe-A-HDMI-A-3 [615.109714] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [615.119662] Starting dynamic subtest: pipe-B-HDMI-A-3 [615.128106] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [615.137542] Starting dynamic subtest: pipe-C-HDMI-A-3 [615.145954] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [615.155614] Starting dynamic subtest: pipe-D-HDMI-A-3 [615.164862] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [615.166614] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s) [615.367507] [077/131] (487s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [617.441165] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [617.443006] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [617.522144] [078/131] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [619.647400] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [619.649162] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [619.764717] [079/131] (482s left) syncobj_wait (invalid-signal-one-illegal-handle) [619.946501] Starting subtest: invalid-signal-one-illegal-handle [619.947453] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [620.058878] [080/131] (482s left) gem_workarounds (reset-fd) [620.193769] Starting subtest: reset-fd [620.417723] Subtest reset-fd: SUCCESS (0.224s) [620.547304] [081/131] (482s left) gem_exec_params (rel-constants-invalid-ring) [620.667589] Starting subtest: rel-constants-invalid-ring [620.668514] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [620.781441] [082/131] (481s left) kms_tiled_display (basic-test-pattern) [623.829245] Subtest basic-test-pattern: SKIP (0.000s) [623.860720] [083/131] (478s left) syncobj_eventfd (binary-wait-signaled) [623.985956] Starting subtest: binary-wait-signaled [623.986852] Subtest binary-wait-signaled: SUCCESS (0.000s) [624.087064] [084/131] (478s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [624.217942] Starting subtest: multi-wait-all-for-submit-available-submitted [624.218919] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [624.328004] [085/131] (478s left) vgem_basic (bad-fence) [624.548275] Starting subtest: bad-fence [624.549214] Subtest bad-fence: SUCCESS (0.000s) [624.599609] [086/131] (478s left) kms_feature_discovery (display-4x) [626.663360] Starting subtest: display-4x [626.665292] Subtest display-4x: SKIP (0.000s) [626.739445] [087/131] (476s left) api_intel_allocator (execbuf-with-allocator) [626.935397] Starting subtest: execbuf-with-allocator [626.961964] Subtest execbuf-with-allocator: SUCCESS (0.027s) [627.078760] [088/131] (475s left) gem_userptr_blits (map-fixed-invalidate-busy) [627.232161] Starting subtest: map-fixed-invalidate-busy [627.233957] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [627.381657] [089/131] (475s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [629.446453] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [629.447454] Starting dynamic subtest: pipe-A [629.548946] Dynamic subtest pipe-A: SUCCESS (0.103s) [629.562473] Starting dynamic subtest: pipe-B [629.694816] Dynamic subtest pipe-B: SUCCESS (0.145s) [629.715555] Starting dynamic subtest: pipe-C [629.840597] Dynamic subtest pipe-C: SUCCESS (0.144s) [629.851776] Starting dynamic subtest: pipe-D [629.982037] Dynamic subtest pipe-D: SUCCESS (0.140s) [629.983036] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.537s) [630.144672] [090/131] (472s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [632.222177] Starting subtest: fbc-rgb101010-draw-mmap-gtt [632.223905] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [632.319948] [091/131] (470s left) syncobj_basic (bad-destroy-pad) [632.520355] Starting subtest: bad-destroy-pad [632.521317] Subtest bad-destroy-pad: SUCCESS (0.000s) [632.610513] [092/131] (470s left) drm_fdinfo (most-busy-check-all) [632.759169] Starting subtest: most-busy-check-all [632.760139] Starting dynamic subtest: rcs0 [632.779015] Dynamic subtest rcs0: SKIP (0.027s) [632.789507] Starting dynamic subtest: bcs0 [632.791335] Dynamic subtest bcs0: SKIP (0.001s) [632.801459] Starting dynamic subtest: vcs0 [632.803375] Dynamic subtest vcs0: SKIP (0.000s) [632.813463] Starting dynamic subtest: vcs1 [632.815456] Dynamic subtest vcs1: SKIP (0.001s) [632.825512] Starting dynamic subtest: vecs0 [632.827686] Dynamic subtest vecs0: SKIP (0.000s) [632.837218] Starting dynamic subtest: vecs1 [632.839249] Dynamic subtest vecs1: SKIP (0.000s) [632.849306] Starting dynamic subtest: ccs0 [632.851434] Dynamic subtest ccs0: SKIP (0.000s) [632.853445] Subtest most-busy-check-all: SKIP (0.036s) [632.867997] [093/131] (470s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [634.985585] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [636.254660] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.269s) [636.425198] [094/131] (466s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [638.491537] Starting subtest: fbcpsr-tiling-4 [638.493235] Subtest fbcpsr-tiling-4: SKIP (0.000s) [638.603734] [095/131] (464s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [638.806088] Starting subtest: invalid-multi-wait-unsubmitted-submitted [638.807108] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [638.916752] [096/131] (464s left) drm_fdinfo (memory-info-active) [639.045963] Starting subtest: memory-info-active [639.046933] Starting dynamic subtest: lmem0 [642.313542] Dynamic subtest lmem0: SUCCESS (3.267s) [642.331185] Starting dynamic subtest: smem0 [645.972237] Dynamic subtest smem0: SUCCESS (3.657s) [645.973202] Subtest memory-info-active: SUCCESS (6.929s) [646.035585] [097/131] (457s left) gen9_exec_parse (allowed-all) [646.162148] Subtest allowed-all: SKIP (0.000s) [646.200026] [098/131] (457s left) kms_atomic_interruptible (legacy-dpms) [648.265352] Starting subtest: legacy-dpms [648.267546] Starting dynamic subtest: pipe-A-HDMI-A-3 [654.454105] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.188s) [654.454978] Subtest legacy-dpms: SUCCESS (6.190s) [654.577895] [099/131] (448s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [656.682560] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [656.745963] [100/131] (446s left) gem_partial_pwrite_pread (writes-after-reads-display) [656.898404] Subtest writes-after-reads-display: SKIP (0.000s) [656.947586] [101/131] (446s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [659.032117] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [659.033881] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [659.153620] [102/131] (444s left) kms_dsc (dsc-with-formats) [661.273132] Starting subtest: dsc-with-formats [661.289948] Subtest dsc-with-formats: SKIP (0.001s) [661.333336] [103/131] (442s left) kms_rotation_crc (multiplane-rotation-cropping-top) [663.446106] Starting subtest: multiplane-rotation-cropping-top [674.980863] Subtest multiplane-rotation-cropping-top: SUCCESS (11.536s) [675.171938] [104/131] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [677.241104] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [677.242901] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [677.343454] [105/131] (426s left) kms_pm_rpm (universal-planes) [682.562035] Starting subtest: universal-planes [682.563120] Starting dynamic subtest: plane-32 [690.951124] Dynamic subtest plane-32: SUCCESS (8.387s) [690.988597] Starting dynamic subtest: plane-41 [699.216247] Dynamic subtest plane-41: SUCCESS (8.263s) [699.255711] Starting dynamic subtest: plane-50 [707.559628] Dynamic subtest plane-50: SUCCESS (8.340s) [707.599013] Starting dynamic subtest: plane-59 [715.816658] Dynamic subtest plane-59: SUCCESS (8.253s) [715.854547] Starting dynamic subtest: plane-68 [724.138351] Dynamic subtest plane-68: SUCCESS (8.318s) [724.148805] Starting dynamic subtest: plane-77 [732.429043] Dynamic subtest plane-77: SUCCESS (8.287s) [732.430572] Subtest universal-planes: SUCCESS (49.865s) [733.586116] [106/131] (369s left) kms_flip (2x-plain-flip) [735.646100] Starting subtest: 2x-plain-flip [735.658150] Subtest 2x-plain-flip: SKIP (0.013s) [735.743633] [107/131] (367s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [737.892460] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [737.894484] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [737.977025] [108/131] (365s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [740.124215] Starting subtest: nonblocking-modeset-vs-cursor-atomic [740.315037] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.192s) [740.476081] [109/131] (363s left) kms_atomic (test-only) [742.581637] Starting subtest: test-only [743.046439] Starting dynamic subtest: pipe-A-HDMI-A-3 [743.722484] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.676s) [743.723369] Subtest test-only: SUCCESS (1.140s) [743.886683] [110/131] (359s left) kms_psr (pr-cursor-plane-move) [745.950438] Subtest pr-cursor-plane-move: SKIP (0.000s) [745.977697] [111/131] (357s left) kms_addfb_basic (bad-pitch-32) [746.099353] Starting subtest: bad-pitch-32 [746.100251] Subtest bad-pitch-32: SUCCESS (0.000s) [748.143419] [112/131] (355s left) i915_power (sanity) [748.334254] Starting subtest: sanity [752.422433] Subtest sanity: SUCCESS (4.086s) [752.549653] [113/131] (351s left) prime_mmap_kms (buffer-sharing) [754.606214] Starting subtest: buffer-sharing [754.943725] Subtest buffer-sharing: SUCCESS (0.338s) [755.112598] [114/131] (348s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [757.187766] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s) [757.205704] [115/131] (346s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [759.272007] Starting subtest: fbc-modesetfrombusy [760.489488] Subtest fbc-modesetfrombusy: SUCCESS (1.219s) [760.629108] [116/131] (343s left) kms_cursor_edge_walk (64x64-top-bottom) [762.696168] Starting subtest: 64x64-top-bottom [762.697114] Starting dynamic subtest: pipe-A-HDMI-A-3 [766.000339] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.303s) [766.012361] Starting dynamic subtest: pipe-D-HDMI-A-3 [769.233785] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.231s) [769.234641] Subtest 64x64-top-bottom: SUCCESS (6.538s) [769.401321] [117/131] (334s left) kms_big_fb (yf-tiled-addfb-size-overflow) [771.473354] Starting subtest: yf-tiled-addfb-size-overflow [771.475247] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [771.574423] [118/131] (332s left) core_hotunplug (unbind-rebind) [771.810662] Starting subtest: unbind-rebind [778.120092] Subtest unbind-rebind: SUCCESS (6.310s) [778.140730] [119/131] (325s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [780.155233] Starting subtest: cursorB-vs-flipB-toggle [780.157111] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [780.227651] [120/131] (323s left) gem_exec_params (rsvd2-dirt) [780.372935] Starting subtest: rsvd2-dirt [780.374834] Subtest rsvd2-dirt: SKIP (0.000s) [780.485293] [121/131] (323s left) kms_pm_rpm (cursor) [785.688833] Starting subtest: cursor [796.367033] Subtest cursor: SUCCESS (10.676s) [797.514862] [122/131] (306s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [799.547073] Starting subtest: fbcpsr-rgb565-draw-blt [799.549792] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [799.684709] [123/131] (304s left) gem_mmap_offset (perf) [799.808405] Starting subtest: perf [799.809337] Starting dynamic subtest: lmem0 [800.066152] Dynamic subtest lmem0: SUCCESS (0.257s) [800.077241] Starting dynamic subtest: smem0 [800.082421] Dynamic subtest smem0: SUCCESS (0.002s) [800.083400] Subtest perf: SUCCESS (0.261s) [800.182694] [124/131] (303s left) kms_async_flips (test-time-stamp-atomic) [802.203172] Starting subtest: test-time-stamp-atomic [802.404067] Starting dynamic subtest: pipe-A-HDMI-A-3 [802.685498] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.281s) [802.866426] Starting dynamic subtest: pipe-B-HDMI-A-3 [802.965012] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.107s) [803.130769] Starting dynamic subtest: pipe-C-HDMI-A-3 [803.221260] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.100s) [803.395022] Starting dynamic subtest: pipe-D-HDMI-A-3 [803.493221] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.107s) [803.494115] Subtest test-time-stamp-atomic: SUCCESS (1.290s) [803.873565] [125/131] (300s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [803.960770] Starting subtest: etime-single-wait-for-submit-unsubmitted [804.063278] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s) [804.175826] [126/131] (300s left) gem_softpin (softpin) [804.268439] Starting subtest: softpin [836.652445] Subtest softpin: SUCCESS (32.376s) [836.775616] [127/131] (267s left) gem_exec_reloc (basic-cpu-noreloc) [836.858229] Subtest basic-cpu-noreloc: SKIP (0.000s) [836.909554] [128/131] (267s left) gem_readwrite (new-obj) [836.983471] Subtest new-obj: SKIP (0.000s) [837.030176] [129/131] (267s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [839.058200] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [839.059174] Starting dynamic subtest: pipe-A-valid-mode [839.969911] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.910s) [839.970871] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.912s) [840.118588] [130/131] (264s left) gem_render_copy (linear-to-vebox-yf-tiled) [840.212421] Starting subtest: linear-to-vebox-yf-tiled [840.214467] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [840.390266] [131/131] (263s left) gem_exec_params (invalid-bsd1-flag-on-blt) [840.468746] Starting subtest: invalid-bsd1-flag-on-blt [840.469650] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [840.577858] Closing watchdogs Done.