[56.040636] Initializing watchdogs [56.040780] /dev/watchdog0 [56.057554] [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] [56.062132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.064824] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.068682] [001/155] (960s left) api_intel_bb (blit-reloc-keep-cache) [56.139120] Starting subtest: blit-reloc-keep-cache [56.143934] Subtest blit-reloc-keep-cache: SKIP (0.001s) [56.276530] [002/155] (960s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [56.400319] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [56.404626] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [56.481718] [003/155] (960s left) kms_psr (fbc-psr2-primary-blt) [56.572210] Starting subtest: fbc-psr2-primary-blt [56.574545] Starting dynamic subtest: eDP-1 [56.578684] Dynamic subtest eDP-1: SKIP (0.000s) [56.582795] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [56.646106] [004/155] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [56.739137] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [56.743777] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [56.821345] [005/155] (959s left) perf (polling) [56.936199] Starting subtest: polling [56.937844] Starting dynamic subtest: 0-rcs0 [66.958843] Dynamic subtest 0-rcs0: SUCCESS (9.903s) [66.970588] Starting dynamic subtest: 1-vecs0 [77.038718] Dynamic subtest 1-vecs0: SUCCESS (9.998s) [77.040914] Subtest polling: SUCCESS (19.903s) [77.095841] [006/155] (939s left) syncobj_wait (single-wait-signaled) [77.154777] Starting subtest: single-wait-signaled [77.157216] Subtest single-wait-signaled: SUCCESS (0.001s) [77.277083] [007/155] (939s left) gem_exec_fence (invalid-timeline-fence-array) [77.838993] Starting subtest: invalid-timeline-fence-array [77.847716] Subtest invalid-timeline-fence-array: SUCCESS (0.008s) [79.383821] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [79.386738] [008/155] (937s left) gem_create (create-massive) [79.434267] Starting subtest: create-massive [79.436293] Subtest create-massive: SUCCESS (0.000s) [79.638815] [009/155] (937s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt) [79.747024] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt [79.751267] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [79.886916] [010/155] (937s left) syncobj_timeline (invalid-single-wait-unsubmitted) [79.954754] Starting subtest: invalid-single-wait-unsubmitted [79.956984] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [80.056192] [011/155] (936s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt) [80.160576] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt [80.164974] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [80.242780] [012/155] (936s left) kms_vblank (query-forked-busy) [80.339113] Starting subtest: query-forked-busy [80.341438] Starting dynamic subtest: pipe-A-eDP-1 [82.242438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s) [82.255696] Starting dynamic subtest: pipe-D-eDP-1 [84.842663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.598s) [84.845069] Subtest query-forked-busy: SUCCESS (4.501s) [85.653174] [013/155] (931s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [85.757773] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [85.762575] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [85.852125] [014/155] (931s left) gem_lmem_swapping (verify) [85.896454] Subtest verify: SKIP (0.000s) [85.939010] [015/155] (931s left) api_intel_bb (object-noreloc-purge-cache-simple) [85.990060] Starting subtest: object-noreloc-purge-cache-simple [85.994865] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.007s) [86.112253] [016/155] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [86.214687] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [90.686292] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.475s) [91.888382] [017/155] (925s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy) [91.997518] Starting subtest: psrhdr-modesetfrombusy [92.002142] Subtest psrhdr-modesetfrombusy: SKIP (0.000s) [92.102316] [018/155] (925s left) gem_ccs (block-copy-compressed) [92.166237] Starting subtest: block-copy-compressed [92.170980] Subtest block-copy-compressed: SKIP (0.000s) [92.265494] [019/155] (925s left) kms_lease (page-flip-implicit-plane) [92.362172] Starting subtest: page-flip-implicit-plane [92.364654] Starting dynamic subtest: pipe-A-eDP-1 [92.843697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s) [92.853773] Starting dynamic subtest: pipe-B-eDP-1 [94.021396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s) [94.032080] Starting dynamic subtest: pipe-C-eDP-1 [95.131737] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s) [95.142352] Starting dynamic subtest: pipe-D-eDP-1 [96.261084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [96.263454] Subtest page-flip-implicit-plane: SUCCESS (3.897s) [97.087921] [020/155] (920s left) gem_ctx_isolation (clean) [97.161243] Starting subtest: clean [97.163744] Starting dynamic subtest: rcs0 [97.201784] Dynamic subtest rcs0: SUCCESS (0.040s) [97.213189] Starting dynamic subtest: bcs0 [97.258729] Dynamic subtest bcs0: SUCCESS (0.056s) [97.272635] Starting dynamic subtest: vcs0 [97.331195] Dynamic subtest vcs0: SUCCESS (0.072s) [97.341263] Starting dynamic subtest: vcs1 [99.285564] Dynamic subtest vcs1: SUCCESS (1.953s) [99.296701] Starting dynamic subtest: vecs0 [101.329046] Dynamic subtest vecs0: SUCCESS (2.042s) [101.339822] Starting dynamic subtest: ccs0 [103.320698] Dynamic subtest ccs0: SUCCESS (1.990s) [103.323232] Subtest clean: SUCCESS (6.157s) [103.557771] [021/155] (913s left) gem_pxp (verify-pxp-stale-ctx-execution) [103.679998] Starting subtest: verify-pxp-stale-ctx-execution [104.749102] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.069s) [104.880166] [022/155] (912s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [104.936393] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [105.038501] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [105.113833] [023/155] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [105.221812] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [105.226475] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [105.328983] [024/155] (912s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [105.425770] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [105.428607] Starting dynamic subtest: pipe-A-default-mode [106.559073] Dynamic subtest pipe-A-default-mode: SKIP (1.131s) [106.563620] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.132s) [106.704233] [025/155] (910s left) gem_eio (wait-wedge-immediate) [106.898799] Starting subtest: wait-wedge-immediate [108.344179] Subtest wait-wedge-immediate: SUCCESS (1.444s) [108.506116] [026/155] (909s left) kms_rmfb (rmfb-ioctl) [108.591487] Starting subtest: rmfb-ioctl [108.593829] Starting dynamic subtest: pipe-A-eDP-1 [108.694339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [108.703912] Starting dynamic subtest: pipe-B-eDP-1 [109.898190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.202s) [109.908119] Starting dynamic subtest: pipe-C-eDP-1 [111.107326] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s) [111.118199] Starting dynamic subtest: pipe-D-eDP-1 [112.268091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s) [112.270594] Subtest rmfb-ioctl: SUCCESS (3.679s) [113.474279] [027/155] (904s left) kms_color (invalid-gamma-lut-sizes) [113.561127] Starting subtest: invalid-gamma-lut-sizes [113.563517] Starting dynamic subtest: pipe-A [113.847873] Dynamic subtest pipe-A: SUCCESS (0.288s) [113.856842] Starting dynamic subtest: pipe-B [113.859066] Dynamic subtest pipe-B: SUCCESS (0.000s) [113.867806] Starting dynamic subtest: pipe-C [113.870151] Dynamic subtest pipe-C: SUCCESS (0.000s) [113.878828] Starting dynamic subtest: pipe-D [113.881293] Dynamic subtest pipe-D: SUCCESS (0.000s) [113.883215] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s) [114.708746] [028/155] (903s left) kms_psr (psr2-primary-render) [114.802928] Starting subtest: psr2-primary-render [114.805308] Starting dynamic subtest: eDP-1 [116.520462] Dynamic subtest eDP-1: SUCCESS (1.719s) [116.522877] Subtest psr2-primary-render: SUCCESS (1.720s) [117.396455] [029/155] (900s left) kms_psr (fbc-psr-cursor-mmap-cpu) [117.494292] Starting subtest: fbc-psr-cursor-mmap-cpu [117.496649] Starting dynamic subtest: eDP-1 [117.500894] Dynamic subtest eDP-1: SKIP (0.000s) [117.505238] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s) [117.571621] [030/155] (900s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [117.676618] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [117.681027] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [117.769219] [031/155] (900s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary) [117.874786] Starting subtest: fbchdr-shrfb-scaledprimary [117.878946] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s) [117.960720] [032/155] (899s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [118.062896] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [118.067557] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [119.224386] [033/155] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [119.330619] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [126.405025] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.078s) [126.531274] [034/155] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [126.632068] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [134.129446] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.502s) [134.243759] [035/155] (883s left) syncobj_timeline (single-wait-for-submit-available-signaled) [134.302085] Starting subtest: single-wait-for-submit-available-signaled [134.304413] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [134.395250] [036/155] (883s left) prime_udl [134.477763] [037/155] (883s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [134.582076] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [135.683780] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.102s) [135.818224] [038/155] (882s left) kms_cursor_legacy (torture-move) [135.941087] Starting subtest: torture-move [135.942787] Starting dynamic subtest: pipe-A [141.737253] Dynamic subtest pipe-A: SUCCESS (5.741s) [141.747789] Starting dynamic subtest: pipe-B [148.151802] Dynamic subtest pipe-B: SUCCESS (6.463s) [148.167720] Starting dynamic subtest: pipe-C [154.644395] Dynamic subtest pipe-C: SUCCESS (6.494s) [154.654844] Starting dynamic subtest: pipe-D [160.307553] Dynamic subtest pipe-D: SUCCESS (5.661s) [160.322085] Starting dynamic subtest: all-pipes [166.858089] Dynamic subtest all-pipes: SUCCESS (6.550s) [166.860882] Subtest torture-move: SUCCESS (30.915s) [167.015503] [039/155] (851s left) gem_caching (reads) [167.067086] Subtest reads: SKIP (0.000s) [167.136783] [040/155] (851s left) kms_atomic_transition (plane-all-modeset-transition) [167.230898] Starting subtest: plane-all-modeset-transition [167.235215] Subtest plane-all-modeset-transition: SKIP (0.000s) [167.305470] [041/155] (850s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [167.410424] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [168.546346] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.135s) [168.698739] [042/155] (849s left) kms_big_fb (x-tiled-64bpp-rotate-180) [168.807718] Starting subtest: x-tiled-64bpp-rotate-180 [170.509404] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.702s) [170.676229] [043/155] (847s left) gem_exec_schedule (u-submit-late-slice) [170.743619] Starting subtest: u-submit-late-slice [170.745824] Starting dynamic subtest: rcs0 [170.776959] Dynamic subtest rcs0: SUCCESS (0.038s) [170.785846] Starting dynamic subtest: bcs0 [170.816554] Dynamic subtest bcs0: SUCCESS (0.039s) [170.825883] Starting dynamic subtest: vcs0 [170.853308] Dynamic subtest vcs0: SUCCESS (0.036s) [170.862346] Starting dynamic subtest: vcs1 [170.882324] Dynamic subtest vcs1: SUCCESS (0.028s) [170.891354] Starting dynamic subtest: vecs0 [170.915072] Dynamic subtest vecs0: SUCCESS (0.032s) [170.927106] Starting dynamic subtest: ccs0 [170.950304] Dynamic subtest ccs0: SUCCESS (0.035s) [170.952226] Subtest u-submit-late-slice: SUCCESS (0.212s) [172.360138] [044/155] (846s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt) [172.462718] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt [172.467438] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [172.557359] [045/155] (845s left) kms_big_fb (y-tiled-16bpp-rotate-270) [172.653925] Starting subtest: y-tiled-16bpp-rotate-270 [172.658501] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [172.751141] [046/155] (845s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [172.839094] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [172.843173] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [172.913992] [047/155] (845s left) sw_sync (alloc_merge_fence) [172.950309] Starting subtest: alloc_merge_fence [172.952338] Subtest alloc_merge_fence: SUCCESS (0.000s) [173.023266] [048/155] (845s left) kms_addfb_basic (bad-pitch-63) [173.076799] Starting subtest: bad-pitch-63 [173.078700] Subtest bad-pitch-63: SUCCESS (0.000s) [173.217604] [049/155] (845s left) kms_addfb_basic (bo-too-small) [173.309317] Starting subtest: bo-too-small [173.311495] Subtest bo-too-small: SUCCESS (0.000s) [173.397855] [050/155] (845s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt) [173.496564] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt [173.499922] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [173.590476] [051/155] (845s left) gem_gpgpu_fill (basic) [173.642218] Starting subtest: basic [173.644210] Starting dynamic subtest: smem [173.648505] Dynamic subtest smem: SUCCESS (0.007s) [173.650543] Subtest basic: SUCCESS (0.008s) [173.792642] [052/155] (844s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [173.892190] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [173.895789] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [173.990726] [053/155] (844s left) gem_pwrite (basic-self) [174.043663] Subtest basic-self: SKIP (0.000s) [174.107735] [054/155] (844s left) gem_exec_reloc (basic-cpu-wc) [174.166853] Subtest basic-cpu-wc: SKIP (0.000s) [174.242017] [055/155] (844s left) gem_exec_schedule (semaphore-noskip) [174.318461] Starting subtest: semaphore-noskip [174.747621] Subtest semaphore-noskip: SUCCESS (0.433s) [175.076762] [056/155] (843s left) gem_mmap_gtt (zero-extend) [175.136614] Subtest zero-extend: SKIP (0.000s) [175.202713] [057/155] (843s left) kms_plane (plane-position-hole-dpms) [175.297229] Starting subtest: plane-position-hole-dpms [175.808109] Starting dynamic subtest: pipe-A-plane-1 [178.211630] Dynamic subtest pipe-A-plane-1: SUCCESS (2.401s) [178.221085] Starting dynamic subtest: pipe-A-plane-2 [180.645676] Dynamic subtest pipe-A-plane-2: SUCCESS (2.434s) [180.655917] Starting dynamic subtest: pipe-A-plane-3 [183.056623] Dynamic subtest pipe-A-plane-3: SUCCESS (2.411s) [183.066792] Starting dynamic subtest: pipe-A-plane-4 [185.509856] Dynamic subtest pipe-A-plane-4: SUCCESS (2.451s) [185.520188] Starting dynamic subtest: pipe-A-plane-5 [185.534963] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [186.774055] Starting dynamic subtest: pipe-B-plane-1 [189.217756] Dynamic subtest pipe-B-plane-1: SUCCESS (2.453s) [189.227998] Starting dynamic subtest: pipe-B-plane-2 [191.645100] Dynamic subtest pipe-B-plane-2: SUCCESS (2.425s) [191.657273] Starting dynamic subtest: pipe-B-plane-3 [194.003291] Dynamic subtest pipe-B-plane-3: SUCCESS (2.358s) [194.012374] Starting dynamic subtest: pipe-B-plane-4 [196.361684] Dynamic subtest pipe-B-plane-4: SUCCESS (2.360s) [196.372722] Starting dynamic subtest: pipe-B-plane-5 [196.389677] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [196.391985] Subtest plane-position-hole-dpms: SUCCESS (21.092s) [197.172618] [058/155] (821s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [197.281987] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [197.286375] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [197.383086] [059/155] (821s left) gem_exec_reloc (basic-range) [197.443284] Subtest basic-range: SKIP (0.000s) [197.521982] [060/155] (821s left) gen9_exec_parse (shadow-peek) [197.579260] Subtest shadow-peek: SKIP (0.000s) [197.655602] [061/155] (821s left) i915_pm_rc6_residency (rc6-accuracy) [197.715462] Starting subtest: rc6-accuracy [197.717337] Starting dynamic subtest: gt0 [200.888269] Dynamic subtest gt0: SUCCESS (3.168s) [200.899692] Starting dynamic subtest: gt1 [204.111524] Dynamic subtest gt1: SUCCESS (3.169s) [204.114053] Subtest rc6-accuracy: SUCCESS (6.341s) [204.155030] [062/155] (815s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [204.542445] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [205.380636] [063/155] (813s left) gem_exec_balancer (parallel-keep-in-fence) [205.646898] Starting subtest: parallel-keep-in-fence [206.890302] Subtest parallel-keep-in-fence: SUCCESS (1.244s) [206.994669] [064/155] (812s left) sriov_basic (enable-vfs-bind-unbind-each) [207.039457] Starting subtest: enable-vfs-bind-unbind-each [207.041880] Starting dynamic subtest: numvfs-1 [207.046560] Dynamic subtest numvfs-1: SKIP (0.001s) [207.057658] Starting dynamic subtest: numvfs-2 [207.061808] Dynamic subtest numvfs-2: SKIP (0.001s) [207.070795] Starting dynamic subtest: numvfs-3 [207.075264] Dynamic subtest numvfs-3: SKIP (0.001s) [207.084637] Starting dynamic subtest: numvfs-4 [207.088688] Dynamic subtest numvfs-4: SKIP (0.001s) [207.097616] Starting dynamic subtest: numvfs-5 [207.101731] Dynamic subtest numvfs-5: SKIP (0.001s) [207.110551] Starting dynamic subtest: numvfs-6 [207.114625] Dynamic subtest numvfs-6: SKIP (0.001s) [207.123094] Starting dynamic subtest: numvfs-7 [207.127193] Dynamic subtest numvfs-7: SKIP (0.001s) [207.135953] Starting dynamic subtest: numvfs-random [207.140124] Dynamic subtest numvfs-random: SKIP (0.001s) [207.144298] Subtest enable-vfs-bind-unbind-each: SKIP (0.009s) [207.182161] [065/155] (812s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [207.231250] Starting subtest: multi-wait-available-unsubmitted-signaled [207.233578] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [207.316614] [066/155] (812s left) core_setmaster (master-drop-set-shared-fd) [207.397984] Starting subtest: master-drop-set-shared-fd [207.420146] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [207.462821] [067/155] (811s left) kms_joiner (basic-max-non-joiner) [207.568240] Starting subtest: basic-max-non-joiner [207.572258] Subtest basic-max-non-joiner: SKIP (0.000s) [207.636304] [068/155] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [207.736843] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [208.867358] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.531s) [208.909239] [069/155] (810s left) gem_spin_batch (engines) [208.972879] Starting subtest: engines [208.975087] Starting dynamic subtest: rcs0 [212.212758] Dynamic subtest rcs0: SUCCESS (3.234s) [212.224555] Starting dynamic subtest: bcs0 [215.505330] Dynamic subtest bcs0: SUCCESS (3.237s) [215.517267] Starting dynamic subtest: vcs0 [218.741741] Dynamic subtest vcs0: SUCCESS (3.236s) [218.753634] Starting dynamic subtest: vcs1 [221.978968] Dynamic subtest vcs1: SUCCESS (3.234s) [221.991587] Starting dynamic subtest: vecs0 [225.214039] Dynamic subtest vecs0: SUCCESS (3.234s) [225.225665] Starting dynamic subtest: ccs0 [228.454895] Dynamic subtest ccs0: SUCCESS (3.237s) [228.457301] Subtest engines: SUCCESS (19.427s) [228.630489] [070/155] (790s left) gem_exec_balancer (full) [228.690035] Starting subtest: full [233.165865] Subtest full: SUCCESS (4.478s) [233.492318] [071/155] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [233.593975] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [241.058255] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.470s) [241.206746] [072/155] (778s left) syncobj_wait (invalid-reset-illegal-handle) [241.257821] Starting subtest: invalid-reset-illegal-handle [241.259953] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [241.347695] [073/155] (778s left) kms_psr (fbc-pr-primary-page-flip) [241.440368] Starting subtest: fbc-pr-primary-page-flip [241.444454] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [241.511020] [074/155] (778s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte) [241.612571] Starting subtest: fbcpsrhdr-1p-rte [241.616974] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s) [241.718716] [075/155] (778s left) perf_pmu (busy-idle-no-semaphores) [241.762409] Starting subtest: busy-idle-no-semaphores [241.764723] Starting dynamic subtest: rcs0 [242.437440] Dynamic subtest rcs0: SUCCESS (0.673s) [242.450267] Starting dynamic subtest: bcs0 [243.089643] Dynamic subtest bcs0: SUCCESS (0.650s) [243.101321] Starting dynamic subtest: vcs0 [243.742818] Dynamic subtest vcs0: SUCCESS (0.651s) [243.753249] Starting dynamic subtest: vcs1 [244.899418] Dynamic subtest vcs1: SUCCESS (1.154s) [244.912328] Starting dynamic subtest: vecs0 [246.883540] Dynamic subtest vecs0: SUCCESS (1.981s) [246.896311] Starting dynamic subtest: ccs0 [248.932902] Dynamic subtest ccs0: SUCCESS (2.046s) [248.936040] Subtest busy-idle-no-semaphores: SUCCESS (7.170s) [249.070388] [076/155] (770s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [249.177312] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [249.181385] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [249.272866] [077/155] (770s left) kms_feature_discovery (display) [249.365245] Starting subtest: display [249.367553] Subtest display: SUCCESS (0.000s) [249.444504] [078/155] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [249.547115] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [249.551551] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [249.662753] [079/155] (770s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render) [249.778818] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render [256.776931] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.001s) [256.931646] [080/155] (763s left) kms_chamelium_edid (dp-edid-resolution-list) [257.324339] Subtest dp-edid-resolution-list: SKIP (0.000s) [258.160173] [081/155] (761s left) kms_flip (2x-flip-vs-dpms) [258.257070] Starting subtest: 2x-flip-vs-dpms [258.266892] Subtest 2x-flip-vs-dpms: SKIP (0.011s) [258.345650] [082/155] (761s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [258.441028] Starting subtest: fbc-rgb565-draw-mmap-cpu [262.502857] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.066s) [263.686499] [083/155] (756s left) kms_flip (2x-flip-vs-rmfb) [263.786331] Starting subtest: 2x-flip-vs-rmfb [263.797651] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [263.893058] [084/155] (756s left) gem_exec_gttfill (engines) [263.956626] Starting subtest: engines [263.958589] Starting dynamic subtest: rcs0 [286.980503] Dynamic subtest rcs0: SUCCESS (23.025s) [286.990679] Starting dynamic subtest: bcs0 [310.307858] Dynamic subtest bcs0: SUCCESS (23.326s) [310.318572] Starting dynamic subtest: vcs0 [333.700465] Dynamic subtest vcs0: SUCCESS (23.389s) [333.713947] Starting dynamic subtest: vcs1 [357.034967] Dynamic subtest vcs1: SUCCESS (23.333s) [357.045894] Starting dynamic subtest: vecs0 [380.399765] Dynamic subtest vecs0: SUCCESS (23.362s) [380.413561] Starting dynamic subtest: ccs0 [403.793843] Dynamic subtest ccs0: SUCCESS (23.391s) [403.796695] Subtest engines: SUCCESS (139.834s) [403.987304] [085/155] (616s left) gem_ctx_persistence (heartbeat-stop) [404.105162] Starting subtest: heartbeat-stop [404.109810] Subtest heartbeat-stop: SKIP (0.000s) [404.219878] [086/155] (616s left) kms_vrr (flipline) [404.322876] Starting subtest: flipline [404.329819] Subtest flipline: SKIP (0.000s) [404.396295] [087/155] (615s left) syncobj_wait (invalid-reset-zero-handles) [404.474641] Starting subtest: invalid-reset-zero-handles [404.477091] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [404.591211] [088/155] (615s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [404.681082] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [404.683296] Starting dynamic subtest: pipe-A-eDP-1 [404.703697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [404.715531] Starting dynamic subtest: pipe-B-eDP-1 [404.735247] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [404.745477] Starting dynamic subtest: pipe-C-eDP-1 [404.765096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [404.775056] Starting dynamic subtest: pipe-D-eDP-1 [404.794605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [404.796546] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [406.940531] [089/155] (613s left) kms_cursor_crc (cursor-sliding-128x42) [407.172191] Starting subtest: cursor-sliding-128x42 [407.225824] Subtest cursor-sliding-128x42: SKIP (0.048s) [407.439283] [090/155] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [407.552811] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [407.556844] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [407.650432] [091/155] (612s left) kms_hdr (invalid-hdr) [407.757458] Starting subtest: invalid-hdr [407.759704] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [412.948952] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.188s) [412.969107] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [417.059506] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.095s) [417.072125] Subtest invalid-hdr: SUCCESS (9.316s) [417.202913] [092/155] (603s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render) [417.309283] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render [417.313681] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [417.411556] [093/155] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [417.513866] Starting subtest: psr-2p-scndscrn-spr-indfb-move [417.517791] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [417.607787] [094/155] (602s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen) [417.712619] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen [417.716730] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [417.796019] [095/155] (602s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite) [417.893196] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite [417.897152] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [417.991039] [096/155] (602s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [418.078515] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [418.082334] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [418.164981] [097/155] (602s left) sysfs_defaults (readonly) [418.230320] Starting subtest: readonly [418.232380] Starting dynamic subtest: vecs0 [418.234434] Dynamic subtest vecs0: SUCCESS (0.000s) [418.246327] Starting dynamic subtest: ccs0 [418.247911] Dynamic subtest ccs0: SUCCESS (0.000s) [418.257723] Starting dynamic subtest: vcs0 [418.259791] Dynamic subtest vcs0: SUCCESS (0.000s) [418.269262] Starting dynamic subtest: bcs0 [418.270879] Dynamic subtest bcs0: SUCCESS (0.000s) [418.280143] Starting dynamic subtest: rcs0 [418.281792] Dynamic subtest rcs0: SUCCESS (0.000s) [418.291447] Starting dynamic subtest: vcs1 [418.293319] Dynamic subtest vcs1: SUCCESS (0.000s) [418.295264] Subtest readonly: SUCCESS (0.006s) [418.343886] [098/155] (602s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [418.449041] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [418.452451] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [418.543883] [099/155] (602s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move) [418.646009] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move [418.653335] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [418.770111] [100/155] (602s left) syncobj_wait (invalid-multi-wait-unsubmitted) [418.827199] Starting subtest: invalid-multi-wait-unsubmitted [418.829028] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [418.921131] [101/155] (601s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [419.004505] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [419.007900] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [419.090821] [102/155] (601s left) kms_content_protection (dp-mst-type-0) [419.239565] Starting subtest: dp-mst-type-0 [419.243460] Subtest dp-mst-type-0: SKIP (0.000s) [419.378627] [103/155] (601s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [419.489588] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [419.492976] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [419.559120] [104/155] (601s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [419.652944] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [419.656363] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [419.750514] [105/155] (601s left) kms_pm_backlight (fade-with-suspend) [419.854607] Starting subtest: fade-with-suspend [436.854435] Starting dynamic subtest: eDP-1 [439.904990] Dynamic subtest eDP-1: SUCCESS (2.959s) [439.907696] Subtest fade-with-suspend: SUCCESS (5.346s) [440.794108] [106/155] (580s left) syncobj_timeline (device-signal-unordered) [440.859709] Starting subtest: device-signal-unordered [440.862107] Subtest device-signal-unordered: SUCCESS (0.001s) [440.956041] [107/155] (580s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [441.083884] Starting subtest: 2x-flip-vs-cursor-atomic [441.088475] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [441.230721] [108/155] (579s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [441.349817] Starting subtest: fbcpsr-modesetfrombusy [447.688085] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.232s) [447.843842] [109/155] (573s left) kms_cursor_crc (cursor-onscreen-64x64) [448.024875] Starting subtest: cursor-onscreen-64x64 [448.028926] Starting dynamic subtest: pipe-A-eDP-1 [450.171776] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s) [450.204728] Starting dynamic subtest: pipe-D-eDP-1 [453.031779] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.815s) [453.034200] Subtest cursor-onscreen-64x64: SUCCESS (4.964s) [453.908866] [110/155] (567s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [454.016650] Starting subtest: fbc-rgb101010-draw-render [456.732620] Subtest fbc-rgb101010-draw-render: SUCCESS (2.708s) [457.930151] [111/155] (563s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [458.023156] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [458.025485] Starting dynamic subtest: pipe-A-eDP-1 [458.049129] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [458.061743] Starting dynamic subtest: pipe-B-eDP-1 [458.083962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [458.095350] Starting dynamic subtest: pipe-C-eDP-1 [458.118360] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [458.131663] Starting dynamic subtest: pipe-D-eDP-1 [458.154820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [458.159134] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s) [460.296727] [112/155] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [460.395419] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [467.523886] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.122s) [467.653577] [113/155] (553s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [467.753382] Starting subtest: blocking-absolute-wf_vblank-interruptible [467.755691] Starting dynamic subtest: A-eDP1 [476.539564] Dynamic subtest A-eDP1: SUCCESS (8.745s) [476.556230] Starting dynamic subtest: B-eDP1 [485.274655] Dynamic subtest B-eDP1: SUCCESS (8.731s) [485.289136] Starting dynamic subtest: C-eDP1 [494.023633] Dynamic subtest C-eDP1: SUCCESS (8.730s) [494.035049] Starting dynamic subtest: D-eDP1 [502.750329] Dynamic subtest D-eDP1: SUCCESS (8.717s) [502.752924] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.937s) [503.942394] [114/155] (517s left) kms_psr (psr-sprite-plane-move) [504.036623] Starting subtest: psr-sprite-plane-move [504.038991] Starting dynamic subtest: eDP-1 [505.839596] Dynamic subtest eDP-1: SUCCESS (1.803s) [505.842037] Subtest psr-sprite-plane-move: SUCCESS (1.804s) [506.681035] [115/155] (514s left) gem_exec_reloc (basic-write-gtt-noreloc) [506.737076] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [506.817596] [116/155] (514s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [506.929672] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [506.934122] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [507.046316] [117/155] (514s left) kms_atomic (plane-immutable-zpos) [507.139728] Starting subtest: plane-immutable-zpos [507.142056] Starting dynamic subtest: pipe-A-eDP-1 [507.784514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s) [507.786839] Subtest plane-immutable-zpos: SUCCESS (0.647s) [508.610431] [118/155] (513s left) kms_cursor_edge_walk (128x128-top-bottom) [508.708131] Starting subtest: 128x128-top-bottom [508.710501] Starting dynamic subtest: pipe-A-eDP-1 [512.177984] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s) [512.190115] Starting dynamic subtest: pipe-D-eDP-1 [515.384155] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.203s) [515.386394] Subtest 128x128-top-bottom: SUCCESS (6.675s) [516.194653] [119/155] (505s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [516.314417] Starting subtest: hdr-rgb565-draw-mmap-cpu [516.318552] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [516.405652] [120/155] (505s left) kms_pm_rpm (dpms-lpsp) [518.043360] Starting subtest: dpms-lpsp [518.594846] Subtest dpms-lpsp: SUCCESS (0.552s) [518.717216] [121/155] (503s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [518.831630] Starting subtest: cursorA-vs-flipA-varying-size [529.972647] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s) [530.788277] [122/155] (491s left) gem_tiled_wb [530.908902] [123/155] (490s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [531.007490] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [531.011699] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [531.097087] [124/155] (490s left) kms_flip (dpms-off-confusion) [531.200036] Starting subtest: dpms-off-confusion [531.201890] Starting dynamic subtest: A-eDP1 [539.931865] Dynamic subtest A-eDP1: SUCCESS (8.702s) [539.946751] Starting dynamic subtest: B-eDP1 [548.660891] Dynamic subtest B-eDP1: SUCCESS (8.729s) [548.673860] Starting dynamic subtest: C-eDP1 [557.392960] Dynamic subtest C-eDP1: SUCCESS (8.719s) [557.405318] Starting dynamic subtest: D-eDP1 [566.114063] Dynamic subtest D-eDP1: SUCCESS (8.716s) [566.117634] Subtest dpms-off-confusion: SUCCESS (34.881s) [567.237318] [125/155] (454s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [567.332242] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [567.334160] Starting dynamic subtest: pipe-A-eDP-1 [567.354352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [567.367287] Starting dynamic subtest: pipe-B-eDP-1 [567.387571] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [567.400968] Starting dynamic subtest: pipe-C-eDP-1 [567.420014] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [567.431485] Starting dynamic subtest: pipe-D-eDP-1 [567.451572] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [567.453548] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s) [569.707094] [126/155] (452s left) i915_hangman (hangcheck-unterminated) [569.783713] Starting subtest: hangcheck-unterminated [580.843589] Subtest hangcheck-unterminated: SUCCESS (11.059s) [580.967989] [127/155] (441s left) gem_flink_basic (double-flink) [581.023838] Starting subtest: double-flink [581.026138] Subtest double-flink: SUCCESS (0.000s) [581.128029] [128/155] (440s left) gem_ctx_shared (q-out-order) [581.190593] Starting subtest: Q-out-order [581.193012] Starting dynamic subtest: rcs0 [581.353960] Dynamic subtest rcs0: SUCCESS (0.162s) [581.370060] Starting dynamic subtest: vcs0 [581.482235] Dynamic subtest vcs0: SUCCESS (0.126s) [581.504444] Starting dynamic subtest: vcs1 [581.594618] Dynamic subtest vcs1: SUCCESS (0.111s) [581.613383] Starting dynamic subtest: vecs0 [581.709555] Dynamic subtest vecs0: SUCCESS (0.114s) [581.731303] Starting dynamic subtest: ccs0 [581.841062] Dynamic subtest ccs0: SUCCESS (0.130s) [581.843568] Subtest Q-out-order: SUCCESS (0.650s) [583.024510] [129/155] (439s left) i915_drm_fdinfo (virtual-busy-hang) [583.060421] Starting subtest: virtual-busy-hang [583.065201] Subtest virtual-busy-hang: SKIP (0.000s) [583.128425] [130/155] (439s left) kms_chamelium_color (ctm-negative) [583.227031] Subtest ctm-negative: SKIP (0.000s) [583.274339] [131/155] (438s left) prime_mmap (test_aperture_limit) [583.328146] Starting subtest: test_aperture_limit [583.330002] Starting dynamic subtest: test_aperture_limit-smem [583.340358] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s) [583.344857] Subtest test_aperture_limit: SKIP (0.011s) [583.428260] [132/155] (438s left) gem_softpin (allocator-basic) [583.490216] Starting subtest: allocator-basic [583.562034] Subtest allocator-basic: SUCCESS (0.071s) [583.671158] [133/155] (438s left) perf_pmu (init-sema) [583.712079] Starting subtest: init-sema [583.714273] Starting dynamic subtest: rcs0 [583.716582] Dynamic subtest rcs0: SUCCESS (0.001s) [583.729227] Starting dynamic subtest: bcs0 [583.731089] Dynamic subtest bcs0: SUCCESS (0.000s) [583.741825] Starting dynamic subtest: vcs0 [583.743750] Dynamic subtest vcs0: SUCCESS (0.001s) [583.754612] Starting dynamic subtest: vcs1 [583.756546] Dynamic subtest vcs1: SUCCESS (0.001s) [583.767299] Starting dynamic subtest: vecs0 [583.769239] Dynamic subtest vecs0: SUCCESS (0.001s) [583.780510] Starting dynamic subtest: ccs0 [583.782736] Dynamic subtest ccs0: SUCCESS (0.000s) [583.785152] Subtest init-sema: SUCCESS (0.009s) [583.836573] [134/155] (438s left) gem_userptr_blits (nohangcheck) [583.909052] Starting subtest: nohangcheck [584.169605] Subtest nohangcheck: SUCCESS (0.257s) [584.281141] [135/155] (438s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [584.328634] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [584.429525] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [584.507178] [136/155] (437s left) i915_suspend (basic-s3-without-i915) [584.547959] Starting subtest: basic-s3-without-i915 [587.167569] Subtest basic-s3-without-i915: SKIP (2.619s) [588.835685] [137/155] (433s left) kms_async_flips (async-flip-hang) [588.932830] Starting subtest: async-flip-hang [589.314980] Starting dynamic subtest: pipe-A-eDP-1 [604.400826] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.083s) [604.785545] Starting dynamic subtest: pipe-B-eDP-1 [620.398129] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.613s) [620.796078] Starting dynamic subtest: pipe-C-eDP-1 [636.400117] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.596s) [636.772236] Starting dynamic subtest: pipe-D-eDP-1 [652.389260] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.621s) [652.391854] Subtest async-flip-hang: SUCCESS (63.436s) [653.572393] [138/155] (368s left) kms_plane_cursor (overlay) [653.686839] Starting subtest: overlay [653.691131] Starting dynamic subtest: pipe-A-eDP-1-size-64 [656.363345] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.677s) [656.424835] Starting dynamic subtest: pipe-A-eDP-1-size-128 [659.109393] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.693s) [659.171966] Starting dynamic subtest: pipe-A-eDP-1-size-256 [661.832967] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.671s) [662.183987] Starting dynamic subtest: pipe-B-eDP-1-size-64 [665.501990] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.333s) [665.563117] Starting dynamic subtest: pipe-B-eDP-1-size-128 [668.259972] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.705s) [668.319838] Starting dynamic subtest: pipe-B-eDP-1-size-256 [671.014934] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.705s) [671.378429] Starting dynamic subtest: pipe-C-eDP-1-size-64 [674.461123] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.097s) [674.501203] Starting dynamic subtest: pipe-C-eDP-1-size-128 [676.827240] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.336s) [676.868526] Starting dynamic subtest: pipe-C-eDP-1-size-256 [679.216050] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.358s) [679.558660] Starting dynamic subtest: pipe-D-eDP-1-size-64 [682.595252] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.050s) [682.636084] Starting dynamic subtest: pipe-D-eDP-1-size-128 [684.995964] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.370s) [685.034728] Starting dynamic subtest: pipe-D-eDP-1-size-256 [687.383388] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.358s) [687.705343] Subtest overlay: SUCCESS (34.023s) [688.595797] [139/155] (333s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt) [688.702523] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt [688.706554] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [688.811357] [140/155] (333s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [688.913391] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [688.917518] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [689.008240] [141/155] (333s left) gem_tiled_fence_blits (basic) [689.066212] Subtest basic: SKIP (0.000s) [689.142627] [142/155] (333s left) gem_exec_flush (basic-uc-set-default) [689.211243] Starting subtest: basic-uc-set-default [694.696387] Subtest basic-uc-set-default: SUCCESS (5.459s) [694.875103] [143/155] (327s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [694.980853] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [694.985116] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [695.084952] [144/155] (327s left) kms_setmode (invalid-clone-exclusive-crtc) [695.135076] Starting subtest: invalid-clone-exclusive-crtc [695.141366] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [695.229238] [145/155] (327s left) perf (create-destroy-userspace-config) [695.380824] Starting subtest: create-destroy-userspace-config [695.403471] Subtest create-destroy-userspace-config: SUCCESS (0.021s) [695.452360] [146/155] (327s left) gem_exec_reloc (basic-cpu-active) [695.524569] Subtest basic-cpu-active: SKIP (0.000s) [695.600898] [147/155] (327s left) prime_vgem (basic-fence-mmap) [695.657934] Starting subtest: basic-fence-mmap [695.661847] Subtest basic-fence-mmap: SKIP (0.000s) [695.755994] [148/155] (327s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [695.865541] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [695.869620] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [695.967604] [149/155] (327s left) gem_exec_schedule (preempt-queue-chain) [696.051258] Subtest preempt-queue-chain: SKIP (0.000s) [696.342044] [150/155] (326s left) kms_psr (pr-suspend) [696.430139] Starting subtest: pr-suspend [696.434117] Subtest pr-suspend: SKIP (0.000s) [696.511610] [151/155] (326s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [696.617411] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt [696.621500] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [696.720451] [152/155] (326s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [696.818211] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [696.822379] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [696.929167] [153/155] (326s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [697.023806] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [697.028081] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [697.138492] [154/155] (326s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [697.271393] Starting subtest: cursorB-vs-flipA-varying-size [697.276075] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [697.416186] [155/155] (325s left) drm_read (short-buffer-nonblock) [697.577744] Starting subtest: short-buffer-nonblock [697.580110] Subtest short-buffer-nonblock: SUCCESS (0.000s) [697.704290] Closing watchdogs results: parsing output: 0/ for test: api_intel_bb results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: perf results: parsing output: 5/ for test: syncobj_wait results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_create results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_vblank results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_lmem_swapping results: parsing output: 14/ for test: api_intel_bb results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_ccs results: parsing output: 18/ for test: kms_lease results: parsing output: 19/ for test: gem_ctx_isolation results: parsing output: 20/ for test: gem_pxp results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_rmfb results: parsing output: 26/ for test: kms_color results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: prime_udl results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: gem_caching results: parsing output: 39/ for test: kms_atomic_transition results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: gem_exec_schedule results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_flip_scaled_crc results: parsing output: 46/ for test: sw_sync results: parsing output: 47/ for test: kms_addfb_basic results: parsing output: 48/ for test: kms_addfb_basic results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_gpgpu_fill results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_pwrite results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: gem_exec_schedule results: parsing output: 55/ for test: gem_mmap_gtt results: parsing output: 56/ for test: kms_plane results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_exec_reloc results: parsing output: 59/ for test: gen9_exec_parse results: parsing output: 60/ for test: i915_pm_rc6_residency results: parsing output: 61/ for test: kms_chamelium_hpd results: parsing output: 62/ for test: gem_exec_balancer results: parsing output: 63/ for test: sriov_basic results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: core_setmaster results: parsing output: 66/ for test: kms_joiner results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_spin_batch results: parsing output: 69/ for test: gem_exec_balancer results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: perf_pmu results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_feature_discovery results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_chamelium_edid results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: gem_exec_gttfill results: parsing output: 84/ for test: gem_ctx_persistence results: parsing output: 85/ for test: kms_vrr results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: kms_ccs results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_hdr results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: sysfs_defaults results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: kms_content_protection results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_pm_backlight results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_cursor_crc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_atomic results: parsing output: 117/ for test: kms_cursor_edge_walk results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_pm_rpm results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: gem_tiled_wb results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: i915_hangman results: parsing output: 126/ for test: gem_flink_basic results: parsing output: 127/ for test: gem_ctx_shared results: parsing output: 128/ for test: i915_drm_fdinfo results: parsing output: 129/ for test: kms_chamelium_color results: parsing output: 130/ for test: prime_mmap results: parsing output: 131/ for test: gem_softpin results: parsing output: 132/ for test: perf_pmu results: parsing output: 133/ for test: gem_userptr_blits results: parsing output: 134/ for test: syncobj_wait results: parsing output: 135/ for test: i915_suspend results: parsing output: 136/ for test: kms_async_flips results: parsing output: 137/ for test: kms_plane_cursor results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: gem_tiled_fence_blits results: parsing output: 141/ for test: gem_exec_flush results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_setmode results: parsing output: 144/ for test: perf results: parsing output: 145/ for test: gem_exec_reloc results: parsing output: 146/ for test: prime_vgem results: parsing output: 147/ for test: kms_big_fb results: parsing output: 148/ for test: gem_exec_schedule results: parsing output: 149/ for test: kms_psr results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_cursor_legacy results: parsing output: 154/ for test: drm_read Done.