[44.816177] Initializing watchdogs [44.816237] /dev/watchdog0 [44.832396] [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] [44.838076] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [44.840616] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [44.842496] [001/156] (960s left) kms_cursor_crc (cursor-random-256x256) [44.945890] Starting subtest: cursor-random-256x256 [44.961125] Starting dynamic subtest: pipe-A-HDMI-A-1 [46.892640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.932s) [46.931014] Starting dynamic subtest: pipe-D-HDMI-A-1 [48.812773] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.885s) [48.813540] Subtest cursor-random-256x256: SUCCESS (3.863s) [48.987179] [002/156] (956s left) i915_drm_fdinfo (busy-idle-check-all) [49.032466] Starting subtest: busy-idle-check-all [49.033297] Starting dynamic subtest: rcs0 [49.656481] Dynamic subtest rcs0: SUCCESS (0.623s) [49.665426] Starting dynamic subtest: bcs0 [50.287412] Dynamic subtest bcs0: SUCCESS (0.629s) [50.296369] Starting dynamic subtest: vcs0 [50.912450] Dynamic subtest vcs0: SUCCESS (0.624s) [50.921637] Starting dynamic subtest: vcs1 [51.535352] Dynamic subtest vcs1: SUCCESS (0.621s) [51.543867] Starting dynamic subtest: vecs0 [52.158041] Dynamic subtest vecs0: SUCCESS (0.620s) [52.159077] Subtest busy-idle-check-all: SUCCESS (3.120s) [52.230981] [003/156] (953s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render) [52.328139] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render [52.329535] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [52.427102] [004/156] (953s left) kms_content_protection (type1) [52.519722] Starting subtest: type1 [52.524981] Subtest type1: SKIP (0.004s) [52.623772] [005/156] (952s left) kms_chamelium_edid (hdmi-edid-read) [52.767342] Subtest hdmi-edid-read: SKIP (0.000s) [52.860080] [006/156] (952s left) gen9_exec_parse (bb-chained) [52.906032] Subtest bb-chained: SKIP (0.000s) [52.950994] [007/156] (952s left) drm_read (fault-buffer) [53.063404] Starting subtest: fault-buffer [53.064212] Subtest fault-buffer: SUCCESS (0.000s) [53.172454] [008/156] (952s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [53.264382] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [53.265875] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [53.370111] [009/156] (952s left) kms_getfb (getfb-handle-valid) [53.459766] Starting subtest: getfb-handle-valid [53.460501] Subtest getfb-handle-valid: SUCCESS (0.000s) [53.559934] [010/156] (952s left) kms_async_flips (async-flip-hang) [53.649915] Starting subtest: async-flip-hang [53.780603] Starting dynamic subtest: pipe-A-HDMI-A-1 [68.704586] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.905s) [68.834012] Starting dynamic subtest: pipe-B-HDMI-A-1 [83.577065] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.710s) [83.666031] Starting dynamic subtest: pipe-C-HDMI-A-1 [98.425098] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.728s) [98.525843] Starting dynamic subtest: pipe-D-HDMI-A-1 [113.784510] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (15.231s) [113.785208] Subtest async-flip-hang: SUCCESS (60.082s) [113.985616] [011/156] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [114.087320] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [114.088708] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [114.172575] [012/156] (891s left) gem_userptr_blits (huge-split) [114.225339] Starting subtest: huge-split [114.228679] Subtest huge-split: SUCCESS (0.003s) [114.344731] [013/156] (891s left) gem_exec_balancer (smoke) [114.387854] Starting subtest: smoke [137.546919] Subtest smoke: SUCCESS (23.127s) [138.007139] [014/156] (867s left) kms_flip_event_leak (basic) [138.095495] Starting subtest: basic [138.096226] Starting dynamic subtest: pipe-A-HDMI-A-1 [138.263756] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.168s) [138.271696] Starting dynamic subtest: pipe-B-HDMI-A-1 [138.432105] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.166s) [138.438401] Starting dynamic subtest: pipe-C-HDMI-A-1 [138.602343] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.169s) [138.609583] Starting dynamic subtest: pipe-D-HDMI-A-1 [138.769805] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.166s) [138.770505] Subtest basic: SUCCESS (0.674s) [138.914231] [015/156] (866s left) kms_big_fb (y-tiled-16bpp-rotate-0) [139.021371] Starting subtest: y-tiled-16bpp-rotate-0 [140.193915] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.172s) [140.326080] [016/156] (865s left) kms_sequence (get-forked) [140.416732] Starting subtest: get-forked [140.418350] Starting dynamic subtest: pipe-A-HDMI-A-1 [141.658213] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.240s) [141.664732] Starting dynamic subtest: pipe-B-HDMI-A-1 [142.889502] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.230s) [142.897441] Starting dynamic subtest: pipe-C-HDMI-A-1 [144.151848] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.260s) [144.158912] Starting dynamic subtest: pipe-D-HDMI-A-1 [145.387620] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.235s) [145.388422] Subtest get-forked: SUCCESS (4.971s) [145.520428] [017/156] (860s left) gem_ppgtt (flink-and-close-vma-leak) [145.559534] Starting subtest: flink-and-close-vma-leak [145.563405] Subtest flink-and-close-vma-leak: SUCCESS (0.004s) [145.660153] [018/156] (860s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [145.755618] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [145.757099] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [145.829585] [019/156] (860s left) kms_big_fb (x-tiled-8bpp-rotate-180) [145.927136] Starting subtest: x-tiled-8bpp-rotate-180 [146.935131] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.008s) [147.059360] [020/156] (859s left) gem_fence_thrash (bo-write-verify-threaded-none) [147.092169] Starting subtest: bo-write-verify-threaded-none [151.412332] Subtest bo-write-verify-threaded-none: SUCCESS (4.287s) [151.485772] [021/156] (854s left) kms_pm_rpm (modeset-pc8-residency-stress) [152.887923] Starting subtest: modeset-pc8-residency-stress [152.890343] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [153.082192] [022/156] (853s left) i915_pm_rps (basic-api) [153.123746] Starting subtest: basic-api [153.125890] Subtest basic-api: SUCCESS (0.002s) [153.185453] [023/156] (853s left) gem_exec_fence (syncobj-timeline-wait) [153.674794] Starting subtest: syncobj-timeline-wait [153.699665] Subtest syncobj-timeline-wait: SUCCESS (0.035s) [153.873117] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [153.874754] [024/156] (852s left) gem_ctx_persistence (engines-mixed-process) [153.912955] Starting subtest: engines-mixed-process [153.913769] Starting dynamic subtest: rcs0 [154.279582] Dynamic subtest rcs0: SUCCESS (0.365s) [154.287176] Starting dynamic subtest: bcs0 [154.640028] Dynamic subtest bcs0: SUCCESS (0.361s) [154.657236] Starting dynamic subtest: vcs0 [155.004668] Dynamic subtest vcs0: SUCCESS (0.364s) [155.014685] Starting dynamic subtest: vcs1 [155.353106] Dynamic subtest vcs1: SUCCESS (0.347s) [155.370723] Starting dynamic subtest: vecs0 [155.725076] Dynamic subtest vecs0: SUCCESS (0.371s) [155.726418] Subtest engines-mixed-process: SUCCESS (1.812s) [155.800810] [025/156] (850s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [155.840203] Starting subtest: no-spare-fences-busy-interruptible [157.996743] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.156s) [158.115852] [026/156] (848s left) sysfs_timeslice_duration (idempotent) [158.152681] Starting subtest: idempotent [158.153407] Starting dynamic subtest: vecs0 [158.154120] Dynamic subtest vecs0: SUCCESS (0.001s) [158.161163] Starting dynamic subtest: vcs0 [158.161880] Dynamic subtest vcs0: SUCCESS (0.001s) [158.168781] Starting dynamic subtest: bcs0 [158.169462] Dynamic subtest bcs0: SUCCESS (0.001s) [158.176365] Starting dynamic subtest: rcs0 [158.177072] Dynamic subtest rcs0: SUCCESS (0.001s) [158.183160] Starting dynamic subtest: vcs1 [158.183849] Dynamic subtest vcs1: SUCCESS (0.000s) [158.184554] Subtest idempotent: SUCCESS (0.006s) [158.224407] [027/156] (848s left) i915_query (engine-info) [158.258297] Starting subtest: engine-info [158.259916] Subtest engine-info: SUCCESS (0.002s) [158.331386] [028/156] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [158.425390] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [158.426884] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [158.539993] [029/156] (847s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [158.628530] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [158.629909] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [158.803918] [030/156] (847s left) kms_chamelium_hpd (hdmi-hpd-fast) [158.942999] Subtest hdmi-hpd-fast: SKIP (0.000s) [159.040886] [031/156] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [159.137553] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [159.138981] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [159.227839] [032/156] (847s left) gem_linear_blits (normal) [159.550932] Starting subtest: normal [163.164552] Subtest normal: SUCCESS (3.614s) [163.313683] [033/156] (843s left) prime_vgem (fence-wait) [163.406295] Starting subtest: fence-wait [163.407098] Starting dynamic subtest: rcs0 [164.449110] Dynamic subtest rcs0: SUCCESS (1.042s) [164.457696] Starting dynamic subtest: bcs0 [165.490303] Dynamic subtest bcs0: SUCCESS (1.032s) [165.501212] Starting dynamic subtest: vcs0 [166.516211] Dynamic subtest vcs0: SUCCESS (1.024s) [166.527529] Starting dynamic subtest: vcs1 [167.538365] Dynamic subtest vcs1: SUCCESS (1.020s) [167.555032] Starting dynamic subtest: vecs0 [168.567900] Dynamic subtest vecs0: SUCCESS (1.028s) [168.569376] Subtest fence-wait: SUCCESS (5.153s) [168.672641] [034/156] (837s left) syncobj_wait (invalid-signal-illegal-handle) [168.715945] Starting subtest: invalid-signal-illegal-handle [168.716937] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [168.790734] [035/156] (837s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [168.884471] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [168.885204] Starting dynamic subtest: pipe-A-HDMI-A-1 [168.892053] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [168.899457] Starting dynamic subtest: pipe-B-HDMI-A-1 [168.906226] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [168.913540] Starting dynamic subtest: pipe-C-HDMI-A-1 [168.920417] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [168.927555] Starting dynamic subtest: pipe-D-HDMI-A-1 [168.934654] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [168.935986] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s) [169.128560] [036/156] (837s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [169.217785] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [169.219226] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s) [169.290740] [037/156] (837s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [169.385989] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [169.387449] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [169.478721] [038/156] (837s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [169.572777] Starting subtest: psrhdr-slowdraw [169.574288] Subtest psrhdr-slowdraw: SKIP (0.000s) [169.660976] [039/156] (837s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [169.754464] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [169.755943] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [169.847780] [040/156] (837s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [169.888053] Starting subtest: yf-tiled-ccs-to-yf-tiled [169.888792] Starting dynamic subtest: smem [169.964372] Dynamic subtest smem: SUCCESS (0.076s) [169.965134] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.076s) [170.140507] [041/156] (836s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt) [170.235726] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt [170.237164] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [170.341129] [042/156] (836s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [170.429060] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [170.430565] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [170.492276] [043/156] (836s left) vgem_basic (dmabuf-fence-before) [170.534361] Starting subtest: dmabuf-fence-before [170.535090] Subtest dmabuf-fence-before: SUCCESS (0.000s) [170.589899] [044/156] (836s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt) [170.682602] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt [170.684096] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [170.779789] [045/156] (836s left) syncobj_timeline (multi-wait-available-submitted-signaled) [170.814989] Starting subtest: multi-wait-available-submitted-signaled [170.815795] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [170.885236] [046/156] (836s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [170.979356] Starting subtest: hdr-1p-primscrn-cur-indfb-move [170.980802] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [171.092262] [047/156] (836s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [171.186362] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [171.187803] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [171.277349] [048/156] (835s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [171.370716] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [171.372173] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [171.461650] [049/156] (835s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [171.555292] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [171.556728] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [171.666548] [050/156] (835s left) gem_exec_reloc (basic-write-cpu-active) [171.705595] Starting subtest: basic-write-cpu-active [171.831700] Subtest basic-write-cpu-active: SUCCESS (0.123s) [171.952609] [051/156] (835s left) kms_lease (lease-invalid-connector) [172.040978] Starting subtest: lease-invalid-connector [172.042159] Starting dynamic subtest: pipe-A-HDMI-A-1 [172.042923] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [172.050300] Starting dynamic subtest: pipe-B-HDMI-A-1 [172.051054] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [172.058181] Starting dynamic subtest: pipe-C-HDMI-A-1 [172.058925] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [172.065789] Starting dynamic subtest: pipe-D-HDMI-A-1 [172.067332] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [172.068076] Subtest lease-invalid-connector: SUCCESS (0.005s) [172.101775] [052/156] (835s left) perf (gen12-group-concurrent-oa-buffer-read) [172.205811] Starting subtest: gen12-group-concurrent-oa-buffer-read [182.259976] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.021s) [182.329374] [053/156] (825s left) sw_sync (sync_busy_fork_unixsocket) [182.367564] Starting subtest: sync_busy_fork_unixsocket [182.376206] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [182.448568] [054/156] (825s left) syncobj_timeline (wait-any-complex) [182.482289] Starting subtest: wait-any-complex [182.545228] Subtest wait-any-complex: SUCCESS (0.062s) [182.624958] [055/156] (824s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [182.719452] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [182.720875] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [182.814336] [056/156] (824s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [182.902887] Starting subtest: 2x-long-cursor-vs-flip-legacy [182.905147] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [182.960788] [057/156] (824s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [183.051301] Starting subtest: plane-primary-toggle-with-vblank-wait [183.052075] Starting dynamic subtest: pipe-A-HDMI-A-1 [183.168076] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.116s) [183.243047] Starting dynamic subtest: pipe-B-HDMI-A-1 [183.401811] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.167s) [183.450933] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.400s) [183.603523] [058/156] (824s left) gem_mmap_wc (write-read) [183.640869] Starting subtest: write-read [183.643375] Subtest write-read: SUCCESS (0.003s) [183.737853] [059/156] (823s left) api_intel_bb (render) [183.771637] Starting subtest: render [183.772375] Starting dynamic subtest: render-none-512 [183.861416] Dynamic subtest render-none-512: SUCCESS (0.089s) [183.868750] Starting dynamic subtest: render-none-1024 [184.227825] Dynamic subtest render-none-1024: SUCCESS (0.357s) [184.235154] Starting dynamic subtest: render-x-512 [184.297236] Dynamic subtest render-x-512: SUCCESS (0.077s) [184.304654] Starting dynamic subtest: render-x-1024 [184.630577] Dynamic subtest render-x-1024: SUCCESS (0.324s) [184.637764] Starting dynamic subtest: render-y-512 [184.701660] Dynamic subtest render-y-512: SUCCESS (0.079s) [184.708826] Starting dynamic subtest: render-y-1024 [185.051903] Dynamic subtest render-y-1024: SUCCESS (0.341s) [185.052706] Subtest render: SUCCESS (1.272s) [185.153274] [060/156] (822s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [185.242744] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [185.243443] Starting dynamic subtest: pipe-A-HDMI-A-1 [185.260643] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [185.268076] Starting dynamic subtest: pipe-B-HDMI-A-1 [185.285493] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [185.292896] Starting dynamic subtest: pipe-C-HDMI-A-1 [185.310439] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [185.318281] Starting dynamic subtest: pipe-D-HDMI-A-1 [185.336666] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [185.338101] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.012s) [185.511406] [061/156] (822s left) syncobj_wait (wait-any-interrupted) [185.547358] Starting subtest: wait-any-interrupted [185.653741] Subtest wait-any-interrupted: SUCCESS (0.106s) [185.742266] [062/156] (822s left) gem_mmap_gtt (hang-user) [185.776592] Starting subtest: hang-user [221.323803] Subtest hang-user: SUCCESS (35.548s) [221.428459] [063/156] (786s left) prime_vgem (basic-write) [221.469465] Starting subtest: basic-write [221.500441] Subtest basic-write: SUCCESS (0.031s) [221.620604] [064/156] (786s left) kms_force_connector_basic (force-connector-state) [221.746604] Starting subtest: force-connector-state [222.085888] Subtest force-connector-state: SUCCESS (0.331s) [222.394473] [065/156] (785s left) kms_psr (psr-cursor-plane-move) [222.486366] Subtest psr-cursor-plane-move: SKIP (0.000s) [222.528205] [066/156] (785s left) gem_spin_batch (resubmit-new) [222.571217] Starting subtest: resubmit-new [222.572088] Starting dynamic subtest: rcs0 [222.575015] Dynamic subtest rcs0: SUCCESS (0.004s) [222.583272] Starting dynamic subtest: bcs0 [222.584014] Dynamic subtest bcs0: SUCCESS (0.003s) [222.592518] Starting dynamic subtest: vcs0 [222.593237] Dynamic subtest vcs0: SUCCESS (0.003s) [222.600385] Starting dynamic subtest: vcs1 [222.601193] Dynamic subtest vcs1: SUCCESS (0.003s) [222.608125] Starting dynamic subtest: vecs0 [222.608825] Dynamic subtest vecs0: SUCCESS (0.003s) [222.609500] Subtest resubmit-new: SUCCESS (0.018s) [222.775695] [067/156] (785s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [222.865815] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [222.866890] Starting dynamic subtest: pipe-A [224.122392] Dynamic subtest pipe-A: SUCCESS (1.257s) [224.130484] Starting dynamic subtest: pipe-B [225.390835] Dynamic subtest pipe-B: SUCCESS (1.268s) [225.401013] Starting dynamic subtest: pipe-C [225.599483] Dynamic subtest pipe-C: SUCCESS (0.208s) [225.609168] Starting dynamic subtest: pipe-D [225.809914] Dynamic subtest pipe-D: SUCCESS (0.210s) [225.810710] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.945s) [225.997913] [068/156] (782s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt) [226.097605] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt [226.099140] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [226.192012] [069/156] (781s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [226.283722] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [226.327427] [070/156] (781s left) gem_mmap_gtt (basic-small-bo) [226.360999] Starting subtest: basic-small-bo [226.479633] Subtest basic-small-bo: SUCCESS (0.118s) [226.593557] [071/156] (781s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary) [226.745706] Starting subtest: fbchdr-shrfb-scaledprimary [226.747119] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s) [226.833678] [072/156] (781s left) kms_plane_scaling (planes-upscale-20x20) [226.923034] Starting subtest: planes-upscale-20x20 [226.923823] Starting dynamic subtest: pipe-A [226.994890] Dynamic subtest pipe-A: SUCCESS (0.072s) [227.006180] Starting dynamic subtest: pipe-B [227.137259] Dynamic subtest pipe-B: SUCCESS (0.141s) [227.147061] Starting dynamic subtest: pipe-C [227.304765] Dynamic subtest pipe-C: SUCCESS (0.166s) [227.313272] Starting dynamic subtest: pipe-D [227.438092] Dynamic subtest pipe-D: SUCCESS (0.132s) [227.438874] Subtest planes-upscale-20x20: SUCCESS (0.516s) [227.633682] [073/156] (780s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [227.730972] Starting subtest: cursor-tearing-framebuffer-change [227.731824] Starting dynamic subtest: pipe-A-HDMI-A-1 [228.003667] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.272s) [228.014980] Starting dynamic subtest: pipe-D-HDMI-A-1 [228.238908] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.233s) [228.239684] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.509s) [228.425226] [074/156] (779s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [228.525618] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [228.527131] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [228.620649] [075/156] (779s left) perf_pmu (all-busy-check-all) [228.659624] Starting subtest: all-busy-check-all [229.176164] Subtest all-busy-check-all: SUCCESS (0.516s) [229.249432] [076/156] (779s left) gem_exec_balancer (invalid-bonds) [229.292714] Starting subtest: invalid-bonds [229.295772] Subtest invalid-bonds: SUCCESS (0.003s) [229.499346] [077/156] (778s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [229.603269] Starting subtest: yf-tiled-addfb-size-offset-overflow [229.604674] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [229.693250] [078/156] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [229.787785] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [229.789292] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [229.883655] [079/156] (778s left) syncobj_timeline (device-signal-unordered) [229.925454] Starting subtest: device-signal-unordered [229.926217] Subtest device-signal-unordered: SUCCESS (0.001s) [229.988294] [080/156] (778s left) perf_pmu (init-sema) [230.025811] Starting subtest: init-sema [230.026668] Starting dynamic subtest: rcs0 [230.027382] Dynamic subtest rcs0: SUCCESS (0.002s) [230.035578] Starting dynamic subtest: bcs0 [230.036293] Dynamic subtest bcs0: SUCCESS (0.000s) [230.044112] Starting dynamic subtest: vcs0 [230.044818] Dynamic subtest vcs0: SUCCESS (0.000s) [230.052411] Starting dynamic subtest: vcs1 [230.053108] Dynamic subtest vcs1: SUCCESS (0.001s) [230.060643] Starting dynamic subtest: vecs0 [230.061343] Dynamic subtest vecs0: SUCCESS (0.000s) [230.062039] Subtest init-sema: SUCCESS (0.008s) [230.136996] [081/156] (778s left) gem_exec_schedule (preempt-engines) [230.184104] Starting subtest: preempt-engines [230.184997] Starting dynamic subtest: rcs0 [230.267121] Dynamic subtest rcs0: SUCCESS (0.082s) [230.276173] Starting dynamic subtest: bcs0 [230.357895] Dynamic subtest bcs0: SUCCESS (0.089s) [230.367916] Starting dynamic subtest: vcs0 [230.456873] Dynamic subtest vcs0: SUCCESS (0.097s) [230.466944] Starting dynamic subtest: vcs1 [230.545584] Dynamic subtest vcs1: SUCCESS (0.087s) [230.556666] Starting dynamic subtest: vecs0 [230.639603] Dynamic subtest vecs0: SUCCESS (0.093s) [230.640466] Subtest preempt-engines: SUCCESS (0.456s) [230.938842] [082/156] (777s left) gem_ctx_shared (create-shared-gtt) [230.982434] Starting subtest: create-shared-gtt [233.139851] Subtest create-shared-gtt: SUCCESS (2.149s) [233.332925] [083/156] (775s left) gem_lmem_swapping (verify) [233.372111] Subtest verify: SKIP (0.000s) [233.413124] [084/156] (775s left) kms_ccs (random-ccs-data-y-tiled-ccs) [233.505029] Starting subtest: random-ccs-data-y-tiled-ccs [233.505770] Starting dynamic subtest: pipe-A-HDMI-A-1 [233.513220] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [233.521403] Starting dynamic subtest: pipe-B-HDMI-A-1 [233.528910] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [233.537014] Starting dynamic subtest: pipe-C-HDMI-A-1 [233.544466] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [233.552211] Starting dynamic subtest: pipe-D-HDMI-A-1 [233.560289] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [233.561677] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.007s) [233.813110] [085/156] (774s left) kms_cursor_crc (cursor-offscreen-64x21) [233.906868] Starting subtest: cursor-offscreen-64x21 [233.911114] Starting dynamic subtest: pipe-A-HDMI-A-1 [235.147071] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.235s) [235.183778] Starting dynamic subtest: pipe-D-HDMI-A-1 [236.400228] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.226s) [236.401079] Subtest cursor-offscreen-64x21: SUCCESS (2.494s) [236.547777] [086/156] (772s left) kms_psr (psr2-cursor-mmap-gtt) [236.646838] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s) [236.691674] [087/156] (772s left) kms_plane_alpha_blend (alpha-basic) [236.780085] Starting subtest: alpha-basic [236.848412] Starting dynamic subtest: pipe-A-HDMI-A-1 [238.157223] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.308s) [238.195369] Starting dynamic subtest: pipe-D-HDMI-A-1 [239.690407] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.505s) [239.691157] Subtest alpha-basic: SUCCESS (2.911s) [239.882473] [088/156] (769s left) kms_big_fb (4-tiled-addfb-size-overflow) [239.988881] Starting subtest: 4-tiled-addfb-size-overflow [239.990434] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s) [240.094214] [089/156] (768s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [240.189804] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [241.867523] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (1.677s) [242.000017] [090/156] (767s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [242.094197] Starting subtest: cursorB-vs-flipB-atomic [242.095639] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [242.164769] [091/156] (766s left) kms_psr (fbc-psr-cursor-mmap-gtt) [242.255662] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [242.299748] [092/156] (766s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [242.341227] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [242.342030] Starting dynamic subtest: smem [242.455188] Dynamic subtest smem: SUCCESS (0.113s) [242.456028] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.114s) [242.638846] [093/156] (766s left) gem_exec_flush (basic-wb-rw-before-default) [242.682288] Starting subtest: basic-wb-rw-before-default [248.109575] Subtest basic-wb-rw-before-default: SUCCESS (5.427s) [248.325806] [094/156] (760s left) kms_busy (basic-hang) [248.423097] Starting subtest: basic-hang [248.423826] Starting dynamic subtest: flip-pipe-A [248.760723] Dynamic subtest flip-pipe-A: SUCCESS (0.336s) [248.770946] Starting dynamic subtest: modeset-pipe-A [249.320978] Dynamic subtest modeset-pipe-A: SUCCESS (0.557s) [249.331401] Starting dynamic subtest: flip-pipe-D [249.620783] Dynamic subtest flip-pipe-D: SUCCESS (0.296s) [249.630639] Starting dynamic subtest: modeset-pipe-D [250.177695] Dynamic subtest modeset-pipe-D: SUCCESS (0.556s) [250.178549] Subtest basic-hang: SUCCESS (1.755s) [250.374992] [095/156] (758s left) i915_hangman (hangcheck-unterminated) [250.423498] Starting subtest: hangcheck-unterminated [259.943283] Subtest hangcheck-unterminated: SUCCESS (9.519s) [260.054236] [096/156] (749s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [260.149369] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [260.194368] [097/156] (749s left) syncobj_wait (single-wait-all-signaled) [260.231806] Starting subtest: single-wait-all-signaled [260.232563] Subtest single-wait-all-signaled: SUCCESS (0.000s) [260.304112] [098/156] (749s left) syncobj_wait (wait-all-interrupted) [260.338990] Starting subtest: wait-all-interrupted [260.446933] Subtest wait-all-interrupted: SUCCESS (0.107s) [260.529054] [099/156] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [260.628039] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [260.629398] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [260.716116] [100/156] (748s left) gem_exec_fence (syncobj-timeline-signal) [261.193688] Starting subtest: syncobj-timeline-signal [261.194518] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [261.377024] [101/156] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [261.470023] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [261.471415] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [261.578846] [102/156] (747s left) kms_lease (empty-lease) [261.670300] Starting subtest: empty-lease [261.672741] Starting dynamic subtest: pipe-A-HDMI-A-1 [261.673543] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [261.683451] Starting dynamic subtest: pipe-B-HDMI-A-1 [261.684198] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [261.692486] Starting dynamic subtest: pipe-C-HDMI-A-1 [261.693197] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [261.701336] Starting dynamic subtest: pipe-D-HDMI-A-1 [261.702030] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [261.702710] Subtest empty-lease: SUCCESS (0.015s) [261.769755] [103/156] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [261.864918] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [261.866358] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [261.944716] [104/156] (747s left) gem_exec_whisper (basic-contexts-forked) [261.990305] Starting subtest: basic-contexts-forked [264.617722] Subtest basic-contexts-forked: SUCCESS (2.619s) [264.817277] [105/156] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [264.914674] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [264.916114] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [265.011891] [106/156] (744s left) gem_workarounds (reset-context) [265.061556] Starting subtest: reset-context [265.072821] Subtest reset-context: SUCCESS (0.011s) [265.196022] [107/156] (744s left) sw_sync (sync_multi_consumer) [265.230386] Starting subtest: sync_multi_consumer [265.783353] Subtest sync_multi_consumer: SUCCESS (0.544s) [265.833419] [108/156] (744s left) kms_psr (fbc-pr-cursor-render) [265.924773] Subtest fbc-pr-cursor-render: SKIP (0.000s) [265.970944] [109/156] (743s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt) [266.065278] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt [266.066693] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [266.169369] [110/156] (743s left) prime_vgem (fence-flip-hang) [266.238476] Subtest fence-flip-hang: SKIP (0.000s) [266.346286] [111/156] (743s left) syncobj_timeline (invalid-query-zero-handles) [266.380608] Starting subtest: invalid-query-zero-handles [266.381473] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [266.461212] [112/156] (743s left) gem_exec_parallel (fds) [266.505305] Starting subtest: fds [266.506075] Starting dynamic subtest: rcs0 [271.308125] Dynamic subtest rcs0: SUCCESS (4.801s) [271.333697] Starting dynamic subtest: bcs0 [273.229587] Dynamic subtest bcs0: SUCCESS (1.919s) [273.240606] Starting dynamic subtest: vcs0 [275.117274] Dynamic subtest vcs0: SUCCESS (1.887s) [275.131738] Starting dynamic subtest: vcs1 [277.011207] Dynamic subtest vcs1: SUCCESS (1.893s) [277.021480] Starting dynamic subtest: vecs0 [278.966469] Dynamic subtest vecs0: SUCCESS (1.945s) [278.967510] Subtest fds: SUCCESS (12.452s) [279.147776] [113/156] (730s left) kms_pwrite_crc (basic) [279.240924] Starting subtest: basic [279.547264] Subtest basic: SUCCESS (0.306s) [279.707446] [114/156] (730s left) syncobj_wait (reset-multiple-signaled) [279.745384] Starting subtest: reset-multiple-signaled [279.746129] Subtest reset-multiple-signaled: SUCCESS (0.000s) [279.816126] [115/156] (730s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [279.912023] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [279.913447] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [280.015844] [116/156] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [280.114069] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [280.115553] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [280.203262] [117/156] (730s left) gem_mmap_wc (bad-object) [280.239469] Starting subtest: bad-object [280.240270] Subtest bad-object: SUCCESS (0.000s) [280.332280] [118/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [280.425724] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [280.427194] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [280.523140] [119/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [280.617187] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [280.618611] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [280.685672] [120/156] (729s left) kms_cursor_legacy (single-bo) [280.778122] Starting subtest: single-bo [280.778900] Starting dynamic subtest: pipe-A [286.167600] Dynamic subtest pipe-A: SUCCESS (5.380s) [286.176609] Starting dynamic subtest: pipe-B [291.572651] Dynamic subtest pipe-B: SUCCESS (5.379s) [291.582119] Starting dynamic subtest: pipe-C [296.952555] Dynamic subtest pipe-C: SUCCESS (5.379s) [296.962206] Starting dynamic subtest: pipe-D [302.307468] Dynamic subtest pipe-D: SUCCESS (5.379s) [302.316365] Starting dynamic subtest: all-pipes [307.687108] Dynamic subtest all-pipes: SUCCESS (5.379s) [307.687860] Subtest single-bo: SUCCESS (26.900s) [307.756809] [121/156] (702s left) gem_userptr_blits (map-fixed-invalidate-overlap) [307.804440] Starting subtest: map-fixed-invalidate-overlap [307.805201] Starting dynamic subtest: gtt [307.899436] Dynamic subtest gtt: SUCCESS (0.094s) [307.910263] Starting dynamic subtest: wb [307.962673] Dynamic subtest wb: SUCCESS (0.062s) [307.972180] Starting dynamic subtest: wc [308.022960] Dynamic subtest wc: SUCCESS (0.059s) [308.033683] Starting dynamic subtest: uc [308.084194] Dynamic subtest uc: SUCCESS (0.060s) [308.085006] Subtest map-fixed-invalidate-overlap: SUCCESS (0.280s) [308.193441] [122/156] (702s left) prime_mmap (test_map_unmap) [308.228395] Starting subtest: test_map_unmap [308.229167] Starting dynamic subtest: test_map_unmap-smem [308.229907] Dynamic subtest test_map_unmap-smem: SUCCESS (0.002s) [308.230748] Subtest test_map_unmap: SUCCESS (0.003s) [308.337806] [123/156] (702s left) kms_vrr (lobf) [308.429064] Starting subtest: lobf [308.430590] Subtest lobf: SKIP (0.000s) [308.502258] [124/156] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [308.597024] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [308.598533] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [308.669801] [125/156] (701s left) gem_set_tiling_vs_pwrite [308.780773] [126/156] (701s left) gem_mmap_gtt (basic-read) [308.815538] Starting subtest: basic-read [308.828377] Subtest basic-read: SUCCESS (0.013s) [308.927786] [127/156] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [309.022576] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [309.024042] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [309.131371] [128/156] (701s left) gem_lmem_swapping (heavy-verify-random) [309.170064] Subtest heavy-verify-random: SKIP (0.000s) [309.212454] [129/156] (701s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render) [309.306295] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render [309.307740] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [309.405285] [130/156] (701s left) gem_mmap_gtt (medium-copy-odd) [309.440009] Starting subtest: medium-copy-odd [312.976942] Subtest medium-copy-odd: SUCCESS (3.537s) [313.045500] [131/156] (697s left) gem_eio (in-flight-suspend) [313.132745] Starting subtest: in-flight-suspend [350.606497] Subtest in-flight-suspend: SUCCESS (7.705s) [358.759967] [132/156] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [358.860319] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [358.861756] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [358.959831] [133/156] (659s left) kms_draw_crc (draw-method-mmap-gtt) [359.049439] Starting subtest: draw-method-mmap-gtt [359.050210] Starting dynamic subtest: xrgb8888-untiled [359.204922] Dynamic subtest xrgb8888-untiled: SUCCESS (0.154s) [359.223808] Starting dynamic subtest: rgb565-untiled [359.372394] Dynamic subtest rgb565-untiled: SUCCESS (0.164s) [359.391531] Starting dynamic subtest: xrgb2101010-untiled [359.523065] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.147s) [359.538401] Starting dynamic subtest: xbgr16161616f-untiled [359.673858] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.146s) [359.692153] Starting dynamic subtest: xrgb8888-xtiled [359.757670] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.081s) [359.780261] Starting dynamic subtest: rgb565-xtiled [359.841391] Dynamic subtest rgb565-xtiled: SUCCESS (0.080s) [359.859930] Starting dynamic subtest: xrgb2101010-xtiled [359.916686] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.073s) [359.939761] Starting dynamic subtest: xbgr16161616f-xtiled [359.992103] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.072s) [360.012902] Starting dynamic subtest: xrgb8888-ytiled [360.075836] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.081s) [360.096933] Starting dynamic subtest: rgb565-ytiled [360.167963] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s) [360.188994] Starting dynamic subtest: xrgb2101010-ytiled [360.243311] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.073s) [360.262297] Starting dynamic subtest: xbgr16161616f-ytiled [360.352226] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.106s) [360.353492] Subtest draw-method-mmap-gtt: SUCCESS (1.297s) [360.462016] [134/156] (658s left) kms_flip (dpms-off-confusion-interruptible) [360.559263] Starting subtest: dpms-off-confusion-interruptible [360.562373] Starting dynamic subtest: A-HDMI-A1 [368.249795] Dynamic subtest A-HDMI-A1: SUCCESS (7.664s) [368.269371] Starting dynamic subtest: B-HDMI-A1 [375.900694] Dynamic subtest B-HDMI-A1: SUCCESS (7.634s) [375.913238] Starting dynamic subtest: C-HDMI-A1 [383.574174] Dynamic subtest C-HDMI-A1: SUCCESS (7.638s) [383.583795] Starting dynamic subtest: D-HDMI-A1 [391.219111] Dynamic subtest D-HDMI-A1: SUCCESS (7.640s) [391.219917] Subtest dpms-off-confusion-interruptible: SUCCESS (30.590s) [391.360188] [135/156] (627s left) kms_pm_dc (dc9-dpms) [392.462987] Starting subtest: dc9-dpms [395.788867] Subtest dc9-dpms: SKIP (3.292s) [395.868184] [136/156] (623s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [395.966045] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [395.966847] Starting dynamic subtest: pipe-A-valid-mode [397.261088] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.293s) [397.261902] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.295s) [397.421169] [137/156] (621s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt) [397.518949] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt [397.520403] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [397.610952] [138/156] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [397.705654] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [397.707187] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [397.789412] [139/156] (621s left) kms_atomic (plane-primary-overlay-mutable-zpos) [397.878121] Starting subtest: plane-primary-overlay-mutable-zpos [398.314957] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.435s) [398.492897] [140/156] (620s left) kms_big_fb (linear-64bpp-rotate-90) [398.595776] Starting subtest: linear-64bpp-rotate-90 [398.644457] Subtest linear-64bpp-rotate-90: SKIP (0.048s) [398.736597] [141/156] (620s left) kms_flip (2x-flip-vs-rmfb-interruptible) [398.831745] Starting subtest: 2x-flip-vs-rmfb-interruptible [398.841216] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.009s) [398.909501] [142/156] (620s left) syncobj_wait (invalid-reset-one-illegal-handle) [398.946149] Starting subtest: invalid-reset-one-illegal-handle [398.946938] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [399.009364] [143/156] (620s left) gem_create (busy-create) [399.049419] Starting subtest: busy-create [399.050119] Starting dynamic subtest: smem0 [431.308895] Dynamic subtest smem0: SUCCESS (32.255s) [431.313727] Subtest busy-create: SUCCESS (32.257s) [431.499523] [144/156] (587s left) api_intel_allocator (execbuf-with-allocator) [431.534860] Starting subtest: execbuf-with-allocator [431.536923] Subtest execbuf-with-allocator: SUCCESS (0.003s) [431.647404] [145/156] (587s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [431.749512] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [432.070345] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.320s) [432.212650] [146/156] (587s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [432.301240] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [432.301942] Starting dynamic subtest: pipe-A-HDMI-A-1 [432.308548] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [432.318378] Starting dynamic subtest: pipe-B-HDMI-A-1 [432.325111] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [432.334463] Starting dynamic subtest: pipe-C-HDMI-A-1 [432.341122] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [432.350473] Starting dynamic subtest: pipe-D-HDMI-A-1 [432.357571] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [432.359060] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.007s) [432.562858] [147/156] (586s left) gem_render_copy_redux (interruptible) [432.603582] Starting subtest: interruptible [432.942944] Subtest interruptible: SUCCESS (0.336s) [433.047334] [148/156] (586s left) gem_exec_schedule (u-semaphore-user) [433.094465] Starting subtest: u-semaphore-user [433.101248] Subtest u-semaphore-user: SUCCESS (0.007s) [433.418789] [149/156] (586s left) device_reset (unbind-cold-reset-rebind) [433.469415] Starting subtest: unbind-cold-reset-rebind [433.470887] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [433.541128] [150/156] (586s left) gem_ccs (block-multicopy-compressed) [433.579544] Starting subtest: block-multicopy-compressed [433.581111] Subtest block-multicopy-compressed: SKIP (0.000s) [433.661876] [151/156] (586s left) kms_color (deep-color) [433.753127] Starting subtest: deep-color [433.760234] Subtest deep-color: SKIP (0.002s) [433.820929] [152/156] (585s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [433.913701] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [433.915099] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [434.014649] [153/156] (585s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite) [434.107268] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite [434.108646] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [434.195485] [154/156] (585s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [434.232952] Starting subtest: etime-single-wait-for-submit-submitted [434.336059] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s) [434.425309] [155/156] (585s left) kms_psr (fbc-psr2-cursor-blt) [434.513859] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [434.559228] [156/156] (585s left) gem_ctx_shared (exec-single-timeline) [434.603263] Starting subtest: exec-single-timeline [434.604019] Starting dynamic subtest: rcs0 [435.615783] Dynamic subtest rcs0: SUCCESS (1.013s) [435.629695] Starting dynamic subtest: bcs0 [436.648772] Dynamic subtest bcs0: SUCCESS (1.022s) [436.659817] Starting dynamic subtest: vcs0 [437.672149] Dynamic subtest vcs0: SUCCESS (1.021s) [437.683128] Starting dynamic subtest: vcs1 [438.696208] Dynamic subtest vcs1: SUCCESS (1.021s) [438.707401] Starting dynamic subtest: vecs0 [439.720579] Dynamic subtest vecs0: SUCCESS (1.021s) [439.721570] Subtest exec-single-timeline: SUCCESS (5.109s) [439.894020] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: i915_drm_fdinfo results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_content_protection results: parsing output: 4/ for test: kms_chamelium_edid results: parsing output: 5/ for test: gen9_exec_parse results: parsing output: 6/ for test: drm_read results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_getfb results: parsing output: 9/ for test: kms_async_flips results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_userptr_blits results: parsing output: 12/ for test: gem_exec_balancer results: parsing output: 13/ for test: kms_flip_event_leak results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_sequence results: parsing output: 16/ for test: gem_ppgtt 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_fence_thrash results: parsing output: 20/ for test: kms_pm_rpm results: parsing output: 21/ for test: i915_pm_rps results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_ctx_persistence results: parsing output: 24/ for test: gem_fenced_exec_thrash results: parsing output: 25/ for test: sysfs_timeslice_duration results: parsing output: 26/ for test: i915_query results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: kms_chamelium_hpd results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_linear_blits results: parsing output: 32/ for test: prime_vgem results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_plane results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_render_copy results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: vgem_basic results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_exec_reloc results: parsing output: 50/ for test: kms_lease results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: sw_sync results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_cursor_legacy results: parsing output: 56/ for test: kms_atomic_transition results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: api_intel_bb results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: prime_vgem results: parsing output: 63/ for test: kms_force_connector_basic results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: gem_spin_batch results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_plane_scaling results: parsing output: 72/ for test: kms_cursor_crc results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: perf_pmu results: parsing output: 75/ for test: gem_exec_balancer results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: perf_pmu results: parsing output: 80/ for test: gem_exec_schedule results: parsing output: 81/ for test: gem_ctx_shared results: parsing output: 82/ for test: gem_lmem_swapping results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_plane_alpha_blend results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_cursor_legacy results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: gem_render_copy results: parsing output: 92/ for test: gem_exec_flush results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: i915_hangman results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: syncobj_wait results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_fence results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_lease results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_whisper results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_workarounds results: parsing output: 106/ for test: sw_sync results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: prime_vgem results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_exec_parallel results: parsing output: 112/ for test: kms_pwrite_crc results: parsing output: 113/ for test: syncobj_wait results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_mmap_wc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: gem_userptr_blits results: parsing output: 121/ for test: prime_mmap results: parsing output: 122/ for test: kms_vrr results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_set_tiling_vs_pwrite results: parsing output: 125/ for test: gem_mmap_gtt results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_lmem_swapping results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: gem_eio results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_draw_crc results: parsing output: 133/ for test: kms_flip results: parsing output: 134/ for test: kms_pm_dc results: parsing output: 135/ for test: kms_flip_scaled_crc results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_atomic results: parsing output: 139/ for test: kms_big_fb results: parsing output: 140/ for test: kms_flip results: parsing output: 141/ for test: syncobj_wait results: parsing output: 142/ for test: gem_create results: parsing output: 143/ for test: api_intel_allocator results: parsing output: 144/ for test: kms_big_fb results: parsing output: 145/ for test: kms_ccs results: parsing output: 146/ for test: gem_render_copy_redux results: parsing output: 147/ for test: gem_exec_schedule results: parsing output: 148/ for test: device_reset results: parsing output: 149/ for test: gem_ccs results: parsing output: 150/ for test: kms_color results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: syncobj_timeline results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: gem_ctx_shared Done.