[71.815122] Initializing watchdogs [71.815171] /dev/watchdog0 [71.829144] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [71.833808] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.836399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.839631] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [71.963529] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [77.010431] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.060s) [78.144909] [002/133] (954s left) syncobj_timeline (invalid-signal-zero-handles) [78.226719] Starting subtest: invalid-signal-zero-handles [78.229048] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [78.323795] [003/133] (954s left) syncobj_basic (bad-create-flags) [78.377020] Starting subtest: bad-create-flags [78.379414] Subtest bad-create-flags: SUCCESS (0.000s) [78.487255] [004/133] (953s left) gem_exec_alignment (pi) [78.547697] Starting subtest: pi [128.703735] Subtest pi: SUCCESS (50.258s) [129.744366] [005/133] (902s left) kms_psr (fbc-psr-sprite-mmap-gtt) [129.895836] Starting subtest: fbc-psr-sprite-mmap-gtt [129.897799] Starting dynamic subtest: eDP-1 [129.901785] Dynamic subtest eDP-1: SKIP (0.000s) [129.905795] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [129.967337] [006/133] (902s left) kms_cursor_crc (cursor-rapid-movement-512x170) [130.273735] Starting subtest: cursor-rapid-movement-512x170 [130.277652] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [130.398813] [007/133] (902s left) api_intel_allocator (gem-pool) [130.461035] Starting subtest: gem-pool [130.465764] Subtest gem-pool: SUCCESS (0.007s) [130.582710] [008/133] (902s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [130.683414] Starting subtest: primary-y-tiled-reflect-x-90 [130.687911] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [130.752406] [009/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [130.849458] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [130.853261] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [130.947734] [010/133] (901s left) syncobj_timeline (etime-single-wait-submitted) [131.017107] Starting subtest: etime-single-wait-submitted [131.121889] Subtest etime-single-wait-submitted: SUCCESS (0.102s) [131.195065] [011/133] (901s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [131.296580] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [131.300915] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [131.369852] [012/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [131.466032] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [131.470499] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [131.556514] [013/133] (901s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [131.612167] Subtest no-spare-fences-interruptible: SKIP (0.000s) [131.687426] [014/133] (901s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [131.780704] Starting subtest: bad-aux-stride-y-tiled-ccs [131.783067] Starting dynamic subtest: pipe-A-eDP-1 [131.805807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.816142] Starting dynamic subtest: pipe-B-eDP-1 [131.837965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.844742] Starting dynamic subtest: pipe-C-eDP-1 [131.865280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.872554] Starting dynamic subtest: pipe-D-eDP-1 [131.894548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [131.898816] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s) [134.067222] [015/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [134.173646] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [141.535749] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.365s) [141.664644] [016/133] (891s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [141.760842] Starting subtest: psr-modesetfrombusy [147.896146] Subtest psr-modesetfrombusy: SUCCESS (6.138s) [148.022884] [017/133] (884s left) gem_mmap_gtt (basic-read) [148.084067] Subtest basic-read: SKIP (0.000s) [148.140925] [018/133] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [148.246040] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [152.752561] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.509s) [153.885965] [019/133] (879s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [153.978352] Starting subtest: planes-downscale-factor-0-75-unity-scaling [153.980822] Starting dynamic subtest: pipe-A [154.040583] Dynamic subtest pipe-A: SUCCESS (0.065s) [154.050093] Starting dynamic subtest: pipe-B [155.206888] Dynamic subtest pipe-B: SUCCESS (1.166s) [155.216325] Starting dynamic subtest: pipe-C [156.323207] Dynamic subtest pipe-C: SUCCESS (1.115s) [156.334856] Starting dynamic subtest: pipe-D [157.452839] Dynamic subtest pipe-D: SUCCESS (1.129s) [157.455324] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.477s) [158.611915] [020/133] (874s left) gem_ctx_persistence (legacy-engines-queued) [158.675542] Starting subtest: legacy-engines-queued [158.677907] Starting dynamic subtest: render [158.741437] Dynamic subtest render: SUCCESS (0.070s) [158.752545] Starting dynamic subtest: bsd1 [159.862452] Dynamic subtest bsd1: SUCCESS (1.118s) [159.876899] Starting dynamic subtest: bsd2 [161.842877] Dynamic subtest bsd2: SUCCESS (1.978s) [161.854465] Starting dynamic subtest: blt [161.876536] Dynamic subtest blt: SUCCESS (0.034s) [161.884532] Starting dynamic subtest: vebox [163.890974] Dynamic subtest vebox: SUCCESS (2.012s) [163.894464] Subtest legacy-engines-queued: SUCCESS (5.221s) [163.969819] [021/133] (869s left) kms_chamelium_hpd (common-hpd-after-suspend) [164.378144] Subtest common-hpd-after-suspend: SKIP (0.000s) [165.222576] [022/133] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [165.311223] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [169.925506] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.618s) [171.043958] [023/133] (862s left) kms_vblank (query-forked-hang) [171.132982] Starting subtest: query-forked-hang [171.134869] Starting dynamic subtest: pipe-A-eDP-1 [197.649341] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.517s) [197.662321] Starting dynamic subtest: pipe-D-eDP-1 [222.669666] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s) [222.672067] Subtest query-forked-hang: SUCCESS (51.535s) [223.501869] [024/133] (809s left) gem_mmap_gtt (zero-extend) [223.564331] Subtest zero-extend: SKIP (0.000s) [223.622764] [025/133] (809s left) gem_exec_whisper (basic-fds) [223.679394] Starting subtest: basic-fds [229.335159] Subtest basic-fds: SUCCESS (5.653s) [229.514297] [026/133] (803s left) gem_exec_reloc (basic-cpu-active) [229.578087] Subtest basic-cpu-active: SKIP (0.000s) [229.655451] [027/133] (803s left) gem_workarounds (suspend-resume-fd) [229.731160] Starting subtest: suspend-resume-fd [246.090835] Subtest suspend-resume-fd: SUCCESS (1.303s) [246.225759] [028/133] (787s left) kms_cursor_legacy (single-move) [246.359550] Starting subtest: single-move [246.361982] Starting dynamic subtest: pipe-A [251.721335] Dynamic subtest pipe-A: SUCCESS (5.379s) [251.732556] Starting dynamic subtest: pipe-B [257.065730] Dynamic subtest pipe-B: SUCCESS (5.383s) [257.077444] Starting dynamic subtest: pipe-C [262.428483] Dynamic subtest pipe-C: SUCCESS (5.381s) [262.440003] Starting dynamic subtest: pipe-D [267.798313] Dynamic subtest pipe-D: SUCCESS (5.380s) [267.810361] Starting dynamic subtest: all-pipes [273.180961] Dynamic subtest all-pipes: SUCCESS (5.388s) [273.183151] Subtest single-move: SUCCESS (26.920s) [273.269877] [029/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [273.372495] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [280.294911] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.927s) [280.418280] [030/133] (753s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [280.513877] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [280.518061] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [280.610129] [031/133] (752s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [280.726007] Starting subtest: verify-pxp-execution-after-suspend-resume [287.756571] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.032s) [287.899203] [032/133] (745s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [287.998804] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [288.009506] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [288.082579] [033/133] (745s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [288.184600] Starting subtest: psr2-plane-move-sf-dmg-area [288.186917] Starting dynamic subtest: pipe-A-eDP-1 [292.732180] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.555s) [292.743214] Starting dynamic subtest: pipe-B-eDP-1 [298.076587] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.345s) [298.078999] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.903s) [298.954484] [034/133] (734s left) gem_eio (in-flight-10ms) [299.201035] Starting subtest: in-flight-10ms [308.033647] Subtest in-flight-10ms: SUCCESS (8.834s) [308.186280] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true [308.190003] [035/133] (725s left) kms_setmode (clone-exclusive-crtc) [308.246803] Starting subtest: clone-exclusive-crtc [308.254042] Subtest clone-exclusive-crtc: SKIP (0.001s) [308.366232] [036/133] (725s left) kms_cursor_edge_walk (256x256-top-edge) [308.477744] Starting subtest: 256x256-top-edge [308.480071] Starting dynamic subtest: pipe-A-eDP-1 [311.901590] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s) [311.912865] Starting dynamic subtest: pipe-D-eDP-1 [315.019276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [315.021646] Subtest 256x256-top-edge: SUCCESS (6.546s) [315.822828] [037/133] (717s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [315.926399] Starting subtest: async-flip-with-page-flip-events-tiled [316.307822] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [319.160343] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s) [319.173985] Starting dynamic subtest: pipe-A-eDP-1-4 [321.297243] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.194s) [321.307037] Starting dynamic subtest: pipe-A-eDP-1-4 [323.306299] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [323.319072] Starting dynamic subtest: pipe-A-eDP-1-x [325.483899] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [325.869812] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [328.637847] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.776s) [328.650552] Starting dynamic subtest: pipe-B-eDP-1-4 [330.822324] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [330.832080] Starting dynamic subtest: pipe-B-eDP-1-4 [332.830856] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [332.840612] Starting dynamic subtest: pipe-B-eDP-1-x [335.021005] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [335.384381] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [338.162970] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s) [338.178810] Starting dynamic subtest: pipe-C-eDP-1-4 [340.386641] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [340.396614] Starting dynamic subtest: pipe-C-eDP-1-4 [342.345976] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [342.355966] Starting dynamic subtest: pipe-C-eDP-1-x [344.524059] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [344.889732] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [347.699824] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.819s) [347.712437] Starting dynamic subtest: pipe-D-eDP-1-4 [349.872324] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [349.885282] Starting dynamic subtest: pipe-D-eDP-1-4 [351.882361] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [351.892663] Starting dynamic subtest: pipe-D-eDP-1-x [354.111044] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [354.113345] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.149s) [355.274728] [038/133] (678s left) gem_exec_params (dr1-dirt) [355.335655] Starting subtest: DR1-dirt [355.338070] Subtest DR1-dirt: SUCCESS (0.000s) [355.432552] [039/133] (678s left) gem_lmem_swapping (massive-random) [355.480498] Subtest massive-random: SKIP (0.000s) [355.521373] [040/133] (678s left) kms_pm_rpm (modeset-lpsp-stress) [357.045765] Starting subtest: modeset-lpsp-stress [372.988735] Subtest modeset-lpsp-stress: SUCCESS (15.952s) [373.079285] [041/133] (660s left) gem_exec_fence (syncobj-export) [373.519220] Starting subtest: syncobj-export [373.524068] Subtest syncobj-export: SUCCESS (0.005s) [375.001437] [042/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [375.110480] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [375.114851] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [375.197202] [043/133] (658s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [375.303350] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [375.305591] Starting dynamic subtest: pipe-A-eDP-1 [392.276248] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.417s) [392.287983] Starting dynamic subtest: pipe-B-eDP-1 [409.251397] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.464s) [409.261764] Starting dynamic subtest: pipe-C-eDP-1 [426.242439] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.372s) [426.252430] Starting dynamic subtest: pipe-D-eDP-1 [443.225546] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s) [443.227833] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.620s) [444.361995] [044/133] (589s left) kms_mmap_write_crc (main) [444.473584] Starting subtest: main [444.475960] Starting dynamic subtest: pipe-A-eDP-1 [447.943871] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s) [447.945751] Subtest main: SUCCESS (3.513s) [448.741167] [045/133] (585s left) gem_exec_balancer (parallel-out-fence) [448.995102] Starting subtest: parallel-out-fence [450.107836] Subtest parallel-out-fence: SUCCESS (1.122s) [450.222481] [046/133] (583s left) gem_exec_gttfill (multigpu-basic) [450.391911] Starting subtest: multigpu-basic [463.466897] Subtest multigpu-basic: SUCCESS (13.124s) [463.561920] [047/133] (570s left) gem_flink_race (flink_name) [463.653330] Starting subtest: flink_name [469.095678] Subtest flink_name: SUCCESS (5.394s) [469.184282] [048/133] (564s left) gem_softpin (allocator-evict) [469.264677] Starting subtest: allocator-evict [469.267309] Starting dynamic subtest: rcs0 [493.315548] Dynamic subtest rcs0: SUCCESS (24.071s) [493.326599] Starting dynamic subtest: bcs0 [516.941042] Dynamic subtest bcs0: SUCCESS (23.638s) [516.952845] Starting dynamic subtest: vcs0 [540.303363] Dynamic subtest vcs0: SUCCESS (23.366s) [540.314523] Starting dynamic subtest: vcs1 [564.001195] Dynamic subtest vcs1: SUCCESS (23.661s) [564.012922] Starting dynamic subtest: vecs0 [587.690910] Dynamic subtest vecs0: SUCCESS (23.683s) [587.701966] Starting dynamic subtest: ccs0 [611.523197] Dynamic subtest ccs0: SUCCESS (23.829s) [611.526414] Subtest allocator-evict: SUCCESS (142.256s) [611.608679] [049/133] (422s left) gem_wait (write-busy) [611.714477] Starting subtest: write-busy [611.716876] Starting dynamic subtest: all-engines [612.322246] Dynamic subtest all-engines: SUCCESS (0.607s) [612.340103] Starting dynamic subtest: rcs0 [612.877314] Dynamic subtest rcs0: SUCCESS (0.554s) [612.894954] Starting dynamic subtest: bcs0 [613.428051] Dynamic subtest bcs0: SUCCESS (0.550s) [613.446047] Starting dynamic subtest: vcs0 [615.355525] Dynamic subtest vcs0: SUCCESS (1.924s) [615.373302] Starting dynamic subtest: vcs1 [617.403281] Dynamic subtest vcs1: SUCCESS (2.045s) [617.420931] Starting dynamic subtest: vecs0 [619.388478] Dynamic subtest vecs0: SUCCESS (1.982s) [619.407409] Starting dynamic subtest: ccs0 [619.938420] Dynamic subtest ccs0: SUCCESS (0.548s) [619.941102] Subtest write-busy: SUCCESS (8.224s) [620.156097] [050/133] (414s left) gem_exec_balancer (full) [620.233036] Starting subtest: full [625.266520] Subtest full: SUCCESS (5.032s) [625.583439] [051/133] (408s left) syncobj_wait (wait-any-complex) [625.645861] Starting subtest: wait-any-complex [625.705781] Subtest wait-any-complex: SUCCESS (0.062s) [625.798155] [052/133] (408s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [625.911647] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [625.913998] Starting dynamic subtest: pipe-A-eDP-1 [625.973581] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [625.985566] Starting dynamic subtest: pipe-B-eDP-1 [626.044179] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [626.055530] Starting dynamic subtest: pipe-C-eDP-1 [626.114246] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s) [626.125689] Starting dynamic subtest: pipe-D-eDP-1 [626.183849] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [626.188353] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.023s) [628.131508] [053/133] (406s left) kms_hdmi_inject (inject-4k) [628.472702] Starting subtest: inject-4k [628.784977] Subtest inject-4k: SUCCESS (0.315s) [629.313180] [054/133] (405s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [629.415166] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [630.526034] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.112s) [630.643244] [055/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [630.742518] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [630.746064] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [630.849075] [056/133] (403s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [630.937690] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [630.941117] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [631.018419] [057/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [631.113447] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [631.116994] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [631.207667] [058/133] (403s left) kms_joiner (basic-max-non-joiner) [631.302440] Starting subtest: basic-max-non-joiner [631.305924] Subtest basic-max-non-joiner: SKIP (0.000s) [631.368931] [059/133] (403s left) perf (non-system-wide-paranoid) [631.486148] Starting subtest: non-system-wide-paranoid [631.515294] Subtest non-system-wide-paranoid: SUCCESS (0.030s) [631.555875] [060/133] (403s left) prime_mmap (test_forked_cpu_write) [631.611747] Starting subtest: test_forked_cpu_write [631.613604] Starting dynamic subtest: test_forked_cpu_write-smem [631.619197] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s) [631.621163] Subtest test_forked_cpu_write: SUCCESS (0.010s) [631.715659] [061/133] (403s left) kms_async_flips (invalid-async-flip) [631.811438] Starting subtest: invalid-async-flip [632.196190] Starting dynamic subtest: pipe-A-eDP-1 [633.055492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s) [633.420896] Starting dynamic subtest: pipe-B-eDP-1 [634.254805] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.842s) [634.613978] Starting dynamic subtest: pipe-C-eDP-1 [635.429389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.824s) [635.784451] Starting dynamic subtest: pipe-D-eDP-1 [636.543412] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s) [636.545677] Subtest invalid-async-flip: SUCCESS (4.735s) [637.761809] [062/133] (397s left) perf (missing-sample-flags) [637.860514] Starting subtest: missing-sample-flags [637.862866] Subtest missing-sample-flags: SUCCESS (0.000s) [637.915529] [063/133] (396s left) kms_psr (fbc-psr2-cursor-plane-move) [637.999476] Starting subtest: fbc-psr2-cursor-plane-move [638.001778] Starting dynamic subtest: eDP-1 [638.005956] Dynamic subtest eDP-1: SKIP (0.000s) [638.010194] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [638.075919] [064/133] (396s left) kms_feature_discovery (dp-mst) [638.166088] Starting subtest: dp-mst [638.170334] Subtest dp-mst: SKIP (0.000s) [638.236550] [065/133] (396s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [638.330502] Starting subtest: plane-scaler-unity-scaling-with-modifiers [638.332710] Starting dynamic subtest: pipe-A [638.678901] Dynamic subtest pipe-A: SUCCESS (0.350s) [638.689739] Starting dynamic subtest: pipe-B [640.124010] Dynamic subtest pipe-B: SUCCESS (1.444s) [640.134173] Starting dynamic subtest: pipe-C [641.528573] Dynamic subtest pipe-C: SUCCESS (1.403s) [641.539139] Starting dynamic subtest: pipe-D [642.933891] Dynamic subtest pipe-D: SUCCESS (1.404s) [642.936199] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.606s) [644.077832] [066/133] (390s left) kms_universal_plane (universal-plane-functional) [644.173525] Starting subtest: universal-plane-functional [644.175853] Starting dynamic subtest: pipe-A-eDP-1 [648.090304] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.916s) [648.101599] Starting dynamic subtest: pipe-B-eDP-1 [652.638194] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.547s) [652.649452] Starting dynamic subtest: pipe-C-eDP-1 [657.010145] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.369s) [657.021120] Starting dynamic subtest: pipe-D-eDP-1 [661.293321] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.282s) [661.295471] Subtest universal-plane-functional: SUCCESS (17.120s) [662.177416] [067/133] (372s left) gem_set_tiling_vs_gtt [662.313296] [068/133] (372s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [662.401517] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [662.405864] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [662.475330] [069/133] (372s left) gem_ctx_param (invalid-ctx-set) [662.529133] Starting subtest: invalid-ctx-set [662.531437] Subtest invalid-ctx-set: SUCCESS (0.001s) [662.648000] [070/133] (372s left) gem_fenced_exec_thrash (no-spare-fences-busy) [662.714464] Subtest no-spare-fences-busy: SKIP (0.000s) [662.794422] [071/133] (372s left) i915_pm_rpm (gem-evict-pwrite) [664.530471] Starting subtest: gem-evict-pwrite [664.535411] Subtest gem-evict-pwrite: SKIP (0.000s) [665.064402] [072/133] (370s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [665.121448] Starting subtest: y-tiled-ccs-to-y-tiled [665.125784] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [665.307980] [073/133] (369s left) syncobj_wait (wait-delayed-signal) [665.362574] Starting subtest: wait-delayed-signal [665.464360] Subtest wait-delayed-signal: SUCCESS (0.102s) [665.574312] [074/133] (369s left) syncobj_eventfd (timeline-wait-signaled) [665.623352] Starting subtest: timeline-wait-signaled [665.625573] Subtest timeline-wait-signaled: SUCCESS (0.001s) [665.727843] [075/133] (369s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [665.779419] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [665.781843] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [665.899177] [076/133] (369s left) kms_chamelium_color (ctm-red-to-blue) [665.993049] Subtest ctm-red-to-blue: SKIP (0.000s) [666.039555] [077/133] (369s left) kms_big_fb (4-tiled-64bpp-rotate-180) [666.136094] Starting subtest: 4-tiled-64bpp-rotate-180 [667.659064] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.523s) [667.818016] [078/133] (367s left) kms_hdr (bpc-switch) [667.903243] Starting subtest: bpc-switch [668.998934] Starting dynamic subtest: pipe-A-eDP-1 [672.400759] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.404s) [672.402981] Subtest bpc-switch: SUCCESS (4.500s) [672.517517] [079/133] (363s left) device_reset (unbind-reset-rebind) [672.572928] Starting subtest: unbind-reset-rebind [677.501836] Subtest unbind-reset-rebind: SUCCESS (4.924s) [677.575374] [080/133] (358s left) kms_pm_dc (dc6-dpms) [678.698966] Starting subtest: dc6-dpms [680.733614] Subtest dc6-dpms: SUCCESS (2.039s) [680.815640] [081/133] (354s left) kms_flip (dpms-off-confusion) [680.909766] Starting subtest: dpms-off-confusion [680.912089] Starting dynamic subtest: A-eDP1 [689.633730] Dynamic subtest A-eDP1: SUCCESS (8.690s) [689.646933] Starting dynamic subtest: B-eDP1 [698.355062] Dynamic subtest B-eDP1: SUCCESS (8.723s) [698.368010] Starting dynamic subtest: C-eDP1 [707.079237] Dynamic subtest C-eDP1: SUCCESS (8.711s) [707.092793] Starting dynamic subtest: D-eDP1 [715.667625] Dynamic subtest D-eDP1: SUCCESS (8.632s) [715.673188] Subtest dpms-off-confusion: SUCCESS (34.768s) [716.836048] [082/133] (318s left) kms_psr (psr2-no-drrs) [716.924428] Starting subtest: psr2-no-drrs [716.926678] Starting dynamic subtest: eDP-1 [718.510109] Dynamic subtest eDP-1: SUCCESS (1.585s) [718.512036] Subtest psr2-no-drrs: SUCCESS (1.586s) [719.314779] [083/133] (316s left) gem_exec_create (madvise) [719.379019] Starting subtest: madvise [719.381359] Starting dynamic subtest: smem [741.439620] Dynamic subtest smem: SUCCESS (22.055s) [741.442034] Subtest madvise: SUCCESS (22.057s) [742.576100] [084/133] (293s left) api_intel_bb (simple-bb-ctx) [742.645914] Starting subtest: simple-bb-ctx [742.663790] Subtest simple-bb-ctx: SUCCESS (0.019s) [742.802461] [085/133] (293s left) kms_cursor_crc (cursor-offscreen-256x256) [743.054477] Starting subtest: cursor-offscreen-256x256 [743.059602] Starting dynamic subtest: pipe-A-eDP-1 [745.003617] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s) [745.039878] Starting dynamic subtest: pipe-D-eDP-1 [747.633697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.607s) [747.635863] Subtest cursor-offscreen-256x256: SUCCESS (4.576s) [748.483655] [086/133] (287s left) gem_exec_schedule (reorder-wide) [748.663343] Subtest reorder-wide: SKIP (0.000s) [748.849524] [087/133] (287s left) kms_getfb (getfb-handle-valid) [748.945634] Starting subtest: getfb-handle-valid [748.947960] Subtest getfb-handle-valid: SUCCESS (0.000s) [749.041630] [088/133] (286s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [749.107902] Starting subtest: multi-wait-available-unsubmitted-signaled [749.110319] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [749.191496] [089/133] (286s left) gem_exec_reloc (basic-gtt-cpu-active) [749.262046] Subtest basic-gtt-cpu-active: SKIP (0.000s) [749.342753] [090/133] (286s left) perf_pmu (busy-double-start) [749.384533] Starting subtest: busy-double-start [749.387043] Starting dynamic subtest: rcs0 [753.027420] Dynamic subtest rcs0: FAIL (3.588s) [753.041073] Starting dynamic subtest: bcs0 [756.540831] Dynamic subtest bcs0: SUCCESS (3.567s) [756.553897] Starting dynamic subtest: vcs0 [760.891922] Dynamic subtest vcs0: SUCCESS (4.348s) [760.904391] Starting dynamic subtest: vcs1 [764.862015] Dynamic subtest vcs1: SUCCESS (3.967s) [764.874594] Starting dynamic subtest: vecs0 [768.929217] Dynamic subtest vecs0: SUCCESS (4.064s) [768.942341] Starting dynamic subtest: ccs0 [772.564815] Dynamic subtest ccs0: FAIL (3.565s) [772.567097] Subtest busy-double-start: FAIL (23.111s) [772.611238] [091/133] (263s left) perf_pmu (semaphore-wait) [772.658920] Starting subtest: semaphore-wait [772.661195] Starting dynamic subtest: rcs0 [773.177175] Dynamic subtest rcs0: SUCCESS (0.519s) [773.191246] Starting dynamic subtest: bcs0 [773.701275] Dynamic subtest bcs0: SUCCESS (0.511s) [773.712928] Starting dynamic subtest: vcs0 [774.206759] Dynamic subtest vcs0: SUCCESS (0.512s) [774.220870] Starting dynamic subtest: vcs1 [774.721737] Dynamic subtest vcs1: SUCCESS (0.512s) [774.735606] Starting dynamic subtest: vecs0 [775.236900] Dynamic subtest vecs0: SUCCESS (0.512s) [775.249963] Starting dynamic subtest: ccs0 [775.752324] Dynamic subtest ccs0: SUCCESS (0.512s) [775.755027] Subtest semaphore-wait: SUCCESS (3.097s) [775.873613] [092/133] (260s left) kms_content_protection (lic-type-1) [776.024996] Starting subtest: lic-type-1 [776.029430] Subtest lic-type-1: SKIP (0.000s) [776.148467] [093/133] (260s left) gem_exec_suspend (basic-s3) [776.213290] Starting subtest: basic-S3 [776.215554] Starting dynamic subtest: smem [796.043742] Dynamic subtest smem: SUCCESS (6.180s) [796.046430] Subtest basic-S3: SUCCESS (6.182s) [796.233674] [094/133] (239s left) i915_pm_rps (thresholds-idle-park) [796.315246] Starting subtest: thresholds-idle-park [796.320236] Subtest thresholds-idle-park: SKIP (0.001s) [796.389846] [095/133] (239s left) kms_lease (setcrtc-implicit-plane) [796.480212] Starting subtest: setcrtc-implicit-plane [796.482477] Starting dynamic subtest: pipe-A-eDP-1 [796.938347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s) [796.953246] Starting dynamic subtest: pipe-B-eDP-1 [798.095058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s) [798.106339] Starting dynamic subtest: pipe-C-eDP-1 [799.188349] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.088s) [799.201028] Starting dynamic subtest: pipe-D-eDP-1 [800.351925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s) [800.354745] Subtest setcrtc-implicit-plane: SUCCESS (3.870s) [801.458208] [096/133] (234s left) kms_flip (2x-flip-vs-expired-vblank) [801.559164] Starting subtest: 2x-flip-vs-expired-vblank [801.567481] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [801.649708] [097/133] (234s left) gem_mmap_gtt (medium-copy-odd) [801.704124] Subtest medium-copy-odd: SKIP (0.000s) [801.767350] [098/133] (234s left) kms_psr (fbc-psr-sprite-render) [801.881244] Starting subtest: fbc-psr-sprite-render [801.883542] Starting dynamic subtest: eDP-1 [801.888354] Dynamic subtest eDP-1: SKIP (0.000s) [801.893356] Subtest fbc-psr-sprite-render: SKIP (0.001s) [801.971972] [099/133] (234s left) gem_unref_active_buffers [802.178263] [100/133] (234s left) i915_drm_fdinfo (virtual-idle) [802.221305] Starting subtest: virtual-idle [805.286926] Subtest virtual-idle: SUCCESS (3.058s) [805.364899] [101/133] (231s left) gem_pxp (create-valid-protected-context) [805.483808] Starting subtest: create-valid-protected-context [805.486880] Subtest create-valid-protected-context: SUCCESS (0.001s) [805.593580] [102/133] (231s left) gem_gtt_cpu_tlb [805.724831] [103/133] (230s left) perf_pmu (idle-no-semaphores) [805.765778] Starting subtest: idle-no-semaphores [805.768321] Starting dynamic subtest: rcs0 [806.304302] Dynamic subtest rcs0: SUCCESS (0.538s) [806.319757] Starting dynamic subtest: bcs0 [806.822379] Dynamic subtest bcs0: SUCCESS (0.514s) [806.834792] Starting dynamic subtest: vcs0 [807.342187] Dynamic subtest vcs0: SUCCESS (0.516s) [807.353887] Starting dynamic subtest: vcs1 [807.857773] Dynamic subtest vcs1: SUCCESS (0.511s) [807.872633] Starting dynamic subtest: vecs0 [808.376247] Dynamic subtest vecs0: SUCCESS (0.515s) [808.390409] Starting dynamic subtest: ccs0 [808.893667] Dynamic subtest ccs0: SUCCESS (0.514s) [808.896599] Subtest idle-no-semaphores: SUCCESS (3.127s) [809.057619] [104/133] (227s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [809.170890] Starting subtest: fbcpsr-1p-rte [816.090295] Subtest fbcpsr-1p-rte: SUCCESS (6.918s) [816.228002] [105/133] (220s left) i915_drm_fdinfo (busy-idle-check-all) [816.270144] Starting subtest: busy-idle-check-all [816.272757] Starting dynamic subtest: rcs0 [816.278110] Dynamic subtest rcs0: SKIP (0.004s) [816.289288] Starting dynamic subtest: bcs0 [816.294642] Dynamic subtest bcs0: SKIP (0.000s) [816.305341] Starting dynamic subtest: vcs0 [816.310181] Dynamic subtest vcs0: SKIP (0.000s) [816.320460] Starting dynamic subtest: vcs1 [816.325360] Dynamic subtest vcs1: SKIP (0.000s) [816.336178] Starting dynamic subtest: vecs0 [816.341241] Dynamic subtest vecs0: SKIP (0.000s) [816.351502] Starting dynamic subtest: ccs0 [816.356506] Dynamic subtest ccs0: SKIP (0.000s) [816.361308] Subtest busy-idle-check-all: SKIP (0.009s) [816.400795] [106/133] (220s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [816.519365] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [816.524300] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [816.592867] [107/133] (220s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [816.692080] Starting subtest: pr-overlay-primary-update-sf-dmg-area [816.697167] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [816.760398] [108/133] (220s left) gem_ccs (block-multicopy-compressed) [816.816491] Starting subtest: block-multicopy-compressed [816.821511] Subtest block-multicopy-compressed: SKIP (0.000s) [816.923239] [109/133] (220s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [817.019268] Starting subtest: fbcpsr-2p-rte [817.023159] Subtest fbcpsr-2p-rte: SKIP (0.000s) [817.119183] [110/133] (219s left) gem_ctx_exec (basic-norecovery) [817.172644] Starting subtest: basic-norecovery [817.516781] Subtest basic-norecovery: SUCCESS (0.344s) [817.631183] [111/133] (219s left) gem_exec_schedule (noreorder-priority) [817.822078] Starting subtest: noreorder-priority [817.824727] Starting dynamic subtest: rcs0 [818.959664] Dynamic subtest rcs0: SUCCESS (1.136s) [818.973362] Starting dynamic subtest: vcs0 [820.979168] Dynamic subtest vcs0: SUCCESS (2.014s) [820.992143] Starting dynamic subtest: vcs1 [823.045405] Dynamic subtest vcs1: SUCCESS (2.062s) [823.059119] Starting dynamic subtest: vecs0 [825.009626] Dynamic subtest vecs0: SUCCESS (1.961s) [825.022982] Starting dynamic subtest: ccs0 [826.145479] Dynamic subtest ccs0: SUCCESS (1.134s) [826.148136] Subtest noreorder-priority: SUCCESS (8.321s) [826.337514] [112/133] (210s left) gem_mmap (bad-size) [826.401621] Subtest bad-size: SKIP (0.000s) [826.463377] [113/133] (210s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [826.563494] Starting subtest: plane-lut1d-ctm3x4-lut1d [826.687708] Starting dynamic subtest: pipe-A-plane-0 [826.842487] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [826.854166] Starting dynamic subtest: pipe-A-plane-1 [826.976007] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [826.989898] Starting dynamic subtest: pipe-A-plane-2 [827.131989] Dynamic subtest pipe-A-plane-2: SUCCESS (0.153s) [828.340636] Starting dynamic subtest: pipe-B-plane-0 [828.520192] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [828.538866] Starting dynamic subtest: pipe-B-plane-1 [828.654505] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [828.666178] Starting dynamic subtest: pipe-B-plane-2 [828.786940] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s) [829.964476] Starting dynamic subtest: pipe-C-plane-0 [830.099868] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [830.110867] Starting dynamic subtest: pipe-C-plane-1 [830.266905] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [830.278015] Starting dynamic subtest: pipe-C-plane-2 [830.421920] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [831.594743] Starting dynamic subtest: pipe-D-plane-0 [831.730267] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [831.742323] Starting dynamic subtest: pipe-D-plane-1 [831.874392] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [831.886097] Starting dynamic subtest: pipe-D-plane-2 [832.029976] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [832.337407] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.771s) [833.170408] [114/133] (204s left) kms_psr (psr-sprite-mmap-cpu) [833.260424] Starting subtest: psr-sprite-mmap-cpu [833.262772] Starting dynamic subtest: eDP-1 [834.993146] Dynamic subtest eDP-1: SUCCESS (1.733s) [834.996116] Subtest psr-sprite-mmap-cpu: SUCCESS (1.734s) [835.856179] [115/133] (201s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [835.944111] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [835.946638] Starting dynamic subtest: pipe-A-eDP-1 [836.675389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s) [836.687409] Starting dynamic subtest: pipe-B-eDP-1 [838.440914] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.766s) [838.452214] Starting dynamic subtest: pipe-C-eDP-1 [840.188988] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.747s) [840.200384] Starting dynamic subtest: pipe-D-eDP-1 [842.015215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.822s) [842.017522] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.060s) [843.169252] [116/133] (194s left) kms_addfb_basic (invalid-set-prop) [843.231492] Starting subtest: invalid-set-prop [843.234414] Subtest invalid-set-prop: SUCCESS (0.000s) [843.375955] [117/133] (193s left) syncobj_timeline (wait-all-snapshot) [843.433939] Starting subtest: wait-all-snapshot [843.514587] Subtest wait-all-snapshot: SUCCESS (0.083s) [843.604864] [118/133] (193s left) kms_plane_multiple (tiling-y) [843.693878] Starting subtest: tiling-y [843.699088] Subtest tiling-y: SKIP (0.000s) [843.773907] [119/133] (193s left) vgem_basic (dmabuf-fence) [843.823139] Starting subtest: dmabuf-fence [843.825402] Subtest dmabuf-fence: SUCCESS (0.000s) [843.895223] [120/133] (193s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [843.991878] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [843.997147] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [844.099848] [121/133] (193s left) gem_close_race (multigpu-basic-threads) [844.171997] Starting subtest: multigpu-basic-threads [844.176526] Subtest multigpu-basic-threads: SKIP (0.000s) [844.396901] [122/133] (193s left) sysfs_heartbeat_interval (mixed) [844.453473] Starting subtest: mixed [844.456382] Starting dynamic subtest: vecs0 [849.652147] Dynamic subtest vecs0: SUCCESS (5.198s) [849.665993] Starting dynamic subtest: ccs0 [854.863494] Dynamic subtest ccs0: SUCCESS (5.209s) [854.877513] Starting dynamic subtest: vcs0 [860.049464] Dynamic subtest vcs0: SUCCESS (5.183s) [860.063151] Starting dynamic subtest: bcs0 [865.281285] Dynamic subtest bcs0: SUCCESS (5.229s) [865.294171] Starting dynamic subtest: rcs0 [870.531081] Dynamic subtest rcs0: SUCCESS (5.247s) [870.544494] Starting dynamic subtest: vcs1 [875.723993] Dynamic subtest vcs1: SUCCESS (5.191s) [875.726827] Subtest mixed: SUCCESS (31.267s) [875.811867] [123/133] (161s left) gem_ctx_create (basic-files) [875.867187] Starting subtest: basic-files [877.877368] Subtest basic-files: SUCCESS (2.010s) [879.102883] [124/133] (158s left) kms_big_fb (y-tiled-16bpp-rotate-180) [879.201632] Starting subtest: y-tiled-16bpp-rotate-180 [879.206408] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [879.299012] [125/133] (158s left) gen9_exec_parse (cmd-crossing-page) [879.369326] Subtest cmd-crossing-page: SKIP (0.000s) [879.438656] [126/133] (158s left) kms_flip (wf_vblank-ts-check-interruptible) [879.525733] Starting subtest: wf_vblank-ts-check-interruptible [879.528082] Starting dynamic subtest: A-eDP1 [888.449294] Dynamic subtest A-eDP1: SUCCESS (8.887s) [888.462221] Starting dynamic subtest: B-eDP1 [897.375353] Dynamic subtest B-eDP1: SUCCESS (8.923s) [897.386266] Starting dynamic subtest: C-eDP1 [906.298260] Dynamic subtest C-eDP1: SUCCESS (8.912s) [906.310469] Starting dynamic subtest: D-eDP1 [915.239154] Dynamic subtest D-eDP1: SUCCESS (8.938s) [915.241376] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.671s) [916.342370] [127/133] (121s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [916.436473] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [920.470116] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.037s) [921.656269] [128/133] (116s left) gem_mmap_gtt (basic-small-bo) [921.722527] Subtest basic-small-bo: SKIP (0.000s) [921.781799] [129/133] (116s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [921.877281] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [921.882247] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [921.962344] [130/133] (115s left) kms_big_fb (linear-8bpp-rotate-180) [922.063957] Starting subtest: linear-8bpp-rotate-180 [923.345219] Subtest linear-8bpp-rotate-180: SUCCESS (1.281s) [923.457521] [131/133] (114s left) kms_big_fb (x-tiled-32bpp-rotate-180) [923.554304] Starting subtest: x-tiled-32bpp-rotate-180 [924.945187] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s) [925.078687] [132/133] (112s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [925.143160] Starting subtest: yf-tiled-to-vebox-x-tiled [925.148402] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [925.347742] [133/133] (112s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [925.449742] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [925.452393] Starting dynamic subtest: pipe-A-eDP-1 [925.478175] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [925.489481] Starting dynamic subtest: pipe-B-eDP-1 [925.516291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [925.527468] Starting dynamic subtest: pipe-C-eDP-1 [925.553419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [925.564114] Starting dynamic subtest: pipe-D-eDP-1 [925.591032] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [925.595510] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [927.619899] 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: syncobj_basic results: parsing output: 3/ for test: gem_exec_alignment results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_cursor_crc results: parsing output: 6/ for test: api_intel_allocator results: parsing output: 7/ for test: kms_rotation_crc results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_psr2_sf results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_fenced_exec_thrash results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_mmap_gtt results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_plane_scaling results: parsing output: 19/ for test: gem_ctx_persistence results: parsing output: 20/ for test: kms_chamelium_hpd results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_vblank results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: gem_workarounds results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: gem_pxp results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: kms_setmode results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: kms_async_flips results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: gem_lmem_swapping results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_mmap_write_crc results: parsing output: 44/ for test: gem_exec_balancer results: parsing output: 45/ for test: gem_exec_gttfill results: parsing output: 46/ for test: gem_flink_race results: parsing output: 47/ for test: gem_softpin results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_hdmi_inject results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_joiner results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: prime_mmap results: parsing output: 60/ for test: kms_async_flips results: parsing output: 61/ for test: perf results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_feature_discovery results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_universal_plane results: parsing output: 66/ for test: gem_set_tiling_vs_gtt results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: gem_fenced_exec_thrash results: parsing output: 70/ for test: i915_pm_rpm results: parsing output: 71/ for test: gem_render_copy results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: syncobj_eventfd results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: kms_chamelium_color results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_hdr results: parsing output: 78/ for test: device_reset results: parsing output: 79/ for test: kms_pm_dc results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: gem_exec_create results: parsing output: 83/ for test: api_intel_bb results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: kms_getfb results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: gem_exec_reloc results: parsing output: 89/ for test: perf_pmu results: parsing output: 90/ for test: perf_pmu results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: gem_exec_suspend results: parsing output: 93/ for test: i915_pm_rps results: parsing output: 94/ for test: kms_lease results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_unref_active_buffers results: parsing output: 99/ for test: i915_drm_fdinfo results: parsing output: 100/ for test: gem_pxp results: parsing output: 101/ for test: gem_gtt_cpu_tlb results: parsing output: 102/ for test: perf_pmu results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: i915_drm_fdinfo results: parsing output: 105/ for test: kms_plane results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: gem_ccs results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_ctx_exec results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: gem_mmap results: parsing output: 112/ for test: kms_color_pipeline results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_plane_multiple results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_close_race results: parsing output: 121/ for test: sysfs_heartbeat_interval results: parsing output: 122/ for test: gem_ctx_create results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gen9_exec_parse results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_mmap_gtt results: parsing output: 128/ for test: kms_flip_scaled_crc results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: gem_render_copy results: parsing output: 132/ for test: kms_ccs Done.