[66.577793] Initializing watchdogs [66.577863] /dev/watchdog0 [66.599433] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [66.610583] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [66.614289] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [66.616714] [001/156] (960s left) gem_exec_balancer (bonded-false-hang) [67.180769] Starting subtest: bonded-false-hang [67.182680] Subtest bonded-false-hang: SKIP (0.000s) [67.746215] [002/156] (959s left) kms_psr (fbc-pr-sprite-mmap-cpu) [69.313038] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [69.360026] [003/156] (957s left) gem_userptr_blits (sync-unmap-after-close) [69.454415] Starting subtest: sync-unmap-after-close [69.475358] Subtest sync-unmap-after-close: SUCCESS (0.021s) [69.662611] [004/156] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [71.180499] Starting subtest: yf-tiled-32bpp-rotate-90 [71.182421] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [71.342665] [005/156] (956s left) i915_pm_rc6_residency (rc6-idle) [71.442028] Starting subtest: rc6-idle [71.464522] Starting dynamic subtest: gt0-rcs0 [95.850714] Dynamic subtest gt0-rcs0: SUCCESS (24.385s) [95.861999] Starting dynamic subtest: gt0-bcs0 [120.285364] Dynamic subtest gt0-bcs0: SUCCESS (24.433s) [120.297054] Starting dynamic subtest: gt0-vcs0 [144.661331] Dynamic subtest gt0-vcs0: SUCCESS (24.376s) [144.671525] Starting dynamic subtest: gt0-vecs0 [169.047616] Dynamic subtest gt0-vecs0: SUCCESS (24.385s) [169.057386] Starting dynamic subtest: gt0-ccs0 [193.459961] Dynamic subtest gt0-ccs0: SUCCESS (24.411s) [193.462231] Subtest rc6-idle: SUCCESS (122.018s) [193.625856] [006/156] (833s left) kms_draw_crc (draw-method-mmap-gtt) [195.131479] Starting subtest: draw-method-mmap-gtt [195.133337] Subtest draw-method-mmap-gtt: SKIP (0.000s) [195.253986] [007/156] (832s left) kms_frontbuffer_tracking (pipe-fbc-rte) [196.791010] Starting subtest: pipe-fbc-rte [196.796871] Subtest pipe-fbc-rte: SKIP (0.000s) [196.985914] [008/156] (830s left) gem_mmap_gtt (flink-race) [197.067304] Subtest flink-race: SKIP (0.000s) [197.132120] [009/156] (830s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [198.650438] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [198.652140] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [198.861789] [010/156] (828s left) sysfs_heartbeat_interval (nopreempt) [198.946581] Starting subtest: nopreempt [198.947537] Starting dynamic subtest: vecs0 [203.252352] Dynamic subtest vecs0: SUCCESS (4.305s) [203.262997] Starting dynamic subtest: ccs0 [207.523650] Dynamic subtest ccs0: SUCCESS (4.271s) [207.534176] Starting dynamic subtest: vcs0 [211.723225] Dynamic subtest vcs0: SUCCESS (4.199s) [211.733337] Starting dynamic subtest: bcs0 [215.897104] Dynamic subtest bcs0: SUCCESS (4.173s) [215.907364] Starting dynamic subtest: vecs1 [220.104134] Dynamic subtest vecs1: SUCCESS (4.207s) [220.114929] Starting dynamic subtest: rcs0 [224.406387] Dynamic subtest rcs0: SUCCESS (4.302s) [224.417059] Starting dynamic subtest: vcs1 [228.611509] Dynamic subtest vcs1: SUCCESS (4.205s) [228.612656] Subtest nopreempt: SUCCESS (29.664s) [228.756630] [011/156] (799s left) syncobj_timeline (invalid-transfer-bad-pad) [228.831170] Starting subtest: invalid-transfer-bad-pad [228.832137] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [228.970491] [012/156] (798s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt) [230.481560] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt [230.483256] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [230.610502] [013/156] (797s left) sriov_basic (enable-vfs-bind-unbind-each) [230.708085] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s) [230.817426] [014/156] (797s left) gem_ctx_bad_destroy (invalid-ctx) [230.888599] Starting subtest: invalid-ctx [230.889514] Subtest invalid-ctx: SUCCESS (0.000s) [230.980483] [015/156] (797s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [232.535422] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [232.659259] [016/156] (795s left) syncobj_eventfd (timeline-wait) [232.746388] Starting subtest: timeline-wait [232.756162] Subtest timeline-wait: SUCCESS (0.011s) [232.897357] [017/156] (795s left) gem_exec_params (invalid-bsd-ring) [232.972385] Starting subtest: invalid-bsd-ring [232.973309] Subtest invalid-bsd-ring: SUCCESS (0.000s) [233.120050] [018/156] (795s left) kms_big_fb (x-tiled-64bpp-rotate-90) [234.636428] Starting subtest: x-tiled-64bpp-rotate-90 [234.704301] Subtest x-tiled-64bpp-rotate-90: SKIP (0.067s) [234.941238] [019/156] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [236.454040] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [236.455787] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [236.588797] [020/156] (791s left) gen9_exec_parse (bb-large) [236.691658] Subtest bb-large: SKIP (0.000s) [236.763753] [021/156] (791s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [238.276481] Starting subtest: primary-x-tiled-reflect-x-180 [248.697557] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.421s) [248.936279] [022/156] (779s left) kms_prop_blob (invalid-set-prop-any) [249.009143] Starting subtest: invalid-set-prop-any [249.010370] Subtest invalid-set-prop-any: SUCCESS (0.000s) [249.201642] [023/156] (779s left) gem_exec_schedule (preempt-queue) [249.286642] Subtest preempt-queue: SKIP (0.000s) [249.668514] [024/156] (779s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [251.173479] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [251.174415] Starting dynamic subtest: pipe-A-HDMI-A-3 [254.804721] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.615s) [254.821207] Starting dynamic subtest: pipe-B-HDMI-A-3 [255.314381] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.504s) [255.341065] Starting dynamic subtest: pipe-C-HDMI-A-3 [255.856665] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.538s) [255.871708] Starting dynamic subtest: pipe-D-HDMI-A-3 [256.382895] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.521s) [256.384930] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.193s) [256.638572] [025/156] (772s left) kms_atomic_transition (plane-all-modeset-transition) [258.145439] Starting subtest: plane-all-modeset-transition [258.146311] Starting dynamic subtest: pipe-A-HDMI-A-3 [272.765281] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (14.618s) [272.819045] Starting dynamic subtest: pipe-B-HDMI-A-3 [283.956959] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (11.151s) [283.975952] Subtest plane-all-modeset-transition: SUCCESS (25.830s) [284.171951] [026/156] (744s left) i915_hangman (detector) [284.260117] Starting subtest: detector [284.261045] Starting dynamic subtest: rcs0 [294.191373] Dynamic subtest rcs0: SUCCESS (9.932s) [294.202471] Starting dynamic subtest: bcs0 [304.146419] Dynamic subtest bcs0: SUCCESS (9.954s) [304.157854] Starting dynamic subtest: vcs0 [313.227509] Dynamic subtest vcs0: SUCCESS (9.080s) [313.239894] Starting dynamic subtest: vcs1 [323.173389] Dynamic subtest vcs1: SUCCESS (9.945s) [323.184264] Starting dynamic subtest: vecs0 [333.166382] Dynamic subtest vecs0: SUCCESS (9.992s) [333.177499] Starting dynamic subtest: vecs1 [343.184371] Dynamic subtest vecs1: SUCCESS (10.017s) [343.196376] Starting dynamic subtest: ccs0 [353.212378] Dynamic subtest ccs0: SUCCESS (10.027s) [353.213350] Subtest detector: SUCCESS (68.952s) [353.423513] [027/156] (675s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [354.935069] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [354.936894] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [355.084843] [028/156] (673s left) syncobj_wait (multi-wait-submitted-signaled) [355.186552] Starting subtest: multi-wait-submitted-signaled [355.187467] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [355.317566] [029/156] (673s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt) [356.829425] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt [356.831170] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [356.949421] [030/156] (672s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [358.474511] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [358.475406] Starting dynamic subtest: pipe-A [358.553511] Dynamic subtest pipe-A: SUCCESS (0.080s) [358.566497] Starting dynamic subtest: pipe-B [358.698118] Dynamic subtest pipe-B: SUCCESS (0.144s) [358.714063] Starting dynamic subtest: pipe-C [358.858280] Dynamic subtest pipe-C: SUCCESS (0.160s) [358.871323] Starting dynamic subtest: pipe-D [358.999294] Dynamic subtest pipe-D: SUCCESS (0.140s) [359.000349] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.526s) [359.229632] [031/156] (670s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [360.742597] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [360.744334] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [360.848600] [032/156] (668s left) gem_exec_schedule (u-independent) [360.956998] Starting subtest: u-independent [360.958053] Starting dynamic subtest: rcs0 [361.338343] Dynamic subtest rcs0: SUCCESS (0.381s) [361.349397] Starting dynamic subtest: bcs0 [361.625401] Dynamic subtest bcs0: SUCCESS (0.286s) [361.641661] Starting dynamic subtest: vcs0 [361.925463] Dynamic subtest vcs0: SUCCESS (0.299s) [361.938969] Starting dynamic subtest: vcs1 [362.213479] Dynamic subtest vcs1: SUCCESS (0.287s) [362.225140] Starting dynamic subtest: vecs0 [362.504454] Dynamic subtest vecs0: SUCCESS (0.290s) [362.522462] Starting dynamic subtest: vecs1 [362.811388] Dynamic subtest vecs1: SUCCESS (0.306s) [362.823134] Starting dynamic subtest: ccs0 [363.107414] Dynamic subtest ccs0: SUCCESS (0.295s) [363.108547] Subtest u-independent: SUCCESS (2.151s) [363.491812] [033/156] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [365.001362] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [365.003160] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [365.202589] [034/156] (664s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [366.728299] Starting subtest: pixel-format-y-tiled-ccs-modifier [366.730151] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [366.830138] [035/156] (662s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [368.365983] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [368.367951] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [368.486872] [036/156] (661s left) sw_sync (sync_busy) [368.554014] Starting subtest: sync_busy [368.557181] Subtest sync_busy: SUCCESS (0.003s) [368.637571] [037/156] (661s left) gem_fence_thrash (bo-copy) [368.680432] Starting subtest: bo-copy [368.709053] Subtest bo-copy: SKIP (0.027s) [368.786609] [038/156] (660s left) i915_suspend (debugfs-reader) [368.866180] Starting subtest: debugfs-reader [390.311406] Subtest debugfs-reader: SUCCESS (5.789s) [394.876230] [039/156] (639s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [396.421305] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [396.422770] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [396.542077] [040/156] (637s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [398.533768] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [398.535527] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [398.768988] [041/156] (635s left) kms_psr (fbc-psr2-dpms) [400.315834] Subtest fbc-psr2-dpms: SKIP (0.000s) [400.368537] [042/156] (634s left) gem_exec_reloc (basic-cpu-read-active) [400.454018] Subtest basic-cpu-read-active: SKIP (0.000s) [400.540376] [043/156] (634s left) perf (gen12-mi-rpc) [400.952018] Starting subtest: gen12-mi-rpc [400.952970] Starting dynamic subtest: rcs0 [401.011494] Dynamic subtest rcs0: SUCCESS (0.058s) [401.012431] Subtest gen12-mi-rpc: SUCCESS (0.059s) [401.067589] [044/156] (633s left) kms_flip (2x-wf_vblank-ts-check) [402.642713] Starting subtest: 2x-wf_vblank-ts-check [402.654818] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s) [402.788410] [045/156] (631s left) gem_eio (execbuf) [403.106399] Starting subtest: execbuf [403.574083] Subtest execbuf: SUCCESS (0.461s) [405.133412] [046/156] (629s left) kms_big_fb (y-tiled-8bpp-rotate-270) [406.685252] Starting subtest: y-tiled-8bpp-rotate-270 [406.687192] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [406.810013] [047/156] (628s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render) [408.352777] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render [408.354532] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [408.511408] [048/156] (626s left) gem_spin_batch (legacy-resubmit-new) [408.629800] Starting subtest: legacy-resubmit-new [408.630877] Starting dynamic subtest: default [408.664459] Dynamic subtest default: SUCCESS (0.034s) [408.677985] Starting dynamic subtest: render [408.678962] Dynamic subtest render: SUCCESS (0.005s) [408.692262] Starting dynamic subtest: bsd [408.693224] Dynamic subtest bsd: SUCCESS (0.006s) [408.706594] Starting dynamic subtest: bsd1 [408.707692] Dynamic subtest bsd1: SUCCESS (0.004s) [408.720667] Starting dynamic subtest: bsd2 [408.721643] Dynamic subtest bsd2: SUCCESS (0.004s) [408.734341] Starting dynamic subtest: blt [408.735592] Dynamic subtest blt: SUCCESS (0.004s) [408.748117] Starting dynamic subtest: vebox [408.749245] Dynamic subtest vebox: SUCCESS (0.005s) [408.750250] Subtest legacy-resubmit-new: SUCCESS (0.068s) [408.990893] [049/156] (626s left) i915_query (query-topology-matches-eu-total) [409.061038] Starting subtest: query-topology-matches-eu-total [409.062020] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [409.224140] [050/156] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [410.742806] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [410.744690] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [410.876684] [051/156] (624s left) syncobj_timeline (multi-wait-submitted-signaled) [410.973209] Starting subtest: multi-wait-submitted-signaled [410.974151] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [411.120002] [052/156] (624s left) kms_properties (get_properties-sanity-non-atomic) [412.632749] Starting subtest: get_properties-sanity-non-atomic [412.633720] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [412.737730] [053/156] (622s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [412.828908] Starting subtest: etime-single-wait-for-submit-submitted [412.933222] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s) [413.077712] [054/156] (622s left) gem_create (create-ext-cpu-access-big) [413.267973] Starting subtest: create-ext-cpu-access-big [415.439192] Subtest create-ext-cpu-access-big: FAIL (2.155s) [416.379399] [055/156] (619s left) gem_exec_whisper (basic-contexts-forked) [416.463238] Starting subtest: basic-contexts-forked [439.010014] Subtest basic-contexts-forked: SUCCESS (22.525s) [439.304738] [056/156] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [440.814998] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [440.816769] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [440.960766] [057/156] (594s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [442.492355] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [442.493258] Starting dynamic subtest: pipe-A-HDMI-A-3 [442.501850] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [442.516210] Starting dynamic subtest: pipe-B-HDMI-A-3 [442.524797] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [442.538532] Starting dynamic subtest: pipe-C-HDMI-A-3 [442.547992] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [442.562350] Starting dynamic subtest: pipe-D-HDMI-A-3 [442.572974] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [442.575385] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [442.793787] [058/156] (592s left) kms_content_protection (dp-mst-lic-type-1) [444.367007] Starting subtest: dp-mst-lic-type-1 [444.369110] Subtest dp-mst-lic-type-1: SKIP (0.000s) [444.568085] [059/156] (591s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [446.081744] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [446.083389] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [446.244321] [060/156] (589s left) gem_mmap (bad-object) [446.333099] Subtest bad-object: SKIP (0.000s) [446.411889] [061/156] (589s left) gem_mmap_gtt (bad-object) [446.482904] Subtest bad-object: SKIP (0.000s) [446.565820] [062/156] (589s left) kms_cursor_crc (cursor-offscreen-128x128) [448.260920] Starting subtest: cursor-offscreen-128x128 [448.264545] Starting dynamic subtest: pipe-A-HDMI-A-3 [450.794474] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.529s) [450.839414] Starting dynamic subtest: pipe-D-HDMI-A-3 [453.244956] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.417s) [453.246098] Subtest cursor-offscreen-128x128: SUCCESS (4.982s) [453.613493] [063/156] (582s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [455.122463] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [455.123379] Starting dynamic subtest: pipe-A-HDMI-A-3 [455.132110] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [455.146206] Starting dynamic subtest: pipe-B-HDMI-A-3 [455.155192] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [455.168706] Starting dynamic subtest: pipe-C-HDMI-A-3 [455.178068] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [455.191839] Starting dynamic subtest: pipe-D-HDMI-A-3 [455.201859] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [455.203968] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [455.444520] [064/156] (580s left) kms_getfb (getfb2-into-addfb2) [456.951804] Starting subtest: getfb2-into-addfb2 [456.952737] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [457.124928] [065/156] (579s left) kms_pm_rpm (dpms-lpsp) [460.791959] Starting subtest: dpms-lpsp [460.795519] Subtest dpms-lpsp: SKIP (0.001s) [461.717070] [066/156] (574s left) kms_async_flips (alternate-sync-async-flip) [463.235757] Starting subtest: alternate-sync-async-flip [463.471443] Starting dynamic subtest: pipe-A-HDMI-A-3 [465.764808] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.292s) [465.967851] Starting dynamic subtest: pipe-B-HDMI-A-3 [468.048444] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.092s) [468.230487] Starting dynamic subtest: pipe-C-HDMI-A-3 [470.320533] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.102s) [470.497561] Starting dynamic subtest: pipe-D-HDMI-A-3 [472.588174] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.102s) [472.595779] Subtest alternate-sync-async-flip: SUCCESS (9.350s) [473.018162] [067/156] (563s left) gem_eio (wait-10ms) [473.330085] Starting subtest: wait-10ms [473.957998] Subtest wait-10ms: SUCCESS (0.628s) [475.500915] [068/156] (560s left) kms_vblank (wait-idle) [477.022036] Starting subtest: wait-idle [477.023002] Starting dynamic subtest: pipe-A-HDMI-A-3 [479.283999] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.260s) [479.300035] Starting dynamic subtest: pipe-D-HDMI-A-3 [481.469513] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.181s) [481.470415] Subtest wait-idle: SUCCESS (4.447s) [481.642852] [069/156] (554s left) gem_exec_flush (basic-wb-ro-default) [481.722162] Subtest basic-wb-ro-default: SKIP (0.000s) [481.799771] [070/156] (554s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [483.312073] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [483.313896] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [483.445160] [071/156] (553s left) gem_exec_params (sol-reset-invalid) [483.545014] Starting subtest: sol-reset-invalid [483.547288] Subtest sol-reset-invalid: SUCCESS (0.002s) [483.737774] [072/156] (553s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [485.250851] Starting subtest: psr-indfb-scaledprimary [485.252723] Subtest psr-indfb-scaledprimary: SKIP (0.000s) [485.368958] [073/156] (551s left) gem_ctx_persistence (engines-mixed-process) [485.465823] Starting subtest: engines-mixed-process [485.466831] Starting dynamic subtest: rcs0 [487.529973] Dynamic subtest rcs0: SUCCESS (2.064s) [487.546356] Starting dynamic subtest: bcs0 [489.514042] Dynamic subtest bcs0: SUCCESS (1.984s) [489.530607] Starting dynamic subtest: vcs0 [491.569136] Dynamic subtest vcs0: SUCCESS (2.055s) [491.585403] Starting dynamic subtest: vcs1 [493.549202] Dynamic subtest vcs1: SUCCESS (1.979s) [493.565237] Starting dynamic subtest: vecs0 [495.532454] Dynamic subtest vecs0: SUCCESS (1.982s) [495.548852] Starting dynamic subtest: vecs1 [497.567829] Dynamic subtest vecs1: SUCCESS (2.034s) [497.584318] Starting dynamic subtest: ccs0 [499.552828] Dynamic subtest ccs0: SUCCESS (1.984s) [499.553900] Subtest engines-mixed-process: SUCCESS (14.093s) [499.689930] [074/156] (537s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [499.777404] Starting subtest: yf-tiled-ccs-to-y-tiled [499.779687] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [500.008224] [075/156] (536s left) kms_cursor_crc (cursor-tearing-position-change) [501.563385] Starting subtest: cursor-tearing-position-change [501.565804] Starting dynamic subtest: pipe-A-HDMI-A-3 [502.056713] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.491s) [502.071614] Starting dynamic subtest: pipe-D-HDMI-A-3 [502.423020] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.365s) [502.424054] Subtest cursor-tearing-position-change: SUCCESS (0.860s) [502.987074] [076/156] (534s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite) [504.501764] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite [504.503542] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [504.636437] [077/156] (532s left) kms_flip (dpms-vs-vblank-race-interruptible) [506.174190] Starting subtest: dpms-vs-vblank-race-interruptible [506.179263] Starting dynamic subtest: A-HDMI-A3 [509.270280] Dynamic subtest A-HDMI-A3: SUCCESS (3.090s) [509.286604] Starting dynamic subtest: B-HDMI-A3 [512.228454] Dynamic subtest B-HDMI-A3: SUCCESS (2.957s) [512.243780] Starting dynamic subtest: C-HDMI-A3 [515.165615] Dynamic subtest C-HDMI-A3: SUCCESS (2.936s) [515.180241] Starting dynamic subtest: D-HDMI-A3 [518.114832] Dynamic subtest D-HDMI-A3: SUCCESS (2.947s) [518.115876] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.941s) [518.329934] [078/156] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y) [519.849732] Starting subtest: fbcpsrhdr-tiling-y [519.851428] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s) [520.059283] [079/156] (517s left) gem_exec_fence (basic-busy) [520.266473] Starting subtest: basic-busy [520.267871] Starting dynamic subtest: rcs0 [520.383700] Dynamic subtest rcs0: SUCCESS (0.118s) [520.403379] Starting dynamic subtest: bcs0 [520.437549] Dynamic subtest bcs0: SUCCESS (0.052s) [520.457605] Starting dynamic subtest: vcs0 [520.492371] Dynamic subtest vcs0: SUCCESS (0.053s) [520.520013] Starting dynamic subtest: vcs1 [520.550088] Dynamic subtest vcs1: SUCCESS (0.056s) [520.565201] Starting dynamic subtest: vecs0 [520.602208] Dynamic subtest vecs0: SUCCESS (0.051s) [520.629780] Starting dynamic subtest: vecs1 [520.656402] Dynamic subtest vecs1: SUCCESS (0.053s) [520.688383] Starting dynamic subtest: ccs0 [520.710188] Dynamic subtest ccs0: SUCCESS (0.052s) [520.711371] Subtest basic-busy: SUCCESS (0.447s) [521.511360] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [521.513812] [080/156] (515s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [523.041827] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [524.325328] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.282s) [524.548513] [081/156] (512s left) kms_big_fb (linear-64bpp-rotate-180) [526.074787] Starting subtest: linear-64bpp-rotate-180 [528.325268] Subtest linear-64bpp-rotate-180: SUCCESS (2.250s) [528.525116] [082/156] (509s left) kms_addfb_basic (tile-pitch-mismatch) [528.603580] Starting subtest: tile-pitch-mismatch [528.605331] Subtest tile-pitch-mismatch: SKIP (0.000s) [530.193599] [083/156] (507s left) kms_cursor_legacy (forked-move) [531.741009] Starting subtest: forked-move [531.742027] Starting dynamic subtest: pipe-A [537.168285] Dynamic subtest pipe-A: SUCCESS (5.425s) [537.196155] Starting dynamic subtest: pipe-B [542.597577] Dynamic subtest pipe-B: SUCCESS (5.425s) [542.630230] Starting dynamic subtest: pipe-C [548.038356] Dynamic subtest pipe-C: SUCCESS (5.437s) [548.080641] Starting dynamic subtest: pipe-D [553.478482] Dynamic subtest pipe-D: SUCCESS (5.436s) [553.513423] Starting dynamic subtest: all-pipes [558.912116] Dynamic subtest all-pipes: SUCCESS (5.430s) [558.913084] Subtest forked-move: SUCCESS (27.165s) [559.047178] [084/156] (478s left) kms_lease (empty-lease) [560.560972] Starting subtest: empty-lease [560.561952] Starting dynamic subtest: pipe-A-HDMI-A-3 [560.564245] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s) [560.581538] Starting dynamic subtest: pipe-B-HDMI-A-3 [560.582368] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.002s) [560.597280] Starting dynamic subtest: pipe-C-HDMI-A-3 [560.598329] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s) [560.613053] Starting dynamic subtest: pipe-D-HDMI-A-3 [560.614389] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s) [560.615278] Subtest empty-lease: SUCCESS (0.016s) [560.689886] [085/156] (477s left) kms_plane_multiple (tiling-4) [562.208034] Starting subtest: tiling-4 [562.209071] Starting dynamic subtest: pipe-A-HDMI-A-3 [563.089782] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.881s) [563.104715] Starting dynamic subtest: pipe-B-HDMI-A-3 [563.876862] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.786s) [563.893906] Starting dynamic subtest: pipe-C-HDMI-A-3 [564.670033] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.790s) [564.684720] Starting dynamic subtest: pipe-D-HDMI-A-3 [565.453900] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.783s) [565.454916] Subtest tiling-4: SUCCESS (3.247s) [565.679731] [086/156] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [567.203766] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [567.205569] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [567.376873] [087/156] (470s left) sw_sync (sync_merge_invalid) [567.437004] Starting subtest: sync_merge_invalid [567.485245] Subtest sync_merge_invalid: SUCCESS (0.048s) [567.580070] [088/156] (470s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [569.094061] Starting subtest: flip-vs-cursor-busy-crc-atomic [569.683024] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.588s) [569.923520] [089/156] (468s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [571.438075] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [573.353006] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.914s) [573.559512] [090/156] (464s left) kms_async_flips (test-time-stamp) [575.076561] Starting subtest: test-time-stamp [575.315903] Starting dynamic subtest: pipe-A-HDMI-A-3 [575.628689] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.312s) [575.830345] Starting dynamic subtest: pipe-B-HDMI-A-3 [575.935898] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.117s) [576.118481] Starting dynamic subtest: pipe-C-HDMI-A-3 [576.223907] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.117s) [576.419138] Starting dynamic subtest: pipe-D-HDMI-A-3 [576.523484] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.117s) [576.524357] Subtest test-time-stamp: SUCCESS (1.448s) [576.896002] [091/156] (461s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [578.421925] Starting subtest: psr-2p-scndscrn-cur-indfb-move [578.423751] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [578.552615] [092/156] (459s left) gem_eio (in-flight-contexts-10ms) [578.869300] Starting subtest: in-flight-contexts-10ms [592.589785] Subtest in-flight-contexts-10ms: SUCCESS (13.716s) [594.129802] [093/156] (444s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [595.668970] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [598.354828] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.686s) [598.624605] [094/156] (439s left) syncobj_timeline (single-wait-for-submit-available-signaled) [598.706237] Starting subtest: single-wait-for-submit-available-signaled [598.707325] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [598.810205] [095/156] (439s left) kms_addfb_basic (bad-pitch-999) [598.889611] Starting subtest: bad-pitch-999 [598.890595] Subtest bad-pitch-999: SUCCESS (0.000s) [600.520164] [096/156] (438s left) gem_partial_pwrite_pread (write-uncached) [600.613124] Subtest write-uncached: SKIP (0.000s) [600.718833] [097/156] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [602.238725] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [602.240396] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [602.476450] [098/156] (436s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [604.016947] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [606.724629] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.708s) [606.918766] [099/156] (432s left) kms_psr (fbc-psr-cursor-render) [608.439509] Subtest fbc-psr-cursor-render: SKIP (0.000s) [608.507176] [100/156] (430s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt) [610.030111] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt [610.031890] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [610.180345] [101/156] (428s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [611.717999] Starting subtest: cursorA-vs-flipB-legacy [611.719825] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [611.817308] [102/156] (427s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [613.355464] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [613.357314] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [613.528581] [103/156] (425s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render) [615.058072] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render [615.059902] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [615.231863] [104/156] (424s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [616.771719] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [616.773509] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [616.997683] [105/156] (422s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [618.521607] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [618.523431] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [618.691404] [106/156] (420s left) kms_atomic_interruptible (legacy-setmode) [620.219051] Starting subtest: legacy-setmode [620.220158] Starting dynamic subtest: pipe-A-HDMI-A-3 [626.399545] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.181s) [626.400527] Subtest legacy-setmode: SUCCESS (6.183s) [626.601748] [107/156] (413s left) i915_drm_fdinfo (idle) [626.674143] Starting subtest: idle [626.675077] Starting dynamic subtest: rcs0 [627.282905] Dynamic subtest rcs0: SUCCESS (0.608s) [627.302562] Starting dynamic subtest: bcs0 [627.792069] Dynamic subtest bcs0: SUCCESS (0.505s) [627.808700] Starting dynamic subtest: vcs0 [628.298585] Dynamic subtest vcs0: SUCCESS (0.503s) [628.315403] Starting dynamic subtest: vcs1 [628.804389] Dynamic subtest vcs1: SUCCESS (0.503s) [628.819000] Starting dynamic subtest: vecs0 [629.309948] Dynamic subtest vecs0: SUCCESS (0.503s) [629.326651] Starting dynamic subtest: vecs1 [629.819143] Dynamic subtest vecs1: SUCCESS (0.503s) [629.833837] Starting dynamic subtest: ccs0 [630.323405] Dynamic subtest ccs0: SUCCESS (0.503s) [630.326792] Subtest idle: SUCCESS (3.652s) [630.488041] [108/156] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [632.008998] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [632.010829] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [632.179332] [109/156] (407s left) kms_lease (lease-get) [633.708031] Starting subtest: lease-get [633.709024] Starting dynamic subtest: pipe-A-HDMI-A-3 [633.709909] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s) [633.727039] Starting dynamic subtest: pipe-B-HDMI-A-3 [633.728007] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.003s) [633.742687] Starting dynamic subtest: pipe-C-HDMI-A-3 [633.743968] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s) [633.758200] Starting dynamic subtest: pipe-D-HDMI-A-3 [633.759344] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s) [633.760472] Subtest lease-get: SUCCESS (0.016s) [633.874083] [110/156] (406s left) kms_chamelium_audio (dp-audio) [635.477610] Subtest dp-audio: SKIP (0.000s) [635.661868] [111/156] (404s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [637.192928] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [637.194721] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [637.355351] [112/156] (402s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [637.456820] Starting subtest: y-tiled-to-vebox-yf-tiled [637.459016] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [637.713140] [113/156] (402s left) kms_pipe_crc_basic (nonblocking-crc) [639.233968] Starting subtest: nonblocking-crc [639.234977] Starting dynamic subtest: pipe-A-HDMI-A-3 [639.953357] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.718s) [639.968608] Starting dynamic subtest: pipe-B-HDMI-A-3 [640.497354] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.543s) [640.515179] Starting dynamic subtest: pipe-C-HDMI-A-3 [641.063493] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.564s) [641.080747] Starting dynamic subtest: pipe-D-HDMI-A-3 [641.596274] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.531s) [641.597278] Subtest nonblocking-crc: SUCCESS (2.364s) [641.804193] [114/156] (398s left) gem_exec_fence (syncobj-timeline-invalid-wait) [642.515397] Starting subtest: syncobj-timeline-invalid-wait [642.516778] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.009s) [642.825281] [115/156] (397s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [644.345190] Starting subtest: plane-scaler-with-clipping-clamping-rotation [644.346126] Starting dynamic subtest: pipe-A [644.766699] Dynamic subtest pipe-A: SUCCESS (0.422s) [644.813758] Starting dynamic subtest: pipe-B [645.208767] Dynamic subtest pipe-B: SUCCESS (0.439s) [645.240199] Starting dynamic subtest: pipe-C [645.632984] Dynamic subtest pipe-C: SUCCESS (0.422s) [645.665310] Starting dynamic subtest: pipe-D [646.057429] Dynamic subtest pipe-D: SUCCESS (0.423s) [646.058578] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.714s) [646.309751] [116/156] (394s left) perf_pmu (render-node-busy-idle) [646.420670] Starting subtest: render-node-busy-idle [646.421638] Starting dynamic subtest: rcs0 [647.142980] Dynamic subtest rcs0: SUCCESS (0.722s) [647.161973] Starting dynamic subtest: bcs0 [647.805542] Dynamic subtest bcs0: SUCCESS (0.660s) [647.857301] Starting dynamic subtest: vcs0 [648.488338] Dynamic subtest vcs0: SUCCESS (0.678s) [648.512198] Starting dynamic subtest: vcs1 [649.152562] Dynamic subtest vcs1: SUCCESS (0.659s) [649.176009] Starting dynamic subtest: vecs0 [649.820373] Dynamic subtest vecs0: SUCCESS (0.663s) [649.843882] Starting dynamic subtest: vecs1 [650.488521] Dynamic subtest vecs1: SUCCESS (0.663s) [650.511267] Starting dynamic subtest: ccs0 [651.154601] Dynamic subtest ccs0: SUCCESS (0.661s) [651.160956] Subtest render-node-busy-idle: SUCCESS (4.737s) [651.269313] [117/156] (389s left) kms_cursor_crc (cursor-rapid-movement-512x512) [653.070855] Starting subtest: cursor-rapid-movement-512x512 [653.072769] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [653.349952] [118/156] (387s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [654.875976] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [654.878018] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [655.000408] [119/156] (385s left) gem_ctx_persistence (hang) [655.107328] Starting subtest: hang [655.109257] Subtest hang: SKIP (0.000s) [655.315380] [120/156] (385s left) kms_psr (psr2-cursor-mmap-cpu) [656.835205] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [656.896788] [121/156] (383s left) gem_userptr_blits (sync-overlap) [656.990137] Starting subtest: sync-overlap [656.991138] Subtest sync-overlap: SUCCESS (0.000s) [657.183134] [122/156] (383s left) gem_ccs (block-multicopy-compressed) [657.270678] Starting subtest: block-multicopy-compressed [657.271601] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [657.317326] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.046s) [657.333373] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [657.428769] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.110s) [657.444892] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [657.445909] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [657.460675] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [657.556891] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.110s) [657.573205] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [657.574152] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [657.589030] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [657.685367] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.110s) [657.701983] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [657.703226] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s) [657.719383] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [657.814044] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.110s) [657.815009] Subtest block-multicopy-compressed: SUCCESS (0.544s) [657.959839] [123/156] (383s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [659.478378] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [659.546993] [124/156] (381s left) kms_properties (plane-properties-atomic) [661.061128] Starting subtest: plane-properties-atomic [661.062081] Starting dynamic subtest: pipe-A-HDMI-A-3 [661.503327] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.442s) [661.521089] Starting dynamic subtest: pipe-B-HDMI-A-3 [661.954777] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.449s) [661.970019] Starting dynamic subtest: pipe-C-HDMI-A-3 [662.383949] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.427s) [662.399214] Starting dynamic subtest: pipe-D-HDMI-A-3 [662.834368] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.450s) [662.835278] Subtest plane-properties-atomic: SUCCESS (1.775s) [663.048523] [125/156] (378s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt) [664.569837] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt [664.571808] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [664.817433] [126/156] (376s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [666.338797] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [666.340619] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [666.562712] [127/156] (374s left) gem_exec_async (forked-writes) [666.653686] Starting subtest: forked-writes [666.654665] Starting dynamic subtest: rcs0 [666.717656] Dynamic subtest rcs0: SUCCESS (0.063s) [666.736347] Starting dynamic subtest: bcs0 [666.756481] Dynamic subtest bcs0: SUCCESS (0.038s) [666.774144] Starting dynamic subtest: vcs0 [666.794216] Dynamic subtest vcs0: SUCCESS (0.036s) [666.810508] Starting dynamic subtest: vcs1 [666.830220] Dynamic subtest vcs1: SUCCESS (0.035s) [666.847496] Starting dynamic subtest: vecs0 [666.867571] Dynamic subtest vecs0: SUCCESS (0.036s) [666.883740] Starting dynamic subtest: vecs1 [666.902862] Dynamic subtest vecs1: SUCCESS (0.034s) [666.919893] Starting dynamic subtest: ccs0 [666.938463] Dynamic subtest ccs0: SUCCESS (0.034s) [666.939367] Subtest forked-writes: SUCCESS (0.285s) [667.288297] [128/156] (374s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [668.802033] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [668.802979] Starting dynamic subtest: pipe-A-valid-mode [670.421840] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.619s) [670.422810] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (1.620s) [670.639739] [129/156] (370s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [672.160777] Starting subtest: fbc-2p-primscrn-spr-indfb-move [672.162596] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [672.315157] [130/156] (369s left) kms_vblank (accuracy-idle) [673.856072] Starting subtest: accuracy-idle [673.857059] Starting dynamic subtest: pipe-A-HDMI-A-3 [676.117988] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.260s) [676.134607] Starting dynamic subtest: pipe-D-HDMI-A-3 [678.316761] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.196s) [678.317738] Subtest accuracy-idle: SUCCESS (4.462s) [678.515789] [131/156] (363s left) gem_exec_reloc (basic-gtt) [678.600900] Subtest basic-gtt: SKIP (0.000s) [678.689331] [132/156] (363s left) api_intel_allocator (simple-allocator) [678.767527] Starting subtest: simple-allocator [678.768422] Starting dynamic subtest: basic [678.801464] Dynamic subtest basic: SUCCESS (0.035s) [678.818021] Starting dynamic subtest: parallel-one [678.985348] Dynamic subtest parallel-one: SUCCESS (0.183s) [679.000229] Starting dynamic subtest: print [679.001193] Dynamic subtest print: SUCCESS (0.000s) [679.016331] Starting dynamic subtest: reuse [679.017361] Dynamic subtest reuse: SUCCESS (0.000s) [679.031906] Starting dynamic subtest: reserve [679.033038] Dynamic subtest reserve: SUCCESS (0.000s) [679.047472] Starting dynamic subtest: fork-reopen-allocator [679.048619] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [679.049593] Subtest simple-allocator: SUCCESS (0.238s) [679.150279] [133/156] (362s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [680.672851] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [680.674782] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s) [680.831191] [134/156] (361s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [682.375036] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [682.375988] Starting dynamic subtest: pipe-A-HDMI-A-3 [682.384803] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [682.399826] Starting dynamic subtest: pipe-B-HDMI-A-3 [682.408967] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [682.423557] Starting dynamic subtest: pipe-C-HDMI-A-3 [682.433384] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [682.447997] Starting dynamic subtest: pipe-D-HDMI-A-3 [682.458383] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [682.460419] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s) [682.692982] [135/156] (359s left) drm_read (short-buffer-wakeup) [684.289333] Starting subtest: short-buffer-wakeup [716.505159] Subtest short-buffer-wakeup: SUCCESS (32.213s) [716.681658] [136/156] (325s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite) [718.208925] Starting subtest: fbchdr-rgb565-draw-pwrite [718.210790] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s) [718.363639] [137/156] (323s left) kms_color (deep-color) [719.901995] Starting subtest: deep-color [719.910793] Subtest deep-color: SKIP (0.002s) [720.004553] [138/156] (322s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [721.538375] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [721.608513] [139/156] (320s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [723.128093] Starting subtest: hdr-rgb565-draw-mmap-cpu [723.129889] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [723.281292] [140/156] (319s left) kms_flip (2x-busy-flip) [724.817251] Starting subtest: 2x-busy-flip [724.830378] Subtest 2x-busy-flip: SKIP (0.013s) [724.937363] [141/156] (317s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [726.467937] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [726.469816] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [726.610643] [142/156] (315s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [728.157797] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [728.159628] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [728.398017] [143/156] (314s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [729.913321] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [729.914207] Starting dynamic subtest: pipe-A-valid-mode [734.604055] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.689s) [734.605051] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.691s) [734.805917] [144/156] (307s left) gem_exec_fence (syncobj-timeline-wait) [735.498860] Starting subtest: syncobj-timeline-wait [735.601990] Subtest syncobj-timeline-wait: SUCCESS (0.103s) [735.903039] [145/156] (306s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt) [737.423834] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt [737.425690] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [737.559754] [146/156] (305s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [740.193745] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [740.195784] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [740.336224] [147/156] (302s left) gem_partial_pwrite_pread (reads-snoop) [740.422063] Subtest reads-snoop: SKIP (0.000s) [740.496789] [148/156] (302s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [742.056566] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [742.198018] [149/156] (300s left) gem_huc_copy (huc-copy) [742.315665] Starting subtest: huc-copy [742.323117] Subtest huc-copy: SUCCESS (0.007s) [742.504530] [150/156] (300s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [744.027014] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [744.028936] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [744.262551] [151/156] (299s left) kms_prop_blob (invalid-get-prop-any) [744.349818] Starting subtest: invalid-get-prop-any [744.351007] Subtest invalid-get-prop-any: SUCCESS (0.000s) [744.489820] [152/156] (298s left) core_auth (getclient-master-drop) [744.540005] Starting subtest: getclient-master-drop [744.587103] Subtest getclient-master-drop: SUCCESS (0.049s) [744.749519] [153/156] (298s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [746.271078] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [746.272887] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [746.425009] [154/156] (297s left) gem_userptr_blits (probe) [746.548236] Starting subtest: probe [746.682127] Subtest probe: SUCCESS (0.126s) [746.844635] [155/156] (296s left) kms_psr (psr2-primary-mmap-gtt) [748.366197] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [748.437486] [156/156] (295s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [749.967079] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [749.968836] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [750.089092] Closing watchdogs results: parsing output: 0/ for test: gem_exec_balancer results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: gem_userptr_blits results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: i915_pm_rc6_residency results: parsing output: 5/ for test: kms_draw_crc results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: sysfs_heartbeat_interval results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: sriov_basic results: parsing output: 13/ for test: gem_ctx_bad_destroy results: parsing output: 14/ for test: kms_chamelium_edid results: parsing output: 15/ for test: syncobj_eventfd results: parsing output: 16/ for test: gem_exec_params results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gen9_exec_parse results: parsing output: 20/ for test: kms_rotation_crc results: parsing output: 21/ for test: kms_prop_blob results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: kms_atomic_transition results: parsing output: 25/ for test: i915_hangman results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: syncobj_wait results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_schedule results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_plane results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: sw_sync results: parsing output: 36/ for test: gem_fence_thrash results: parsing output: 37/ for test: i915_suspend results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: gem_eio results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_spin_batch results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_properties results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: gem_create results: parsing output: 54/ for test: gem_exec_whisper results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_content_protection results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_mmap results: parsing output: 60/ for test: gem_mmap_gtt results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_getfb results: parsing output: 64/ for test: kms_pm_rpm results: parsing output: 65/ for test: kms_async_flips results: parsing output: 66/ for test: gem_eio results: parsing output: 67/ for test: kms_vblank results: parsing output: 68/ for test: gem_exec_flush results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_exec_params results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_ctx_persistence results: parsing output: 73/ for test: gem_render_copy results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_exec_fence results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: kms_plane_multiple results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: sw_sync results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: kms_cursor_legacy results: parsing output: 89/ for test: kms_async_flips results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_eio results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_addfb_basic results: parsing output: 95/ for test: gem_partial_pwrite_pread results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_atomic_interruptible results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_lease results: parsing output: 109/ for test: kms_chamelium_audio results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_render_copy results: parsing output: 112/ for test: kms_pipe_crc_basic results: parsing output: 113/ for test: gem_exec_fence results: parsing output: 114/ for test: kms_plane_scaling results: parsing output: 115/ for test: perf_pmu results: parsing output: 116/ for test: kms_cursor_crc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_ctx_persistence results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: gem_userptr_blits results: parsing output: 121/ for test: gem_ccs results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: kms_properties results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_async results: parsing output: 127/ for test: kms_flip_scaled_crc results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_vblank results: parsing output: 130/ for test: gem_exec_reloc results: parsing output: 131/ for test: api_intel_allocator results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_ccs results: parsing output: 134/ for test: drm_read results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_color results: parsing output: 137/ for test: kms_psr_stress_test results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_flip results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_flip_scaled_crc results: parsing output: 143/ for test: gem_exec_fence results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_pxp results: parsing output: 146/ for test: gem_partial_pwrite_pread results: parsing output: 147/ for test: kms_chamelium_hpd results: parsing output: 148/ for test: gem_huc_copy results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_prop_blob results: parsing output: 151/ for test: core_auth results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: gem_userptr_blits results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.