[59.430704] Initializing watchdogs [59.430752] /dev/watchdog0 [59.447701] [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] [59.452531] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.454914] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.456654] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [59.563314] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [59.565026] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.669522] [002/156] (960s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [59.762673] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [59.763784] Starting dynamic subtest: pipe-A-eDP-1 [59.773779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [59.781692] Starting dynamic subtest: pipe-B-eDP-1 [59.790955] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [59.797594] Starting dynamic subtest: pipe-C-eDP-1 [59.806735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [59.812682] Starting dynamic subtest: pipe-D-eDP-1 [59.821189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [59.822767] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [62.050525] [003/156] (957s left) gem_exec_schedule (wide) [62.232782] Starting subtest: wide [62.234231] Starting dynamic subtest: rcs0 [72.844367] Dynamic subtest rcs0: SUCCESS (10.604s) [72.858384] Starting dynamic subtest: vcs0 [84.897443] Dynamic subtest vcs0: SUCCESS (12.098s) [84.907143] Starting dynamic subtest: vcs1 [95.003403] Dynamic subtest vcs1: SUCCESS (10.104s) [95.013540] Starting dynamic subtest: vecs0 [106.285310] Dynamic subtest vecs0: SUCCESS (11.281s) [106.293357] Starting dynamic subtest: ccs0 [119.868650] Dynamic subtest ccs0: SUCCESS (13.547s) [119.869637] Subtest wide: SUCCESS (57.637s) [121.413058] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true [121.414785] [004/156] (898s left) kms_psr (psr-sprite-render) [121.504382] Starting subtest: psr-sprite-render [121.505394] Starting dynamic subtest: eDP-1 [123.234062] Dynamic subtest eDP-1: SUCCESS (1.728s) [123.235484] Subtest psr-sprite-render: SUCCESS (1.729s) [124.087574] [005/156] (896s left) syncobj_timeline (multi-wait-signaled) [124.134467] Starting subtest: multi-wait-signaled [124.135556] Subtest multi-wait-signaled: SUCCESS (0.001s) [124.228192] [006/156] (895s left) gem_exec_schedule (preempt-contexts) [124.283208] Starting subtest: preempt-contexts [124.284099] Starting dynamic subtest: rcs0 [124.340097] Dynamic subtest rcs0: SUCCESS (0.057s) [124.348469] Starting dynamic subtest: bcs0 [124.391129] Dynamic subtest bcs0: SUCCESS (0.051s) [124.398025] Starting dynamic subtest: vcs0 [124.439231] Dynamic subtest vcs0: SUCCESS (0.048s) [124.447513] Starting dynamic subtest: vcs1 [124.483136] Dynamic subtest vcs1: SUCCESS (0.043s) [124.491826] Starting dynamic subtest: vecs0 [124.528103] Dynamic subtest vecs0: SUCCESS (0.044s) [124.535386] Starting dynamic subtest: ccs0 [124.576316] Dynamic subtest ccs0: SUCCESS (0.048s) [124.577205] Subtest preempt-contexts: SUCCESS (0.293s) [126.391392] [007/156] (893s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [126.483746] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [134.489150] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.007s) [134.595218] [008/156] (885s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [134.697611] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [134.699338] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [134.788139] [009/156] (885s left) syncobj_wait (multi-wait-all-for-submit-submitted) [134.833640] Starting subtest: multi-wait-all-for-submit-submitted [134.935704] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [135.006859] [010/156] (885s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [135.144810] Starting subtest: dp-mst-lic-type-0-hdcp14 [135.148106] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [135.260832] [011/156] (885s left) kms_flip (absolute-wf_vblank) [135.347242] Starting subtest: absolute-wf_vblank [135.348229] Starting dynamic subtest: A-eDP1 [144.143380] Dynamic subtest A-eDP1: SUCCESS (8.769s) [144.153046] Starting dynamic subtest: B-eDP1 [152.881390] Dynamic subtest B-eDP1: SUCCESS (8.737s) [152.890648] Starting dynamic subtest: C-eDP1 [161.607759] Dynamic subtest C-eDP1: SUCCESS (8.711s) [161.617299] Starting dynamic subtest: D-eDP1 [170.329169] Dynamic subtest D-eDP1: SUCCESS (8.722s) [170.330060] Subtest absolute-wf_vblank: SUCCESS (34.948s) [171.493606] [012/156] (848s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [171.614028] Starting subtest: flip-vs-cursor-crc-atomic [172.316771] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.703s) [173.120037] [013/156] (847s left) prime_busy (hang) [173.170984] Starting subtest: hang [173.172097] Starting dynamic subtest: rcs0 [198.841364] Dynamic subtest rcs0: SUCCESS (25.667s) [198.850501] Starting dynamic subtest: bcs0 [205.993677] Dynamic subtest bcs0: SUCCESS (7.153s) [206.003376] Starting dynamic subtest: vcs0 [212.972478] Dynamic subtest vcs0: SUCCESS (6.977s) [212.981818] Starting dynamic subtest: vcs1 [219.950093] Dynamic subtest vcs1: SUCCESS (6.977s) [219.959382] Starting dynamic subtest: vecs0 [226.983786] Dynamic subtest vecs0: SUCCESS (7.034s) [226.992989] Starting dynamic subtest: ccs0 [240.822562] Dynamic subtest ccs0: SUCCESS (13.837s) [240.823873] Subtest hang: SUCCESS (67.648s) [240.922599] [014/156] (779s left) gem_exec_capture (capture-invisible) [240.975952] Starting subtest: capture-invisible [240.976967] Starting dynamic subtest: smem0 [240.978753] Dynamic subtest smem0: SKIP (0.000s) [240.980437] Subtest capture-invisible: SKIP (0.000s) [241.082865] [015/156] (779s left) gem_exec_reloc (basic-concurrent16) [241.137637] Subtest basic-concurrent16: SKIP (0.000s) [241.200973] [016/156] (779s left) gen3_render_linear_blits [241.301554] [017/156] (779s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [241.351524] Starting subtest: single-wait-all-for-submit-available-signaled [241.352738] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [241.443191] [018/156] (779s left) kms_chamelium_edid (hdmi-edid-read) [241.829235] Subtest hdmi-edid-read: SKIP (0.000s) [242.631951] [019/156] (777s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [242.717474] Starting subtest: psr2-cursor-plane-move-continuous-sf [242.718361] Starting dynamic subtest: pipe-A-eDP-1 [253.092475] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.374s) [253.100665] Starting dynamic subtest: pipe-B-eDP-1 [264.138428] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.045s) [264.139232] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.421s) [264.947549] [020/156] (755s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [264.994032] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [264.994900] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [265.085930] [021/156] (755s left) kms_cursor_legacy (single-move) [265.202684] Starting subtest: single-move [265.203536] Starting dynamic subtest: pipe-A [270.629785] Dynamic subtest pipe-A: SUCCESS (5.378s) [270.639513] Starting dynamic subtest: pipe-B [276.011748] Dynamic subtest pipe-B: SUCCESS (5.380s) [276.021054] Starting dynamic subtest: pipe-C [281.393065] Dynamic subtest pipe-C: SUCCESS (5.380s) [281.402125] Starting dynamic subtest: pipe-D [286.737364] Dynamic subtest pipe-D: SUCCESS (5.379s) [286.747059] Starting dynamic subtest: all-pipes [292.162703] Dynamic subtest all-pipes: SUCCESS (5.387s) [292.163814] Subtest single-move: SUCCESS (26.911s) [292.255294] [022/156] (728s left) gem_mmap_gtt (ptrace) [292.303160] Subtest ptrace: SKIP (0.000s) [292.364867] [023/156] (728s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [292.466170] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [292.467828] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [292.562078] [024/156] (728s left) gem_tiled_pread_basic (basic) [292.601763] Subtest basic: SKIP (0.000s) [292.654087] [025/156] (728s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-blt) [292.740439] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-blt [292.742098] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [292.838708] [026/156] (727s left) kms_chamelium_hpd (dp-hpd-fast) [293.219214] Subtest dp-hpd-fast: SKIP (0.000s) [294.054399] [027/156] (726s left) gem_workarounds (reset-fd) [294.117977] Starting subtest: reset-fd [294.260155] Subtest reset-fd: SUCCESS (0.142s) [294.393805] [028/156] (726s left) kms_big_fb (4-tiled-8bpp-rotate-90) [294.492140] Starting subtest: 4-tiled-8bpp-rotate-90 [294.513112] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [294.622235] [029/156] (726s left) gen9_exec_parse (batch-without-end) [294.674763] Subtest batch-without-end: SKIP (0.000s) [294.748858] [030/156] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [294.834916] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [294.836928] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [294.928350] [031/156] (726s left) kms_psr (pr-primary-mmap-cpu) [295.015377] Starting subtest: pr-primary-mmap-cpu [295.017639] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [295.080716] [032/156] (725s left) kms_lease (master-vs-lease) [295.165179] Starting subtest: master-vs-lease [295.166066] Subtest master-vs-lease: SUCCESS (0.001s) [295.290589] [033/156] (725s left) i915_query (engine-info) [295.345376] Starting subtest: engine-info [295.348878] Subtest engine-info: SUCCESS (0.004s) [295.469183] [034/156] (725s left) kms_hdr (bpc-switch) [295.564392] Starting subtest: bpc-switch [295.565238] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [300.147148] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.583s) [300.156922] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [304.698923] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.550s) [304.699997] Subtest bpc-switch: SUCCESS (9.136s) [304.804660] [035/156] (716s left) gem_busy (extended) [304.988639] Starting subtest: extended [304.989611] Starting dynamic subtest: rcs0 [305.069420] Dynamic subtest rcs0: SUCCESS (0.084s) [305.083069] Starting dynamic subtest: bcs0 [305.111042] Dynamic subtest bcs0: SUCCESS (0.040s) [305.120841] Starting dynamic subtest: vcs0 [306.340257] Dynamic subtest vcs0: SUCCESS (1.218s) [306.350296] Starting dynamic subtest: vcs1 [308.324532] Dynamic subtest vcs1: SUCCESS (1.983s) [308.334859] Starting dynamic subtest: vecs0 [310.307730] Dynamic subtest vecs0: SUCCESS (1.982s) [310.317645] Starting dynamic subtest: ccs0 [310.343465] Dynamic subtest ccs0: SUCCESS (0.044s) [310.344455] Subtest extended: SUCCESS (5.359s) [310.574774] [036/156] (710s left) gem_fenced_exec_thrash (no-spare-fences-busy) [310.629768] Subtest no-spare-fences-busy: SKIP (0.000s) [310.687671] [037/156] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [310.785966] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [310.787754] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [310.885400] [038/156] (710s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [310.930575] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [310.979870] [039/156] (710s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [311.079891] Starting subtest: fbc-rgb565-draw-blt [315.285785] Subtest fbc-rgb565-draw-blt: SUCCESS (4.207s) [316.466116] [040/156] (704s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [316.559063] Starting subtest: fbcpsr-rgb101010-draw-render [321.330812] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.773s) [321.449910] [041/156] (699s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [321.504336] Starting subtest: invalid-multi-wait-unsubmitted-signaled [321.505484] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [321.614146] [042/156] (699s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [321.705052] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [321.706655] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [321.774537] [043/156] (699s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render) [321.868035] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render [321.869680] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [321.965380] [044/156] (699s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [322.055342] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [322.056961] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [322.140086] [045/156] (699s left) kms_invalid_mode (bad-htotal) [322.234920] Starting subtest: bad-htotal [322.235816] Starting dynamic subtest: pipe-A-eDP-1 [322.527175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [322.535037] Starting dynamic subtest: pipe-B-eDP-1 [322.535907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [322.543161] Starting dynamic subtest: pipe-C-eDP-1 [322.543989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [322.551344] Starting dynamic subtest: pipe-D-eDP-1 [322.552207] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [322.553045] Subtest bad-htotal: SUCCESS (0.298s) [323.328887] [046/156] (698s left) gen7_exec_parse (basic-offset) [323.382722] Subtest basic-offset: SKIP (0.000s) [323.448096] [047/156] (698s left) perf_pmu (most-busy-check-all) [323.483407] Starting subtest: most-busy-check-all [323.484390] Starting dynamic subtest: rcs0 [325.349859] Dynamic subtest rcs0: SUCCESS (1.855s) [325.361520] Starting dynamic subtest: bcs0 [327.333941] Dynamic subtest bcs0: SUCCESS (1.981s) [327.344442] Starting dynamic subtest: vcs0 [329.317716] Dynamic subtest vcs0: SUCCESS (1.982s) [329.326578] Starting dynamic subtest: vcs1 [331.302051] Dynamic subtest vcs1: SUCCESS (1.983s) [331.310583] Starting dynamic subtest: vecs0 [333.349273] Dynamic subtest vecs0: SUCCESS (2.046s) [333.359576] Starting dynamic subtest: ccs0 [335.333868] Dynamic subtest ccs0: SUCCESS (1.983s) [335.334926] Subtest most-busy-check-all: SUCCESS (11.840s) [335.416820] [048/156] (686s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [335.509145] Starting subtest: plane-all-transition-nonblocking-fencing [335.510166] Starting dynamic subtest: pipe-A-eDP-1 [338.007138] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s) [338.323221] Starting dynamic subtest: pipe-B-eDP-1 [341.574977] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s) [341.887419] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.377s) [342.700718] [049/156] (678s left) kms_cursor_crc (cursor-random-64x64) [342.892528] Starting subtest: cursor-random-64x64 [342.895736] Starting dynamic subtest: pipe-A-eDP-1 [346.251187] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.355s) [346.288626] Starting dynamic subtest: pipe-D-eDP-1 [350.329566] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.048s) [350.330464] Subtest cursor-random-64x64: SUCCESS (7.436s) [351.176832] [050/156] (670s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [351.262593] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [351.263633] Starting dynamic subtest: pipe-A-eDP-1 [351.295943] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [351.304806] Starting dynamic subtest: pipe-B-eDP-1 [351.327342] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [351.335431] Starting dynamic subtest: pipe-C-eDP-1 [351.357295] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [351.365868] Starting dynamic subtest: pipe-D-eDP-1 [351.388590] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [351.390255] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [353.549034] [051/156] (668s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt) [353.644302] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt [353.645985] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [353.744819] [052/156] (667s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [353.836356] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu [353.837970] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [353.934607] [053/156] (667s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw) [354.028820] Starting subtest: psrhdr-1p-pri-indfb-multidraw [354.030619] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [354.130263] [054/156] (667s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [354.217893] Starting subtest: fbc-2p-pri-indfb-multidraw [354.219839] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [354.298136] [055/156] (667s left) perf_pmu (interrupts) [354.336509] Starting subtest: interrupts [355.419323] Subtest interrupts: SUCCESS (1.073s) [355.511527] [056/156] (666s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [355.605361] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [355.606385] Starting dynamic subtest: pipe-A-eDP-1 [355.615709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [355.626428] Starting dynamic subtest: pipe-B-eDP-1 [355.635173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [355.643199] Starting dynamic subtest: pipe-C-eDP-1 [355.651579] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [355.659326] Starting dynamic subtest: pipe-D-eDP-1 [355.668347] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [355.669890] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [357.902637] [057/156] (663s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt) [358.004680] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt [358.006536] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [358.104068] [058/156] (663s left) prime_self_import (basic-with_one_bo_two_files) [358.130487] Starting subtest: basic-with_one_bo_two_files [358.156938] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s) [358.250076] [059/156] (663s left) kms_flip (dpms-vs-vblank-race-interruptible) [358.349167] Starting subtest: dpms-vs-vblank-race-interruptible [358.350227] Starting dynamic subtest: A-eDP1 [362.268023] Dynamic subtest A-eDP1: SUCCESS (3.927s) [362.278343] Starting dynamic subtest: B-eDP1 [365.853486] Dynamic subtest B-eDP1: SUCCESS (3.582s) [365.863195] Starting dynamic subtest: C-eDP1 [369.369552] Dynamic subtest C-eDP1: SUCCESS (3.514s) [369.378371] Starting dynamic subtest: D-eDP1 [372.889607] Dynamic subtest D-eDP1: SUCCESS (3.519s) [372.893787] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.555s) [373.763683] [060/156] (648s left) kms_psr (fbc-psr-primary-render) [373.849942] Starting subtest: fbc-psr-primary-render [373.851014] Starting dynamic subtest: eDP-1 [373.852684] Dynamic subtest eDP-1: SKIP (0.000s) [373.854352] Subtest fbc-psr-primary-render: SKIP (0.001s) [373.918421] [061/156] (648s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [374.016813] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [374.019044] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [374.096484] [062/156] (647s left) kms_psr (fbc-psr2-dpms) [374.193380] Starting subtest: fbc-psr2-dpms [374.194307] Starting dynamic subtest: eDP-1 [374.196258] Dynamic subtest eDP-1: SKIP (0.000s) [374.197945] Subtest fbc-psr2-dpms: SKIP (0.001s) [374.264024] [063/156] (647s left) gem_userptr_blits (unsync-overlap) [374.322853] Subtest unsync-overlap: SKIP (0.000s) [374.447048] [064/156] (647s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt) [374.535342] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt [374.536904] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [374.615926] [065/156] (647s left) gem_exec_fence (submit-chain) [374.792889] Starting subtest: submit-chain [374.804350] Subtest submit-chain: SUCCESS (0.017s) [376.363763] [066/156] (645s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [376.485378] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [387.649703] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.163s) [388.494590] [067/156] (633s left) kms_pipe_crc_basic (suspend-read-crc) [388.598464] Starting subtest: suspend-read-crc [388.599440] Starting dynamic subtest: pipe-A-eDP-1 [407.434345] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.101s) [407.445339] Starting dynamic subtest: pipe-B-eDP-1 [426.434594] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.581s) [426.443922] Starting dynamic subtest: pipe-C-eDP-1 [445.403422] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.511s) [445.413689] Starting dynamic subtest: pipe-D-eDP-1 [464.383906] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.416s) [464.384655] Subtest suspend-read-crc: SUCCESS (13.615s) [471.233707] [068/156] (557s left) i915_drm_fdinfo (virtual-busy-idle) [471.268418] Starting subtest: virtual-busy-idle [471.270141] Subtest virtual-busy-idle: SKIP (0.000s) [471.331348] [069/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [471.425541] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite [471.427564] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [471.535560] [070/156] (556s left) gem_ctx_persistence (legacy-engines-hostile) [471.586795] Starting subtest: legacy-engines-hostile [471.589491] Starting dynamic subtest: render [471.693986] Dynamic subtest render: SUCCESS (0.108s) [471.707287] Starting dynamic subtest: bsd1 [471.785893] Dynamic subtest bsd1: SUCCESS (0.092s) [471.798531] Starting dynamic subtest: bsd2 [471.879804] Dynamic subtest bsd2: SUCCESS (0.093s) [471.892412] Starting dynamic subtest: blt [471.966629] Dynamic subtest blt: SUCCESS (0.087s) [471.979859] Starting dynamic subtest: vebox [472.057570] Dynamic subtest vebox: SUCCESS (0.090s) [472.058935] Subtest legacy-engines-hostile: SUCCESS (0.485s) [472.131209] [071/156] (556s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [472.216478] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [472.217255] Starting dynamic subtest: pipe-A [472.237508] Dynamic subtest pipe-A: SKIP (0.019s) [472.246520] Starting dynamic subtest: pipe-B [472.271466] Dynamic subtest pipe-B: SKIP (0.035s) [472.280153] Starting dynamic subtest: pipe-C [472.304660] Dynamic subtest pipe-C: SKIP (0.034s) [472.312991] Starting dynamic subtest: pipe-D [472.339389] Dynamic subtest pipe-D: SKIP (0.034s) [472.341023] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.125s) [472.435778] [072/156] (555s left) dumb_buffer (create-valid-dumb) [472.480300] Starting subtest: create-valid-dumb [472.481187] Subtest create-valid-dumb: SUCCESS (0.000s) [472.569324] [073/156] (555s left) syncobj_timeline (wait-zero-handles) [472.612917] Starting subtest: wait-zero-handles [472.613919] Subtest wait-zero-handles: SUCCESS (0.000s) [472.706026] [074/156] (555s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [472.807656] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [473.581988] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s) [473.739144] [075/156] (554s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt) [473.830190] Starting subtest: hdr-rgb101010-draw-blt [473.832024] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s) [473.931498] [076/156] (554s left) sw_sync (sync_busy_fork_unixsocket) [473.959074] Starting subtest: sync_busy_fork_unixsocket [473.963995] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s) [474.019126] [077/156] (554s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [474.133893] Starting subtest: cursor-vs-flip-varying-size [505.437355] Subtest cursor-vs-flip-varying-size: SUCCESS (31.465s) [506.308172] [078/156] (522s left) gem_partial_pwrite_pread (write-snoop) [506.359816] Subtest write-snoop: SKIP (0.000s) [506.416892] [079/156] (522s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [506.507044] Starting subtest: fbc-rgb101010-draw-mmap-wc [509.004361] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.497s) [510.127458] [080/156] (518s left) gem_ctx_shared (q-smoketest-all) [510.191884] Starting subtest: Q-smoketest-all [542.554184] Subtest Q-smoketest-all: SUCCESS (32.334s) [543.564826] [081/156] (485s left) kms_vblank (wait-idle) [543.655105] Starting subtest: wait-idle [543.656082] Starting dynamic subtest: pipe-A-eDP-1 [545.431455] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.777s) [545.442558] Starting dynamic subtest: pipe-D-eDP-1 [547.846618] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.413s) [547.847683] Subtest wait-idle: SUCCESS (4.194s) [548.680268] [082/156] (480s left) kms_atomic (test-only) [548.769471] Starting subtest: test-only [548.819021] Starting dynamic subtest: pipe-A-eDP-1 [551.395080] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.577s) [551.395883] Subtest test-only: SUCCESS (2.627s) [552.260469] [083/156] (476s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [552.358217] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [552.360039] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [552.449633] [084/156] (476s left) gem_pread (self) [552.495119] Subtest self: SKIP (0.000s) [552.554390] [085/156] (476s left) gem_exec_reloc (basic-wc-cpu-noreloc) [552.597977] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [552.673034] [086/156] (476s left) kms_panel_fitting (atomic-fastset) [552.757534] Starting subtest: atomic-fastset [552.758476] Starting dynamic subtest: pipe-A-eDP-1 [552.897206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s) [552.908582] Starting dynamic subtest: pipe-B-eDP-1 [554.127246] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s) [554.137520] Starting dynamic subtest: pipe-C-eDP-1 [555.323209] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s) [555.335713] Starting dynamic subtest: pipe-D-eDP-1 [556.552404] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s) [556.553321] Subtest atomic-fastset: SUCCESS (3.798s) [557.794172] [087/156] (471s left) gem_exec_balancer (nohangcheck) [558.081316] Starting subtest: nohangcheck [559.121154] Subtest nohangcheck: SUCCESS (1.039s) [559.215982] [088/156] (469s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [559.305913] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [559.307563] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [559.395788] [089/156] (469s left) kms_psr (psr2-sprite-plane-onoff) [559.481556] Starting subtest: psr2-sprite-plane-onoff [559.482492] Starting dynamic subtest: eDP-1 [561.230764] Dynamic subtest eDP-1: SUCCESS (1.749s) [561.231623] Subtest psr2-sprite-plane-onoff: SUCCESS (1.750s) [562.067294] [090/156] (466s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [562.152893] Starting subtest: blocking-absolute-wf_vblank-interruptible [562.156188] Starting dynamic subtest: A-eDP1 [570.963846] Dynamic subtest A-eDP1: SUCCESS (8.782s) [570.975607] Starting dynamic subtest: B-eDP1 [579.688639] Dynamic subtest B-eDP1: SUCCESS (8.721s) [579.700808] Starting dynamic subtest: C-eDP1 [588.418637] Dynamic subtest C-eDP1: SUCCESS (8.711s) [588.430791] Starting dynamic subtest: D-eDP1 [597.145761] Dynamic subtest D-eDP1: SUCCESS (8.724s) [597.146869] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.950s) [598.316326] [091/156] (430s left) gem_userptr_blits (sync-unmap) [598.381146] Starting subtest: sync-unmap [598.396877] Subtest sync-unmap: SUCCESS (0.015s) [598.522013] [092/156] (430s left) kms_fb_coherency (memset-crc) [598.626573] Starting subtest: memset-crc [598.627692] Starting dynamic subtest: mmap-offset-wc [599.015436] Dynamic subtest mmap-offset-wc: SUCCESS (0.388s) [599.324144] Starting dynamic subtest: mmap-offset-uc [605.528196] Dynamic subtest mmap-offset-uc: SUCCESS (6.215s) [605.821591] Subtest memset-crc: SUCCESS (7.194s) [606.683262] [093/156] (422s left) kms_color (ctm-blue-to-red) [606.775276] Starting subtest: ctm-blue-to-red [606.776269] Starting dynamic subtest: pipe-A-eDP-1 [607.474005] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s) [607.483391] Starting dynamic subtest: pipe-B-eDP-1 [608.902679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s) [608.911751] Starting dynamic subtest: pipe-C-eDP-1 [610.297316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s) [610.308000] Starting dynamic subtest: pipe-D-eDP-1 [611.633669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [611.634701] Subtest ctm-blue-to-red: SUCCESS (4.858s) [612.437859] [094/156] (416s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [612.487114] Starting subtest: invalid-multi-wait-unsubmitted-submitted [612.488288] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [612.585438] [095/156] (416s left) kms_rotation_crc (bad-tiling) [612.667380] Starting subtest: bad-tiling [612.668898] Subtest bad-tiling: SKIP (0.001s) [612.737200] [096/156] (416s left) gem_exec_reloc (basic-gtt-wc-active) [612.786007] Subtest basic-gtt-wc-active: SKIP (0.000s) [612.863143] [097/156] (416s left) gem_userptr_blits (create-destroy-unsync) [612.907296] Subtest create-destroy-unsync: SKIP (0.000s) [613.018238] [098/156] (416s left) i915_drm_fdinfo (busy-hang) [613.050924] Starting subtest: busy-hang [613.051871] Starting dynamic subtest: rcs0 [613.078161] Dynamic subtest rcs0: SKIP (0.026s) [613.089794] Starting dynamic subtest: bcs0 [613.091591] Dynamic subtest bcs0: SKIP (0.001s) [613.100779] Starting dynamic subtest: vcs0 [613.102637] Dynamic subtest vcs0: SKIP (0.000s) [613.111329] Starting dynamic subtest: vcs1 [613.112976] Dynamic subtest vcs1: SKIP (0.001s) [613.121593] Starting dynamic subtest: vecs0 [613.123415] Dynamic subtest vecs0: SKIP (0.000s) [613.132026] Starting dynamic subtest: ccs0 [613.133978] Dynamic subtest ccs0: SKIP (0.000s) [613.135801] Subtest busy-hang: SKIP (0.033s) [613.167153] [099/156] (416s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [613.253673] Starting subtest: fbcpsrhdr-tiling-linear [613.255601] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [613.361506] [100/156] (416s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff) [613.452293] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff [613.453904] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [613.565286] [101/156] (415s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [613.655478] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [613.656425] Starting dynamic subtest: pipe-A-eDP-1 [613.744449] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [613.756868] Starting dynamic subtest: pipe-B-eDP-1 [614.920169] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s) [614.922200] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.266s) [616.127139] [102/156] (413s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [616.215695] Starting subtest: plane-downscale-factor-0-5-with-rotation [616.216821] Starting dynamic subtest: pipe-A [616.234334] Dynamic subtest pipe-A: SKIP (0.018s) [616.243674] Starting dynamic subtest: pipe-B [616.268197] Dynamic subtest pipe-B: SKIP (0.033s) [616.278031] Starting dynamic subtest: pipe-C [616.301961] Dynamic subtest pipe-C: SKIP (0.034s) [616.310852] Starting dynamic subtest: pipe-D [616.337021] Dynamic subtest pipe-D: SKIP (0.034s) [616.338611] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.122s) [616.434059] [103/156] (413s left) kms_psr (fbc-pr-sprite-mmap-cpu) [616.535304] Starting subtest: fbc-pr-sprite-mmap-cpu [616.536968] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [616.604575] [104/156] (412s left) gem_sync (basic-many-each) [616.682780] Starting subtest: basic-many-each [618.979536] Subtest basic-many-each: SUCCESS (2.306s) [619.161092] [105/156] (410s left) kms_cursor_crc (cursor-sliding-32x32) [619.306066] Starting subtest: cursor-sliding-32x32 [619.354839] Subtest cursor-sliding-32x32: SKIP (0.046s) [619.624468] [106/156] (409s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt) [619.721737] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt [619.723768] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [619.820959] [107/156] (409s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [619.908619] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [619.910280] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [619.997350] [108/156] (409s left) gem_exec_reloc (basic-write-read-active) [620.045003] Subtest basic-write-read-active: SKIP (0.000s) [620.122713] [109/156] (409s left) gem_pxp (reject-modify-context-protection-on) [620.244833] Starting subtest: reject-modify-context-protection-on [620.246280] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [620.347176] [110/156] (409s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [620.443608] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [627.195891] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.753s) [627.334162] [111/156] (402s left) kms_prop_blob (invalid-get-prop-any) [627.385517] Starting subtest: invalid-get-prop-any [627.386577] Subtest invalid-get-prop-any: SUCCESS (0.000s) [627.492061] [112/156] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [627.578230] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [634.851130] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.276s) [634.953666] [113/156] (394s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [635.055105] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [635.067122] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s) [635.158027] [114/156] (394s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [635.245628] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [635.247212] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [635.334575] [115/156] (394s left) gem_basic (bad-close) [635.384897] Starting subtest: bad-close [635.386673] Subtest bad-close: SUCCESS (0.000s) [635.490202] [116/156] (394s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [635.570122] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [635.571110] Starting dynamic subtest: pipe-A-eDP-1 [635.580265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [635.589792] Starting dynamic subtest: pipe-B-eDP-1 [635.597786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [635.607069] Starting dynamic subtest: pipe-C-eDP-1 [635.614243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [635.623273] Starting dynamic subtest: pipe-D-eDP-1 [635.630225] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [635.630994] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [637.870325] [117/156] (392s left) gem_mmap_gtt (basic-small-copy-xy) [637.917303] Subtest basic-small-copy-XY: SKIP (0.000s) [637.995995] [118/156] (392s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [638.083831] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [641.988408] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.905s) [643.174564] [119/156] (386s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [643.263637] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [646.984881] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.723s) [648.177650] [120/156] (381s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [648.270334] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [648.271410] Starting dynamic subtest: pipe-A-eDP-1 [648.279820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [648.289267] Starting dynamic subtest: pipe-B-eDP-1 [648.297595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [648.307028] Starting dynamic subtest: pipe-C-eDP-1 [648.314963] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [648.323785] Starting dynamic subtest: pipe-D-eDP-1 [648.332428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [648.334121] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [650.538302] [121/156] (379s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [650.631964] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [650.633502] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [650.728934] [122/156] (379s left) api_intel_bb (blit-noreloc-purge-cache) [650.773263] Starting subtest: blit-noreloc-purge-cache [650.782515] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s) [650.900248] [123/156] (379s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [650.949581] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [651.051737] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [651.127003] [124/156] (379s left) gem_flink_basic (bad-flink) [651.177613] Starting subtest: bad-flink [651.178496] Subtest bad-flink: SUCCESS (0.000s) [651.286580] [125/156] (379s left) kms_big_fb (y-tiled-8bpp-rotate-90) [651.389830] Starting subtest: y-tiled-8bpp-rotate-90 [651.391624] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [651.493669] [126/156] (378s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [651.548294] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [651.651993] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s) [651.726256] [127/156] (378s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt) [651.817064] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt [651.818791] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [651.924600] [128/156] (378s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [652.008229] Starting subtest: addfb25-y-tiled-small-legacy [652.009817] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [652.086436] [129/156] (378s left) gem_lmem_swapping (basic) [652.122173] Subtest basic: SKIP (0.000s) [652.161469] [130/156] (378s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [652.201686] Starting subtest: invalid-single-wait-all-unsubmitted [652.202575] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [652.309587] [131/156] (378s left) gem_set_tiling_vs_gtt [652.432507] [132/156] (378s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [652.530712] Starting subtest: yf-tiled-32bpp-rotate-0 [652.532449] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [652.629262] [133/156] (377s left) kms_frontbuffer_tracking (psr-1p-rte) [652.720293] Starting subtest: psr-1p-rte [658.130436] Subtest psr-1p-rte: SUCCESS (5.413s) [658.275019] [134/156] (372s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [658.373483] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [658.375195] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [658.478953] [135/156] (372s left) gem_ctx_param (invalid-set-no-zeromap) [658.522645] Starting subtest: invalid-set-no-zeromap [658.523565] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [658.588383] [136/156] (372s left) kms_pm_dc (dc5-psr) [659.679453] Starting subtest: dc5-psr [662.551338] Subtest dc5-psr: SUCCESS (2.872s) [663.383255] [137/156] (367s left) api_intel_bb (intel-bb-blit-x) [663.422751] Starting subtest: intel-bb-blit-x [667.211626] Subtest intel-bb-blit-x: SUCCESS (3.780s) [667.317001] [138/156] (363s left) kms_plane_multiple (tiling-4) [667.405988] Starting subtest: tiling-4 [667.406807] Starting dynamic subtest: pipe-A-eDP-1 [671.123999] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.718s) [671.134015] Starting dynamic subtest: pipe-B-eDP-1 [675.695247] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.571s) [675.707336] Starting dynamic subtest: pipe-C-eDP-1 [680.141622] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.445s) [680.151659] Starting dynamic subtest: pipe-D-eDP-1 [684.504804] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.364s) [684.505623] Subtest tiling-4: SUCCESS (17.103s) [685.321821] [139/156] (345s left) gem_exec_schedule (u-semaphore-noskip) [685.385266] Starting subtest: u-semaphore-noskip [685.801926] Subtest u-semaphore-noskip: SUCCESS (0.407s) [686.137979] [140/156] (344s left) kms_cursor_crc (cursor-dpms) [686.263114] Starting subtest: cursor-dpms [686.264140] Starting dynamic subtest: pipe-A-eDP-1 [689.296399] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.032s) [689.305452] Starting dynamic subtest: pipe-D-eDP-1 [692.977258] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.681s) [692.978336] Subtest cursor-dpms: SUCCESS (6.716s) [693.803080] [141/156] (337s left) i915_pm_rps (thresholds) [693.855686] Starting subtest: thresholds [693.857577] Subtest thresholds: SKIP (0.001s) [693.952754] [142/156] (336s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-pwrite) [694.059484] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-pwrite [694.061098] Subtest hdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [694.148703] [143/156] (336s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render) [694.246027] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render [694.247778] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [694.358893] [144/156] (336s left) perf (blocking-parameterized) [694.485152] Starting subtest: blocking-parameterized [714.551421] Subtest blocking-parameterized: SUCCESS (20.014s) [714.588143] [145/156] (316s left) gem_exec_params (dr4-dirt) [714.645014] Starting subtest: DR4-dirt [714.646102] Subtest DR4-dirt: SUCCESS (0.000s) [714.742145] [146/156] (316s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [714.844880] Starting subtest: fbc-2p-primscrn-spr-indfb-move [714.846591] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [714.958438] [147/156] (316s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [715.048790] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [719.314087] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.265s) [720.526889] [148/156] (310s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [720.580403] Starting subtest: y-tiled-ccs-to-yf-tiled [720.582204] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [720.773660] [149/156] (310s left) gem_cs_tlb (engines) [720.827156] Starting subtest: engines [720.828229] Starting dynamic subtest: rcs0 [723.014410] Dynamic subtest rcs0: SUCCESS (2.152s) [723.025474] Starting dynamic subtest: bcs0 [725.142081] Dynamic subtest bcs0: SUCCESS (2.152s) [725.154345] Starting dynamic subtest: vcs0 [727.287840] Dynamic subtest vcs0: SUCCESS (2.152s) [727.300922] Starting dynamic subtest: vcs1 [729.443005] Dynamic subtest vcs1: SUCCESS (2.153s) [729.458093] Starting dynamic subtest: vecs0 [731.639329] Dynamic subtest vecs0: SUCCESS (2.152s) [731.648590] Starting dynamic subtest: ccs0 [733.756739] Dynamic subtest ccs0: SUCCESS (2.153s) [733.757644] Subtest engines: SUCCESS (12.920s) [733.863538] [150/156] (297s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move) [733.963938] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move [733.965665] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [734.055671] [151/156] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [734.143655] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [734.145529] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [734.260244] [152/156] (297s left) kms_busy (extended-modeset-hang-oldfb) [734.352469] Starting subtest: extended-modeset-hang-oldfb [734.353468] Starting dynamic subtest: pipe-A [746.076203] Dynamic subtest pipe-A: SUCCESS (11.722s) [746.087073] Starting dynamic subtest: pipe-D [758.847676] Dynamic subtest pipe-D: SUCCESS (12.769s) [758.848853] Subtest extended-modeset-hang-oldfb: SUCCESS (24.496s) [759.727849] [153/156] (271s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render) [759.834070] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render [766.910955] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.084s) [767.068031] [154/156] (264s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [767.156563] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [767.157459] Starting dynamic subtest: pipe-A-default-mode [768.346550] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [768.348429] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.189s) [768.516623] [155/156] (262s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [768.615222] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [768.616974] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [768.703175] [156/156] (262s left) kms_selftest (drm_framebuffer) [768.734069] Starting subtest: drm_framebuffer [768.788434] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [768.895759] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.107s) [768.905178] Starting dynamic subtest: drm_test_framebuffer_cleanup [769.008042] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.111s) [769.017682] Starting dynamic subtest: drm_test_framebuffer_create [769.207302] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.198s) [769.217591] Starting dynamic subtest: drm_test_framebuffer_free [769.356398] Dynamic subtest drm_test_framebuffer_free: FAIL (0.134s) [769.357986] Subtest drm_framebuffer: FAIL (0.608s) [769.485841] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [769.504743] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [769.505759] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: kms_content_protection results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: prime_busy results: parsing output: 13/ for test: gem_exec_capture results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: gen3_render_linear_blits results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_chamelium_edid results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: gem_mmap_gtt results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_tiled_pread_basic results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_chamelium_hpd results: parsing output: 26/ for test: gem_workarounds results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: gen9_exec_parse results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: i915_query results: parsing output: 33/ for test: kms_hdr results: parsing output: 34/ for test: gem_busy results: parsing output: 35/ for test: gem_fenced_exec_thrash results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_mmap_gtt results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_invalid_mode results: parsing output: 45/ for test: gen7_exec_parse results: parsing output: 46/ for test: perf_pmu results: parsing output: 47/ for test: kms_atomic_transition results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: prime_self_import results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_fence results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: kms_pipe_crc_basic results: parsing output: 67/ for test: i915_drm_fdinfo results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: dumb_buffer results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: sw_sync results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: gem_partial_pwrite_pread results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_ctx_shared results: parsing output: 80/ for test: kms_vblank results: parsing output: 81/ for test: kms_atomic results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: gem_pread results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: kms_panel_fitting results: parsing output: 86/ for test: gem_exec_balancer results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_userptr_blits results: parsing output: 91/ for test: kms_fb_coherency results: parsing output: 92/ for test: kms_color results: parsing output: 93/ for test: syncobj_wait results: parsing output: 94/ for test: kms_rotation_crc results: parsing output: 95/ for test: gem_exec_reloc results: parsing output: 96/ for test: gem_userptr_blits results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: kms_plane_scaling results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: gem_sync results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_reloc results: parsing output: 108/ for test: gem_pxp results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_prop_blob results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_basic results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: gem_mmap_gtt results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: api_intel_bb results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: gem_flink_basic results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_addfb_basic results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: gem_set_tiling_vs_gtt results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: gem_ctx_param results: parsing output: 135/ for test: kms_pm_dc results: parsing output: 136/ for test: api_intel_bb results: parsing output: 137/ for test: kms_plane_multiple results: parsing output: 138/ for test: gem_exec_schedule results: parsing output: 139/ for test: kms_cursor_crc results: parsing output: 140/ for test: i915_pm_rps results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: perf results: parsing output: 144/ for test: gem_exec_params results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gem_render_copy results: parsing output: 148/ for test: gem_cs_tlb results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_busy results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_flip_scaled_crc results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_selftest Done.