[58.271785] Initializing watchdogs [58.271850] /dev/watchdog0 [58.287903] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [58.293537] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.296010] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.298335] [001/156] (960s left) syncobj_timeline (wait-zero-handles) [58.336246] Starting subtest: wait-zero-handles [58.337379] Subtest wait-zero-handles: SUCCESS (0.000s) [58.440197] [002/156] (960s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [58.532578] Starting subtest: cursorB-vs-flipB-legacy [58.534041] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [58.629567] [003/156] (960s left) gem_shrink (reclaim) [58.669879] Starting subtest: reclaim [60.942299] Subtest reclaim: SUCCESS (2.249s) [61.097580] [004/156] (957s left) gem_mmap_offset (perf) [61.141086] Starting subtest: perf [61.141785] Starting dynamic subtest: smem0 [61.343794] Dynamic subtest smem0: SUCCESS (0.202s) [61.344558] Subtest perf: SUCCESS (0.202s) [61.464624] [005/156] (957s left) gem_ctx_persistence (heartbeat-hang) [61.502124] Starting subtest: heartbeat-hang [62.993517] Subtest heartbeat-hang: SUCCESS (1.484s) [63.092806] [006/156] (955s left) gem_exec_whisper (basic-queues) [63.136337] Starting subtest: basic-queues [64.912341] Subtest basic-queues: SUCCESS (1.769s) [65.156386] [007/156] (953s left) gem_ctx_shared (q-promotion) [65.200657] Starting subtest: Q-promotion [65.201406] Starting dynamic subtest: rcs0 [65.277156] Dynamic subtest rcs0: SUCCESS (0.076s) [65.287902] Starting dynamic subtest: bcs0 [65.330482] Dynamic subtest bcs0: SUCCESS (0.053s) [65.342878] Starting dynamic subtest: vcs0 [65.385494] Dynamic subtest vcs0: SUCCESS (0.054s) [65.397688] Starting dynamic subtest: vcs1 [65.437778] Dynamic subtest vcs1: SUCCESS (0.051s) [65.448936] Starting dynamic subtest: vecs0 [65.491320] Dynamic subtest vecs0: SUCCESS (0.053s) [65.492319] Subtest Q-promotion: SUCCESS (0.290s) [65.706721] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true [65.709435] [008/156] (953s left) syncobj_wait (multi-wait-signaled) [65.744510] Starting subtest: multi-wait-signaled [65.745280] Subtest multi-wait-signaled: SUCCESS (0.001s) [65.858542] [009/156] (953s left) gem_exec_balancer (bonded-pair) [65.901633] Starting subtest: bonded-pair [98.277830] Subtest bonded-pair: SUCCESS (32.344s) [98.480763] [010/156] (920s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [98.571416] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [98.572795] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [98.784732] [011/156] (920s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt) [98.878666] Starting subtest: psrhdr-rgb101010-draw-blt [98.880122] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s) [98.993061] [012/156] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [99.085108] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [99.086468] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [99.202872] [013/156] (920s left) gem_exec_reloc (basic-write-gtt-active) [99.241065] Starting subtest: basic-write-gtt-active [99.369661] Subtest basic-write-gtt-active: SUCCESS (0.120s) [99.525225] [014/156] (919s left) gem_userptr_blits (coherency-unsync) [99.564516] Subtest coherency-unsync: SKIP (0.000s) [99.733577] [015/156] (919s left) gem_exec_schedule (out-order) [99.779403] Starting subtest: out-order [99.780163] Starting dynamic subtest: rcs0 [99.839263] Dynamic subtest rcs0: SUCCESS (0.059s) [99.849706] Starting dynamic subtest: bcs0 [99.905698] Dynamic subtest bcs0: SUCCESS (0.066s) [99.916019] Starting dynamic subtest: vcs0 [99.969023] Dynamic subtest vcs0: SUCCESS (0.063s) [99.979996] Starting dynamic subtest: vcs1 [100.037441] Dynamic subtest vcs1: SUCCESS (0.068s) [100.047820] Starting dynamic subtest: vecs0 [100.101216] Dynamic subtest vecs0: SUCCESS (0.063s) [100.102160] Subtest out-order: SUCCESS (0.322s) [100.432648] [016/156] (919s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [100.567028] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [100.676636] [017/156] (918s left) kms_async_flips (test-time-stamp) [100.764568] Starting subtest: test-time-stamp [100.950533] Starting dynamic subtest: pipe-A-HDMI-A-1 [101.098361] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s) [101.305792] Starting dynamic subtest: pipe-B-HDMI-A-1 [101.429358] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.129s) [101.589100] Starting dynamic subtest: pipe-C-HDMI-A-1 [101.712144] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.130s) [101.904819] Starting dynamic subtest: pipe-D-HDMI-A-1 [102.037353] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.138s) [102.038308] Subtest test-time-stamp: SUCCESS (1.272s) [102.374650] [018/156] (917s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [102.469341] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [102.470730] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [102.582724] [019/156] (917s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [102.681947] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [104.034341] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.352s) [104.234613] [020/156] (915s left) gem_exec_params (secure-non-master) [104.272114] Starting subtest: secure-non-master [104.273517] Subtest secure-non-master: SKIP (0.000s) [104.386397] [021/156] (915s left) kms_dsc (dsc-fractional-bpp) [104.477239] Starting subtest: dsc-fractional-bpp [104.478698] Subtest dsc-fractional-bpp: SKIP (0.000s) [104.574295] [022/156] (915s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [104.665441] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [104.674831] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.009s) [104.785374] [023/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [104.876049] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [104.877378] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [104.993596] [024/156] (914s left) prime_mmap_coherency (ioctl-errors) [105.031073] Starting subtest: ioctl-errors [109.913171] Subtest ioctl-errors: SUCCESS (4.881s) [110.073517] [025/156] (909s left) kms_psr (fbc-psr-dpms) [110.225409] Subtest fbc-psr-dpms: SKIP (0.000s) [110.271055] [026/156] (909s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt) [110.363386] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt [110.364828] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [110.478248] [027/156] (909s left) kms_atomic_interruptible (universal-setplane-primary) [110.572221] Starting subtest: universal-setplane-primary [110.573745] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.811464] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.237s) [116.812179] Subtest universal-setplane-primary: SUCCESS (6.239s) [116.974350] [028/156] (903s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend) [117.069436] Starting subtest: fbcpsrhdr-suspend [117.070825] Subtest fbcpsrhdr-suspend: SKIP (0.000s) [117.182930] [029/156] (902s left) kms_cursor_crc (cursor-random-64x64) [117.279430] Starting subtest: cursor-random-64x64 [117.283707] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.509720] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.226s) [121.540287] Starting dynamic subtest: pipe-D-HDMI-A-1 [125.664738] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.132s) [125.665504] Subtest cursor-random-64x64: SUCCESS (8.385s) [125.871206] [030/156] (894s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [125.965161] Starting subtest: fbc-shrfb-scaledprimary [127.185256] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.220s) [127.385506] [031/156] (892s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [127.515508] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [127.625970] [032/156] (892s left) kms_properties (invalid-properties-atomic) [127.711450] Starting subtest: invalid-properties-atomic [128.249736] Subtest invalid-properties-atomic: SUCCESS (0.530s) [128.329903] [033/156] (891s left) gem_wait (write-wait) [128.375831] Starting subtest: write-wait [128.376532] Starting dynamic subtest: all-engines [129.412249] Dynamic subtest all-engines: SUCCESS (1.036s) [129.422966] Starting dynamic subtest: rcs0 [130.447297] Dynamic subtest rcs0: SUCCESS (1.034s) [130.460197] Starting dynamic subtest: bcs0 [131.479249] Dynamic subtest bcs0: SUCCESS (1.031s) [131.489938] Starting dynamic subtest: vcs0 [132.516306] Dynamic subtest vcs0: SUCCESS (1.036s) [132.528801] Starting dynamic subtest: vcs1 [133.549185] Dynamic subtest vcs1: SUCCESS (1.032s) [133.559201] Starting dynamic subtest: vecs0 [134.579236] Dynamic subtest vecs0: SUCCESS (1.030s) [134.580320] Subtest write-wait: SUCCESS (6.203s) [134.807601] [034/156] (885s left) gem_exec_balancer (persistence) [134.969944] Starting subtest: persistence [136.291963] Subtest persistence: SUCCESS (1.314s) [136.395795] [035/156] (883s left) kms_getfb (getfb-handle-zero) [136.485195] Starting subtest: getfb-handle-zero [136.485902] Subtest getfb-handle-zero: SUCCESS (0.000s) [136.607727] [036/156] (883s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt) [136.699085] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt [136.700439] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [136.835334] [037/156] (883s left) kms_psr (fbc-psr2-suspend) [136.922359] Subtest fbc-psr2-suspend: SKIP (0.000s) [136.969902] [038/156] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [137.062450] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [137.063913] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [137.176481] [039/156] (883s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [137.263839] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [137.264601] Starting dynamic subtest: pipe-A-valid-mode [138.188927] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.924s) [138.189703] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.925s) [138.366847] [040/156] (882s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [138.458280] Starting subtest: plane-lut1d-pre-ctm3x4 [138.651155] Starting dynamic subtest: pipe-A-plane-0 [138.841483] Dynamic subtest pipe-A-plane-0: SUCCESS (0.190s) [138.857384] Starting dynamic subtest: pipe-A-plane-1 [139.012026] Dynamic subtest pipe-A-plane-1: SUCCESS (0.170s) [139.027928] Starting dynamic subtest: pipe-A-plane-2 [139.182504] Dynamic subtest pipe-A-plane-2: SUCCESS (0.170s) [139.452907] Starting dynamic subtest: pipe-B-plane-0 [139.606439] Dynamic subtest pipe-B-plane-0: SUCCESS (0.170s) [139.622222] Starting dynamic subtest: pipe-B-plane-1 [139.776980] Dynamic subtest pipe-B-plane-1: SUCCESS (0.170s) [139.791626] Starting dynamic subtest: pipe-B-plane-2 [139.947770] Dynamic subtest pipe-B-plane-2: SUCCESS (0.170s) [140.232846] Starting dynamic subtest: pipe-C-plane-0 [140.393826] Dynamic subtest pipe-C-plane-0: SUCCESS (0.171s) [140.405010] Starting dynamic subtest: pipe-C-plane-1 [140.564201] Dynamic subtest pipe-C-plane-1: SUCCESS (0.170s) [140.578576] Starting dynamic subtest: pipe-C-plane-2 [140.734956] Dynamic subtest pipe-C-plane-2: SUCCESS (0.170s) [141.011597] Starting dynamic subtest: pipe-D-plane-0 [141.174749] Dynamic subtest pipe-D-plane-0: SUCCESS (0.171s) [141.187815] Starting dynamic subtest: pipe-D-plane-1 [141.345520] Dynamic subtest pipe-D-plane-1: SUCCESS (0.170s) [141.358117] Starting dynamic subtest: pipe-D-plane-2 [141.516494] Dynamic subtest pipe-D-plane-2: SUCCESS (0.170s) [141.563175] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.104s) [141.716581] [041/156] (878s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [141.818468] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [142.235613] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.417s) [142.437362] [042/156] (878s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [142.473517] Starting subtest: invalid-multi-wait-unsubmitted-submitted [142.474277] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [142.564775] [043/156] (878s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [142.657188] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [142.666972] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.009s) [142.797728] [044/156] (877s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [142.832058] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [142.833617] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [142.949703] [045/156] (877s left) kms_hdr (invalid-metadata-sizes) [143.037382] Starting subtest: invalid-metadata-sizes [143.038356] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010 [143.039696] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s) [143.047724] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F [143.049041] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s) [143.050383] Subtest invalid-metadata-sizes: SKIP (0.003s) [143.137973] [046/156] (877s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [143.571236] Starting subtest: syncobj-backward-timeline-chain-engines [143.636283] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.071s) [143.840229] [047/156] (876s left) gem_mmap_wc (read) [143.874184] Starting subtest: read [143.882091] Subtest read: SUCCESS (0.009s) [144.011757] [048/156] (876s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [144.099913] Starting subtest: nonblocking-crc-frame-sequence [144.100693] Starting dynamic subtest: pipe-A-HDMI-A-1 [144.765305] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.665s) [144.774735] Starting dynamic subtest: pipe-B-HDMI-A-1 [145.358842] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.592s) [145.368186] Starting dynamic subtest: pipe-C-HDMI-A-1 [145.950816] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.589s) [145.959759] Starting dynamic subtest: pipe-D-HDMI-A-1 [146.516577] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.564s) [146.517302] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.417s) [146.684804] [049/156] (874s left) gem_madvise (dontneed-before-exec) [146.719470] Starting subtest: dontneed-before-exec [146.722789] Subtest dontneed-before-exec: SUCCESS (0.003s) [146.860553] [050/156] (874s left) kms_psr (psr2-sprite-plane-move) [146.949365] Subtest psr2-sprite-plane-move: SKIP (0.000s) [146.993640] [051/156] (873s left) kms_scaling_modes (scaling-mode-full-aspect) [147.080751] Starting subtest: scaling-mode-full-aspect [147.084767] Subtest scaling-mode-full-aspect: SKIP (0.001s) [147.222224] [052/156] (873s left) gem_ctx_persistence (engines-hostile) [147.263792] Starting subtest: engines-hostile [147.264705] Starting dynamic subtest: rcs0 [147.354541] Dynamic subtest rcs0: SUCCESS (0.091s) [147.370748] Starting dynamic subtest: bcs0 [147.455508] Dynamic subtest bcs0: SUCCESS (0.100s) [147.472643] Starting dynamic subtest: vcs0 [147.547594] Dynamic subtest vcs0: SUCCESS (0.091s) [147.564388] Starting dynamic subtest: vcs1 [147.646516] Dynamic subtest vcs1: SUCCESS (0.098s) [147.664045] Starting dynamic subtest: vecs0 [147.748578] Dynamic subtest vecs0: SUCCESS (0.101s) [147.749659] Subtest engines-hostile: SUCCESS (0.486s) [147.846673] [053/156] (873s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [147.937475] Starting subtest: fbchdr-modesetfrombusy [147.938933] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [148.074835] [054/156] (873s left) fbdev (unaligned-read) [148.121746] Starting subtest: unaligned-read [148.130602] Subtest unaligned-read: SUCCESS (0.009s) [148.202969] [055/156] (872s left) gem_exec_params (sol-reset-not-gen7) [148.248245] Starting subtest: sol-reset-not-gen7 [148.249146] Subtest sol-reset-not-gen7: SUCCESS (0.001s) [148.377833] [056/156] (872s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [148.469486] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [148.470879] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [148.607312] [057/156] (872s left) api_intel_bb (render) [148.640486] Starting subtest: render [148.641270] Starting dynamic subtest: render-none-512 [148.730690] Dynamic subtest render-none-512: SUCCESS (0.090s) [148.738790] Starting dynamic subtest: render-none-1024 [149.096463] Dynamic subtest render-none-1024: SUCCESS (0.357s) [149.104852] Starting dynamic subtest: render-x-512 [149.165809] Dynamic subtest render-x-512: SUCCESS (0.078s) [149.173840] Starting dynamic subtest: render-x-1024 [149.499537] Dynamic subtest render-x-1024: SUCCESS (0.325s) [149.507991] Starting dynamic subtest: render-y-512 [149.570676] Dynamic subtest render-y-512: SUCCESS (0.079s) [149.578802] Starting dynamic subtest: render-y-1024 [149.892771] Dynamic subtest render-y-1024: SUCCESS (0.313s) [149.893475] Subtest render: SUCCESS (1.244s) [150.027863] [058/156] (871s left) perf_pmu (init-wait) [150.065641] Starting subtest: init-wait [150.066350] Starting dynamic subtest: rcs0 [150.067087] Dynamic subtest rcs0: SUCCESS (0.001s) [150.075651] Starting dynamic subtest: bcs0 [150.076341] Dynamic subtest bcs0: SUCCESS (0.000s) [150.084310] Starting dynamic subtest: vcs0 [150.085010] Dynamic subtest vcs0: SUCCESS (0.000s) [150.092733] Starting dynamic subtest: vcs1 [150.093441] Dynamic subtest vcs1: SUCCESS (0.000s) [150.101323] Starting dynamic subtest: vecs0 [150.102029] Dynamic subtest vecs0: SUCCESS (0.000s) [150.102714] Subtest init-wait: SUCCESS (0.005s) [150.150094] [059/156] (871s left) perf_pmu (busy) [150.187265] Starting subtest: busy [150.188050] Starting dynamic subtest: rcs0 [150.733081] Dynamic subtest rcs0: SUCCESS (0.544s) [150.743209] Starting dynamic subtest: bcs0 [151.263221] Dynamic subtest bcs0: SUCCESS (0.531s) [151.275429] Starting dynamic subtest: vcs0 [151.802312] Dynamic subtest vcs0: SUCCESS (0.538s) [151.813142] Starting dynamic subtest: vcs1 [152.340224] Dynamic subtest vcs1: SUCCESS (0.537s) [152.351346] Starting dynamic subtest: vecs0 [152.872302] Dynamic subtest vecs0: SUCCESS (0.531s) [152.873211] Subtest busy: SUCCESS (2.686s) [152.963327] [060/156] (868s left) gem_exec_schedule (timeslicing) [153.008581] Starting subtest: timeslicing [153.009298] Starting dynamic subtest: rcs0 [153.012475] Dynamic subtest rcs0: SUCCESS (0.004s) [153.020851] Starting dynamic subtest: bcs0 [153.021551] Dynamic subtest bcs0: SUCCESS (0.002s) [153.029858] Starting dynamic subtest: vcs0 [153.030577] Dynamic subtest vcs0: SUCCESS (0.003s) [153.038622] Starting dynamic subtest: vcs1 [153.039323] Dynamic subtest vcs1: SUCCESS (0.003s) [153.046787] Starting dynamic subtest: vecs0 [153.047486] Dynamic subtest vecs0: SUCCESS (0.003s) [153.048169] Subtest timeslicing: SUCCESS (0.018s) [153.349966] [061/156] (868s left) syncobj_timeline (single-wait-all-for-submit-signaled) [153.384438] Starting subtest: single-wait-all-for-submit-signaled [153.385156] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [153.496626] [062/156] (867s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [153.595680] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [154.742171] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.146s) [154.924333] [063/156] (866s left) gem_create (busy-create) [154.962008] Starting subtest: busy-create [154.962719] Starting dynamic subtest: smem0 [187.213562] Dynamic subtest smem0: SUCCESS (32.251s) [187.214602] Subtest busy-create: SUCCESS (32.252s) [187.422327] [064/156] (834s left) i915_hangman (gt-engine-hang) [187.472809] Starting subtest: gt-engine-hang [187.473491] Starting dynamic subtest: rcs0 [188.039936] Dynamic subtest rcs0: SUCCESS (0.567s) [188.049776] Starting dynamic subtest: bcs0 [188.606904] Dynamic subtest bcs0: SUCCESS (0.566s) [188.619220] Starting dynamic subtest: vcs0 [189.175954] Dynamic subtest vcs0: SUCCESS (0.568s) [189.187799] Starting dynamic subtest: vcs1 [189.742765] Dynamic subtest vcs1: SUCCESS (0.566s) [189.753828] Starting dynamic subtest: vecs0 [190.309786] Dynamic subtest vecs0: SUCCESS (0.566s) [190.310764] Subtest gt-engine-hang: SUCCESS (2.838s) [190.417289] [065/156] (831s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [190.511414] Starting subtest: plane-downscale-factor-0-5-with-rotation [190.512126] Starting dynamic subtest: pipe-A [191.075985] Dynamic subtest pipe-A: SKIP (0.563s) [191.087278] Starting dynamic subtest: pipe-B [191.607315] Dynamic subtest pipe-B: SKIP (0.530s) [191.617642] Starting dynamic subtest: pipe-C [192.145365] Dynamic subtest pipe-C: SKIP (0.538s) [192.153757] Starting dynamic subtest: pipe-D [192.706631] Dynamic subtest pipe-D: SKIP (0.559s) [192.709350] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (2.193s) [192.900510] [066/156] (828s left) kms_big_fb (x-tiled-8bpp-rotate-90) [193.005309] Starting subtest: x-tiled-8bpp-rotate-90 [193.085104] Subtest x-tiled-8bpp-rotate-90: SKIP (0.079s) [193.222785] [067/156] (828s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [193.312134] Starting subtest: cursorB-vs-flipB-varying-size [193.313570] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [193.412668] [068/156] (828s left) gem_softpin (allocator-basic) [193.450467] Starting subtest: allocator-basic [193.528805] Subtest allocator-basic: SUCCESS (0.078s) [193.659553] [069/156] (828s left) kms_chamelium_color (ctm-max) [193.750172] Subtest ctm-max: SKIP (0.000s) [193.807816] [070/156] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [193.900526] Starting subtest: psr-1p-primscrn-cur-indfb-move [193.902060] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [194.069738] [071/156] (827s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite) [194.162623] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite [194.164030] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [194.296936] [072/156] (827s left) i915_pm_rpm (gem-execbuf-stress-pc8) [195.695358] Starting subtest: gem-execbuf-stress-pc8 [195.767356] Subtest gem-execbuf-stress-pc8: SKIP (0.047s) [195.933066] [073/156] (825s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [196.023905] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [196.024606] Starting dynamic subtest: pipe-A-HDMI-A-1 [196.031406] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [196.039735] Starting dynamic subtest: pipe-B-HDMI-A-1 [196.046433] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [196.054792] Starting dynamic subtest: pipe-C-HDMI-A-1 [196.061448] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [196.069475] Starting dynamic subtest: pipe-D-HDMI-A-1 [196.076593] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [196.077921] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s) [196.327427] [074/156] (825s left) syncobj_wait (wait-all-delayed-signal) [196.363060] Starting subtest: wait-all-delayed-signal [196.465138] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [196.574653] [075/156] (825s left) kms_addfb_basic (invalid-get-prop) [196.609994] Starting subtest: invalid-get-prop [196.610761] Subtest invalid-get-prop: SUCCESS (0.000s) [196.781604] [076/156] (825s left) kms_vblank (wait-idle-hang) [196.870077] Starting subtest: wait-idle-hang [196.871839] Starting dynamic subtest: pipe-A-HDMI-A-1 [210.575699] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.704s) [210.587870] Starting dynamic subtest: pipe-D-HDMI-A-1 [224.896437] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.316s) [224.898339] Subtest wait-idle-hang: SUCCESS (28.027s) [225.087642] [077/156] (797s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt) [225.187409] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt [225.188841] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [225.313793] [078/156] (796s left) kms_vblank (query-idle) [225.402973] Starting subtest: query-idle [225.404757] Starting dynamic subtest: pipe-A-HDMI-A-1 [227.969552] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.565s) [227.980606] Starting dynamic subtest: pipe-D-HDMI-A-1 [230.457153] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.475s) [230.457873] Subtest query-idle: SUCCESS (5.045s) [230.646150] [079/156] (791s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [230.746860] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [230.748320] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [230.892151] [080/156] (791s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [230.985736] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [230.987178] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [231.119853] [081/156] (791s left) dmabuf_sync_file (import-basic) [231.166638] Starting subtest: import-basic [231.168417] Subtest import-basic: SUCCESS (0.002s) [231.291277] [082/156] (791s left) gem_mmap_wc (bad-object) [231.323851] Starting subtest: bad-object [231.324575] Subtest bad-object: SUCCESS (0.000s) [231.479645] [083/156] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [231.572713] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [231.574106] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [231.707939] [084/156] (790s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [231.801083] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [231.802519] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [231.973735] [085/156] (790s left) perf_pmu (frequency) [232.010668] Starting subtest: frequency [232.013192] Starting dynamic subtest: gt0 [234.112893] Dynamic subtest gt0: SUCCESS (2.097s) [234.123899] Starting dynamic subtest: idle-gt0 [234.627463] Dynamic subtest idle-gt0: SUCCESS (0.505s) [234.628163] Subtest frequency: SUCCESS (2.610s) [234.727501] [086/156] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [234.823441] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [234.824811] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [234.953472] [087/156] (787s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [235.044316] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [235.087081] [088/156] (787s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [235.176060] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [235.207477] Starting dynamic subtest: pipe-A-plane-0 [235.643112] Dynamic subtest pipe-A-plane-0: SUCCESS (0.436s) [235.660024] Starting dynamic subtest: pipe-A-plane-3 [235.965738] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s) [235.983661] Starting dynamic subtest: pipe-A-plane-5 [236.288359] Dynamic subtest pipe-A-plane-5: SUCCESS (0.320s) [236.305430] Starting dynamic subtest: pipe-A-plane-7 [236.307013] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [236.478539] Starting dynamic subtest: pipe-B-plane-0 [236.824281] Dynamic subtest pipe-B-plane-0: SUCCESS (0.360s) [236.841558] Starting dynamic subtest: pipe-B-plane-3 [237.146015] Dynamic subtest pipe-B-plane-3: SUCCESS (0.320s) [237.163941] Starting dynamic subtest: pipe-B-plane-5 [237.468497] Dynamic subtest pipe-B-plane-5: SUCCESS (0.320s) [237.485461] Starting dynamic subtest: pipe-B-plane-7 [237.486814] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [237.511645] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SUCCESS (2.336s) [237.715444] [089/156] (784s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [237.811315] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [237.868668] [090/156] (784s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [237.958078] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [237.958787] Starting dynamic subtest: pipe-A-HDMI-A-1 [237.964969] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [237.973546] Starting dynamic subtest: pipe-B-HDMI-A-1 [237.979533] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [237.987782] Starting dynamic subtest: pipe-C-HDMI-A-1 [237.993969] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [238.002096] Starting dynamic subtest: pipe-D-HDMI-A-1 [238.008116] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [238.008855] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.012s) [238.261656] [091/156] (784s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [238.296859] Starting subtest: etime-multi-wait-all-submitted-signaled [238.398672] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.101s) [238.526576] [092/156] (784s left) prime_self_import (basic-with_fd_dup) [238.559112] Starting subtest: basic-with_fd_dup [238.561730] Subtest basic-with_fd_dup: SUCCESS (0.003s) [238.697681] [093/156] (784s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [238.791433] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [240.716771] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (1.926s) [240.899899] [094/156] (781s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [240.992047] Starting subtest: plane-upscale-20x20-with-pixel-format [240.992995] Starting dynamic subtest: pipe-A [243.524967] Dynamic subtest pipe-A: SUCCESS (2.532s) [243.548824] Starting dynamic subtest: pipe-B [246.096113] Dynamic subtest pipe-B: SUCCESS (2.568s) [246.110448] Starting dynamic subtest: pipe-C [246.464776] Dynamic subtest pipe-C: SUCCESS (0.367s) [246.488039] Starting dynamic subtest: pipe-D [246.813584] Dynamic subtest pipe-D: SUCCESS (0.346s) [246.814836] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.823s) [247.040171] [095/156] (775s left) gen9_exec_parse (unaligned-access) [247.081938] Subtest unaligned-access: SKIP (0.000s) [247.141143] [096/156] (775s left) syncobj_wait (multi-wait-submitted-signaled) [247.176151] Starting subtest: multi-wait-submitted-signaled [247.176871] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [247.266641] [097/156] (775s left) kms_feature_discovery (display-2x) [247.358804] Starting subtest: display-2x [247.360659] Subtest display-2x: SKIP (0.000s) [247.497781] [098/156] (775s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [247.590483] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [247.591881] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [247.704215] [099/156] (775s left) kms_addfb_basic (invalid-set-prop-any) [247.738108] Starting subtest: invalid-set-prop-any [247.738875] Subtest invalid-set-prop-any: SUCCESS (0.000s) [247.913560] [100/156] (775s left) kms_lease (lease-invalid-crtc) [248.003149] Starting subtest: lease-invalid-crtc [248.004959] Starting dynamic subtest: pipe-A-HDMI-A-1 [248.005674] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [248.014380] Starting dynamic subtest: pipe-B-HDMI-A-1 [248.015085] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [248.023197] Starting dynamic subtest: pipe-C-HDMI-A-1 [248.023902] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [248.031636] Starting dynamic subtest: pipe-D-HDMI-A-1 [248.032330] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [248.033014] Subtest lease-invalid-crtc: SUCCESS (0.006s) [248.099200] [101/156] (775s left) kms_plane_multiple (2x-tiling-none) [248.188072] Starting subtest: 2x-tiling-none [248.189521] Subtest 2x-tiling-none: SKIP (0.000s) [248.292307] [102/156] (774s left) kms_addfb_basic (addfb25-y-tiled-legacy) [248.381090] Starting subtest: addfb25-y-tiled-legacy [248.381853] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [248.520372] [103/156] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [248.613677] Starting subtest: psr-1p-primscrn-spr-indfb-move [248.615120] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [248.767959] [104/156] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [248.862760] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [251.279361] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.417s) [251.462349] [105/156] (771s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [251.505357] Starting subtest: yf-tiled-ccs-to-y-tiled [251.506079] Starting dynamic subtest: smem [251.607413] Dynamic subtest smem: SUCCESS (0.101s) [251.608172] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.102s) [251.823680] [106/156] (771s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [251.915979] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [251.923422] Starting dynamic subtest: pipe-A-HDMI-A-1 [251.930217] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [251.938651] Starting dynamic subtest: pipe-B-HDMI-A-1 [251.945412] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [251.953725] Starting dynamic subtest: pipe-C-HDMI-A-1 [251.960461] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [251.968645] Starting dynamic subtest: pipe-D-HDMI-A-1 [251.975326] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [251.976665] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [252.215799] [107/156] (771s left) kms_flip (flip-vs-rmfb) [252.307147] Starting subtest: flip-vs-rmfb [252.309112] Starting dynamic subtest: A-HDMI-A1 [260.000526] Dynamic subtest A-HDMI-A1: SUCCESS (7.691s) [260.021845] Starting dynamic subtest: B-HDMI-A1 [267.685087] Dynamic subtest B-HDMI-A1: SUCCESS (7.680s) [267.703944] Starting dynamic subtest: C-HDMI-A1 [275.372510] Dynamic subtest C-HDMI-A1: SUCCESS (7.684s) [275.391892] Starting dynamic subtest: D-HDMI-A1 [283.049949] Dynamic subtest D-HDMI-A1: SUCCESS (7.674s) [283.054832] Subtest flip-vs-rmfb: SUCCESS (30.748s) [283.259331] [108/156] (740s left) syncobj_wait (multi-wait-all-submitted) [283.294745] Starting subtest: multi-wait-all-submitted [283.398723] Subtest multi-wait-all-submitted: SUCCESS (0.103s) [283.521788] [109/156] (739s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [283.617774] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu [283.619192] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [283.750059] [110/156] (739s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [283.840244] Starting subtest: plane-all-modeset-transition-internal-panels [283.841648] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s) [283.940420] [111/156] (739s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu) [284.033125] Starting subtest: hdr-rgb101010-draw-mmap-cpu [284.034514] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [284.187309] [112/156] (739s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt) [284.280668] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt [284.282081] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [284.414459] [113/156] (739s left) gem_bad_reloc (negative-reloc-bltcopy) [284.454109] Starting subtest: negative-reloc-bltcopy [285.577361] Subtest negative-reloc-bltcopy: SUCCESS (1.114s) [285.724797] [114/156] (738s left) syncobj_wait (multi-wait-for-submit-submitted) [285.760195] Starting subtest: multi-wait-for-submit-submitted [285.862786] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s) [285.988721] [115/156] (737s left) kms_pm_lpsp (kms-lpsp) [287.082583] Starting subtest: kms-lpsp [287.083945] Subtest kms-lpsp: SKIP (0.000s) [287.203901] [116/156] (736s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [287.296784] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [287.298201] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [287.450779] [117/156] (736s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [287.543451] Starting subtest: psr-rgb101010-draw-blt [287.544837] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [287.659252] [118/156] (736s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [287.752390] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [287.753754] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [287.886482] [119/156] (736s left) gem_flink_basic (bad-flink) [287.919915] Starting subtest: bad-flink [287.920619] Subtest bad-flink: SUCCESS (0.000s) [288.038152] [120/156] (735s left) prime_vgem (busy) [288.109037] Starting subtest: busy [288.109763] Starting dynamic subtest: rcs0 [288.149226] Dynamic subtest rcs0: SUCCESS (0.041s) [288.159499] Starting dynamic subtest: bcs0 [288.168296] Dynamic subtest bcs0: SUCCESS (0.018s) [288.177974] Starting dynamic subtest: vcs0 [288.189820] Dynamic subtest vcs0: SUCCESS (0.020s) [288.200527] Starting dynamic subtest: vcs1 [288.204569] Dynamic subtest vcs1: SUCCESS (0.013s) [288.215268] Starting dynamic subtest: vecs0 [288.222857] Dynamic subtest vecs0: SUCCESS (0.017s) [288.223583] Subtest busy: SUCCESS (0.116s) [288.361230] [121/156] (735s left) syncobj_wait (wait-all-for-submit-snapshot) [288.396865] Starting subtest: wait-all-for-submit-snapshot [288.479114] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [288.607340] [122/156] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [288.700116] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [288.701534] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [288.834302] [123/156] (735s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt) [288.931084] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt [288.932526] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [289.057780] [124/156] (735s left) gen9_exec_parse (basic-rejected-ctx-param) [289.095626] Subtest basic-rejected-ctx-param: SKIP (0.000s) [289.139796] [125/156] (735s left) gem_exec_params (readonly) [289.178295] Starting subtest: readonly [289.180330] Subtest readonly: SUCCESS (0.001s) [289.310212] [126/156] (734s left) kms_psr (fbc-pr-primary-render) [289.398596] Subtest fbc-pr-primary-render: SKIP (0.000s) [289.444953] [127/156] (734s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [289.538381] Starting subtest: 2x-wf_vblank-ts-check-interruptible [289.548063] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.009s) [289.651028] [128/156] (734s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [289.744747] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [289.746191] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [289.860840] [129/156] (734s left) kms_cursor_legacy (single-bo) [289.950149] Starting subtest: single-bo [289.950915] Starting dynamic subtest: pipe-A [295.364931] Dynamic subtest pipe-A: SUCCESS (5.380s) [295.373140] Starting dynamic subtest: pipe-B [300.745180] Dynamic subtest pipe-B: SUCCESS (5.379s) [300.754463] Starting dynamic subtest: pipe-C [306.099251] Dynamic subtest pipe-C: SUCCESS (5.378s) [306.107775] Starting dynamic subtest: pipe-D [311.504318] Dynamic subtest pipe-D: SUCCESS (5.378s) [311.512773] Starting dynamic subtest: all-pipes [316.884640] Dynamic subtest all-pipes: SUCCESS (5.379s) [316.885570] Subtest single-bo: SUCCESS (26.900s) [316.946891] [130/156] (707s left) kms_cursor_crc (cursor-sliding-64x21) [317.041451] Starting subtest: cursor-sliding-64x21 [317.046268] Starting dynamic subtest: pipe-A-HDMI-A-1 [321.110648] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.064s) [321.143878] Starting dynamic subtest: pipe-D-HDMI-A-1 [325.089786] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.954s) [325.090534] Subtest cursor-sliding-64x21: SUCCESS (8.049s) [325.303713] [131/156] (699s left) gem_huc_copy (huc-copy) [325.345462] Starting subtest: huc-copy [325.347077] Subtest huc-copy: SKIP (0.000s) [325.472186] [132/156] (699s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [325.563472] Starting subtest: primary-y-tiled-reflect-x-0 [333.781660] Subtest primary-y-tiled-reflect-x-0: SUCCESS (8.218s) [334.006101] [133/156] (690s left) kms_properties (colorop-properties-atomic) [334.100095] Starting subtest: colorop-properties-atomic [334.100884] Starting dynamic subtest: pipe-A-HDMI-A-1 [334.191788] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.090s) [334.200483] Starting dynamic subtest: pipe-B-HDMI-A-1 [334.309712] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.116s) [334.322271] Starting dynamic subtest: pipe-C-HDMI-A-1 [334.435435] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.125s) [334.445393] Starting dynamic subtest: pipe-D-HDMI-A-1 [334.554195] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.117s) [334.554913] Subtest colorop-properties-atomic: SUCCESS (0.455s) [334.755870] [134/156] (689s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [334.847743] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [334.849218] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [334.941344] [135/156] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [335.040211] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [335.041580] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [335.152203] [136/156] (689s left) gem_mmap_gtt (cpuset-medium-copy-odd) [335.186945] Starting subtest: cpuset-medium-copy-odd [342.428513] Subtest cpuset-medium-copy-odd: SUCCESS (7.242s) [342.555444] [137/156] (682s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [342.700366] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [342.701947] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [342.813132] [138/156] (681s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite) [342.908745] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite [342.910236] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [343.020422] [139/156] (681s left) i915_pm_rps (thresholds-park) [343.060639] Starting subtest: thresholds-park [343.061464] Starting dynamic subtest: gt0 [357.939219] Dynamic subtest gt0: SUCCESS (14.877s) [357.943199] Subtest thresholds-park: SUCCESS (14.880s) [358.028245] [140/156] (666s left) kms_setmode (basic) [358.063111] Starting subtest: basic [358.143172] Starting dynamic subtest: pipe-A-HDMI-A-1 [360.550336] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.371s) [360.593091] Starting dynamic subtest: pipe-B-HDMI-A-1 [362.990058] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.370s) [362.999589] Subtest basic: SUCCESS (4.936s) [363.204842] [141/156] (661s left) gem_partial_pwrite_pread (write) [363.242750] Starting subtest: write [373.564031] Subtest write: SUCCESS (10.321s) [373.695297] [142/156] (651s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [373.797846] Starting subtest: yf-tiled-addfb-size-offset-overflow [373.799313] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [373.922332] [143/156] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [374.015544] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [374.016975] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [374.149351] [144/156] (650s left) gem_softpin (overlap) [374.190087] Starting subtest: overlap [375.135267] Subtest overlap: SUCCESS (0.945s) [375.271875] [145/156] (649s left) gem_softpin (softpin) [375.310765] Starting subtest: softpin [407.635335] Subtest softpin: SUCCESS (32.315s) [407.752661] [146/156] (617s left) gem_spin_batch (resubmit-new-all) [407.794324] Starting subtest: resubmit-new-all [407.795060] Starting dynamic subtest: rcs0 [407.800161] Dynamic subtest rcs0: SUCCESS (0.005s) [407.811280] Starting dynamic subtest: bcs0 [407.812060] Dynamic subtest bcs0: SUCCESS (0.004s) [407.821733] Starting dynamic subtest: vcs0 [407.822479] Dynamic subtest vcs0: SUCCESS (0.004s) [407.831203] Starting dynamic subtest: vcs1 [407.831945] Dynamic subtest vcs1: SUCCESS (0.004s) [407.840141] Starting dynamic subtest: vecs0 [407.840863] Dynamic subtest vecs0: SUCCESS (0.004s) [407.841577] Subtest resubmit-new-all: SUCCESS (0.027s) [408.053404] [147/156] (617s left) kms_content_protection (dp-mst-lic-type-1) [408.150049] Starting subtest: dp-mst-lic-type-1 [408.151493] Subtest dp-mst-lic-type-1: SKIP (0.000s) [408.285249] [148/156] (616s left) kms_cursor_crc (cursor-onscreen-512x512) [408.379833] Starting subtest: cursor-onscreen-512x512 [408.381301] Subtest cursor-onscreen-512x512: SKIP (0.001s) [408.532750] [149/156] (616s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move) [408.628486] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move [408.629899] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [408.759677] [150/156] (616s left) kms_big_fb (linear-addfb) [408.861602] Starting subtest: linear-addfb [408.862352] Subtest linear-addfb: SUCCESS (0.000s) [409.006090] [151/156] (616s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt) [409.099549] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt [409.100955] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [409.208445] [152/156] (616s left) kms_psr (psr2-cursor-mmap-cpu) [409.298778] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [409.349112] [153/156] (616s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [409.447291] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [409.448741] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [409.576148] [154/156] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [409.669111] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [409.670528] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [409.822752] [155/156] (615s left) syncobj_timeline (invalid-single-wait-unsubmitted) [409.863456] Starting subtest: invalid-single-wait-unsubmitted [409.864197] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [409.991896] [156/156] (615s left) api_intel_allocator (standalone) [410.027199] Starting subtest: standalone [410.043644] Subtest standalone: SUCCESS (0.017s) [410.182833] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: gem_shrink results: parsing output: 3/ for test: gem_mmap_offset results: parsing output: 4/ for test: gem_ctx_persistence results: parsing output: 5/ for test: gem_exec_whisper results: parsing output: 6/ for test: gem_ctx_shared results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: gem_exec_balancer results: parsing output: 9/ for test: kms_ccs results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: gem_userptr_blits results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_chamelium_hpd results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: kms_dsc results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: prime_mmap_coherency results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_atomic_interruptible results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_chamelium_edid results: parsing output: 31/ for test: kms_properties results: parsing output: 32/ for test: gem_wait results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: kms_getfb results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_flip_scaled_crc results: parsing output: 39/ for test: kms_color_pipeline results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_hdr results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: gem_mmap_wc results: parsing output: 47/ for test: kms_pipe_crc_basic results: parsing output: 48/ for test: gem_madvise results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_scaling_modes results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: fbdev results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: perf_pmu results: parsing output: 58/ for test: perf_pmu results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_create results: parsing output: 63/ for test: i915_hangman results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: gem_softpin results: parsing output: 68/ for test: kms_chamelium_color results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: i915_pm_rpm results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: syncobj_wait results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_vblank results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_vblank results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: dmabuf_sync_file results: parsing output: 81/ for test: gem_mmap_wc results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: kms_plane results: parsing output: 88/ for test: kms_psr2_sf results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: prime_self_import results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_plane_scaling results: parsing output: 94/ for test: gen9_exec_parse results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_feature_discovery results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: kms_lease results: parsing output: 100/ for test: kms_plane_multiple results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_render_copy results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: syncobj_wait results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_atomic_transition results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_bad_reloc results: parsing output: 113/ for test: syncobj_wait results: parsing output: 114/ for test: kms_pm_lpsp results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_flink_basic results: parsing output: 119/ for test: prime_vgem results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gen9_exec_parse results: parsing output: 124/ for test: gem_exec_params results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_cursor_crc results: parsing output: 130/ for test: gem_huc_copy results: parsing output: 131/ for test: kms_rotation_crc results: parsing output: 132/ for test: kms_properties results: parsing output: 133/ for test: kms_plane results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: gem_mmap_gtt results: parsing output: 136/ for test: kms_flip_scaled_crc results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: i915_pm_rps results: parsing output: 139/ for test: kms_setmode results: parsing output: 140/ for test: gem_partial_pwrite_pread results: parsing output: 141/ for test: kms_big_fb results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: gem_softpin results: parsing output: 144/ for test: gem_softpin results: parsing output: 145/ for test: gem_spin_batch results: parsing output: 146/ for test: kms_content_protection results: parsing output: 147/ for test: kms_cursor_crc results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_big_fb results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_psr results: parsing output: 152/ for test: kms_big_fb results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: syncobj_timeline results: parsing output: 155/ for test: api_intel_allocator Done.