[60.380523] Initializing watchdogs [60.380567] /dev/watchdog0 [60.402127] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.406594] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.408876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.411007] [001/156] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [60.511499] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [61.602198] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.091s) [61.728805] [002/156] (959s left) syncobj_wait (wait-zero-handles) [61.779031] Starting subtest: wait-zero-handles [61.780036] Subtest wait-zero-handles: SUCCESS (0.000s) [61.888175] [003/156] (959s left) api_intel_bb (object-reloc-purge-cache) [61.933062] Starting subtest: object-reloc-purge-cache [61.936641] Subtest object-reloc-purge-cache: SKIP (0.003s) [62.043049] [004/156] (958s left) gem_exec_balancer (individual) [62.115198] Starting subtest: individual [64.334361] Subtest individual: SUCCESS (2.210s) [64.663046] [005/156] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [64.758994] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [64.761053] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [64.864814] [006/156] (956s left) gem_userptr_blits (invalid-mmap-offset-unsync) [64.918746] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [65.037705] [007/156] (956s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [65.095468] Starting subtest: yf-tiled-ccs-to-y-tiled [65.097449] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [65.271123] [008/156] (955s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [65.368399] Starting subtest: crc-primary-basic-yf-tiled-ccs [65.369427] Starting dynamic subtest: pipe-A-eDP-1 [65.378335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [65.386044] Starting dynamic subtest: pipe-B-eDP-1 [65.394738] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [65.401475] Starting dynamic subtest: pipe-C-eDP-1 [65.410097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [65.416803] Starting dynamic subtest: pipe-D-eDP-1 [65.425200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [65.426828] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s) [67.678615] [009/156] (953s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt) [67.774536] Starting subtest: hdr-rgb565-draw-mmap-gtt [67.776247] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [67.871201] [010/156] (953s left) gem_render_copy (linear) [67.926839] Starting subtest: linear [67.928434] Starting dynamic subtest: smem [67.967972] Dynamic subtest smem: SUCCESS (0.041s) [67.969273] Subtest linear: SUCCESS (0.042s) [68.142976] [011/156] (953s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt) [68.236046] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt [68.237827] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [68.319487] [012/156] (952s left) kms_pipe_stress (stress-xrgb8888-ytiled) [68.412062] Starting subtest: stress-xrgb8888-ytiled [68.413867] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [68.468281] [013/156] (952s left) gem_ctx_persistence (heartbeat-close) [68.519058] Starting subtest: heartbeat-close [68.521388] Subtest heartbeat-close: SKIP (0.000s) [68.619866] [014/156] (952s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt) [68.713776] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt [68.715955] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [68.806514] [015/156] (952s left) kms_pm_backlight (fade-with-dpms) [68.889181] Starting subtest: fade-with-dpms [71.057153] Starting dynamic subtest: eDP-1 [74.091381] Dynamic subtest eDP-1: SUCCESS (3.026s) [74.092269] Subtest fade-with-dpms: SUCCESS (5.195s) [74.941882] [016/156] (946s left) syncobj_timeline (multi-wait-all-signaled) [74.984782] Starting subtest: multi-wait-all-signaled [74.985672] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [75.072955] [017/156] (946s left) kms_chamelium_audio (dp-audio-edid) [75.454059] Subtest dp-audio-edid: SKIP (0.000s) [76.248494] [018/156] (945s left) gem_mmap_gtt (medium-copy-odd) [76.306208] Subtest medium-copy-odd: SKIP (0.000s) [76.366834] [019/156] (945s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [76.457566] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [76.459369] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [76.537758] [020/156] (944s left) gem_exec_params (invalid-batch-start-offset) [76.594687] Starting subtest: invalid-batch-start-offset [76.598392] Subtest invalid-batch-start-offset: SUCCESS (0.003s) [76.715108] [021/156] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [76.803219] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [76.805080] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [76.900028] [022/156] (944s left) perf_pmu (enable-race) [76.938082] Starting subtest: enable-race [76.939028] Starting dynamic subtest: rcs0 [89.716487] Dynamic subtest rcs0: SUCCESS (12.768s) [89.724383] Starting dynamic subtest: bcs0 [102.457477] Dynamic subtest bcs0: SUCCESS (12.737s) [102.465287] Starting dynamic subtest: vcs0 [118.310596] Dynamic subtest vcs0: SUCCESS (15.852s) [118.320905] Starting dynamic subtest: vcs1 [134.309087] Dynamic subtest vcs1: SUCCESS (15.997s) [134.318069] Starting dynamic subtest: vecs0 [150.309089] Dynamic subtest vecs0: SUCCESS (15.999s) [150.318050] Starting dynamic subtest: ccs0 [163.058447] Dynamic subtest ccs0: SUCCESS (12.745s) [163.059276] Subtest enable-race: SUCCESS (86.105s) [163.151386] [023/156] (858s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [163.241943] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [163.252032] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [163.304680] [024/156] (858s left) gem_ppgtt (blt-vs-render-ctxn) [163.368608] Starting subtest: blt-vs-render-ctxN [196.250880] Subtest blt-vs-render-ctxN: SUCCESS (32.871s) [196.360072] [025/156] (825s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [196.500215] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [196.501902] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [196.581766] [026/156] (825s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [196.626479] Starting subtest: multi-wait-all-for-submit-unsubmitted [196.728755] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [196.808359] [027/156] (824s left) kms_psr (psr2-sprite-mmap-gtt) [196.890426] Starting subtest: psr2-sprite-mmap-gtt [196.891319] Starting dynamic subtest: eDP-1 [198.383650] Dynamic subtest eDP-1: SKIP (1.483s) [198.385683] Subtest psr2-sprite-mmap-gtt: SKIP (1.484s) [198.514691] [028/156] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [198.607889] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [205.697798] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.091s) [205.853547] [029/156] (815s left) gem_exec_fence (syncobj-timeline-signal) [206.456852] Starting subtest: syncobj-timeline-signal [206.458266] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [207.406782] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [207.408793] [030/156] (814s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [207.495139] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt [207.496638] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [207.621764] [031/156] (814s left) syncobj_wait (multi-wait-submitted-signaled) [207.667462] Starting subtest: multi-wait-submitted-signaled [207.668526] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [207.744674] [032/156] (814s left) kms_big_fb (linear-8bpp-rotate-270) [207.842693] Starting subtest: linear-8bpp-rotate-270 [207.864854] Subtest linear-8bpp-rotate-270: SKIP (0.022s) [207.962785] [033/156] (813s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [208.067138] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [208.068037] Starting dynamic subtest: pipe-A-eDP-1 [208.089787] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [208.098262] Starting dynamic subtest: pipe-B-eDP-1 [208.119168] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [208.127512] Starting dynamic subtest: pipe-C-eDP-1 [208.149367] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [208.157164] Starting dynamic subtest: pipe-D-eDP-1 [208.179830] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [208.181642] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [210.407899] [034/156] (811s left) kms_cursor_legacy (forked-bo) [210.526257] Starting subtest: forked-bo [210.527044] Starting dynamic subtest: pipe-A [215.991831] Dynamic subtest pipe-A: SUCCESS (5.459s) [216.009458] Starting dynamic subtest: pipe-B [221.468374] Dynamic subtest pipe-B: SUCCESS (5.475s) [221.485053] Starting dynamic subtest: pipe-C [226.977872] Dynamic subtest pipe-C: SUCCESS (5.471s) [226.989723] Starting dynamic subtest: pipe-D [232.460424] Dynamic subtest pipe-D: SUCCESS (5.482s) [232.476962] Starting dynamic subtest: all-pipes [237.969413] Dynamic subtest all-pipes: SUCCESS (5.509s) [237.970451] Subtest forked-bo: SUCCESS (27.401s) [238.065541] [035/156] (783s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [238.149419] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [238.150354] Starting dynamic subtest: pipe-A-default-mode [240.943883] Dynamic subtest pipe-A-default-mode: SUCCESS (2.794s) [240.944783] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.795s) [241.793195] [036/156] (780s left) kms_addfb_basic (legacy-format) [241.843902] Starting subtest: legacy-format [241.871117] Subtest legacy-format: SUCCESS (0.026s) [242.003930] [037/156] (780s left) kms_plane (pixel-format-x-tiled-modifier) [242.094268] Starting subtest: pixel-format-x-tiled-modifier [242.121673] Starting dynamic subtest: pipe-A-plane-0 [242.510390] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s) [242.519383] Starting dynamic subtest: pipe-A-plane-3 [242.843897] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s) [242.852126] Starting dynamic subtest: pipe-A-plane-5 [242.853942] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [243.991741] Starting dynamic subtest: pipe-B-plane-0 [244.382668] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [244.391607] Starting dynamic subtest: pipe-B-plane-3 [244.693722] Dynamic subtest pipe-B-plane-3: SUCCESS (0.311s) [244.702849] Starting dynamic subtest: pipe-B-plane-5 [244.705425] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [245.002432] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.908s) [245.854356] [038/156] (776s left) gem_ccs (ctrl-surf-copy) [245.901043] Starting subtest: ctrl-surf-copy [245.903057] Subtest ctrl-surf-copy: SKIP (0.000s) [245.995384] [039/156] (776s left) kms_psr (psr2-basic) [246.094743] Starting subtest: psr2-basic [246.095683] Starting dynamic subtest: eDP-1 [247.720940] Dynamic subtest eDP-1: SUCCESS (1.627s) [247.721926] Subtest psr2-basic: SUCCESS (1.628s) [248.525093] [040/156] (773s left) kms_big_fb (4-tiled-16bpp-rotate-0) [248.632446] Starting subtest: 4-tiled-16bpp-rotate-0 [249.944967] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.313s) [250.064035] [041/156] (772s left) gem_lmem_swapping (parallel-random-verify-ccs) [250.101165] Subtest parallel-random-verify-ccs: SKIP (0.000s) [250.135812] [042/156] (772s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [250.229381] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [250.230436] Starting dynamic subtest: pipe-A [250.569145] Dynamic subtest pipe-A: SUCCESS (0.340s) [250.578307] Starting dynamic subtest: pipe-B [252.040677] Dynamic subtest pipe-B: SUCCESS (1.471s) [252.049093] Starting dynamic subtest: pipe-C [253.460184] Dynamic subtest pipe-C: SUCCESS (1.419s) [253.468923] Starting dynamic subtest: pipe-D [254.895196] Dynamic subtest pipe-D: SUCCESS (1.434s) [254.896204] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.667s) [256.060183] [043/156] (766s left) kms_big_fb (y-tiled-8bpp-rotate-270) [256.150365] Starting subtest: y-tiled-8bpp-rotate-270 [256.152133] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [256.237678] [044/156] (766s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [256.343060] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [274.756062] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.413s) [275.629986] [045/156] (746s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt) [275.723611] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt [275.725375] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [275.822735] [046/156] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [275.921109] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [275.922653] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [276.020289] [047/156] (746s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff) [276.109990] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff [276.111894] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [276.196936] [048/156] (746s left) gem_exec_whisper (basic-queues-forked) [276.250271] Starting subtest: basic-queues-forked [299.522938] Subtest basic-queues-forked: SUCCESS (23.259s) [299.694267] [049/156] (722s left) perf (invalid-remove-userspace-config) [299.822563] Starting subtest: invalid-remove-userspace-config [299.832275] Subtest invalid-remove-userspace-config: SUCCESS (0.011s) [299.870318] [050/156] (722s left) syncobj_eventfd (timeline-wait-before-signal) [299.926934] Starting subtest: timeline-wait-before-signal [299.958933] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [300.033025] [051/156] (722s left) kms_psr2_su (frontbuffer-xrgb8888) [300.081958] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [300.142525] [052/156] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [300.230767] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [300.232798] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [300.336412] [053/156] (722s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [300.416121] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [300.418366] Starting dynamic subtest: A-eDP1 [304.058717] Dynamic subtest A-eDP1: SUCCESS (3.640s) [304.067583] Starting dynamic subtest: B-eDP1 [307.275722] Dynamic subtest B-eDP1: SUCCESS (3.216s) [307.284602] Starting dynamic subtest: C-eDP1 [310.510054] Dynamic subtest C-eDP1: SUCCESS (3.233s) [310.518769] Starting dynamic subtest: D-eDP1 [313.729928] Dynamic subtest D-eDP1: SUCCESS (3.218s) [313.731838] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.315s) [314.534852] [054/156] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [314.622465] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [321.741390] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.120s) [321.896423] [055/156] (700s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [321.942030] Starting subtest: wait-all-for-submit-delayed-submit [322.045626] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [322.121585] [056/156] (700s left) gem_exec_schedule (preempt-other) [322.186374] Starting subtest: preempt-other [322.187343] Starting dynamic subtest: rcs0 [322.259804] Dynamic subtest rcs0: SUCCESS (0.073s) [322.268854] Starting dynamic subtest: bcs0 [322.332733] Dynamic subtest bcs0: SUCCESS (0.072s) [322.344945] Starting dynamic subtest: vcs0 [322.403647] Dynamic subtest vcs0: SUCCESS (0.070s) [322.416036] Starting dynamic subtest: vcs1 [322.469958] Dynamic subtest vcs1: SUCCESS (0.065s) [322.484660] Starting dynamic subtest: vecs0 [322.535362] Dynamic subtest vecs0: SUCCESS (0.064s) [322.548618] Starting dynamic subtest: ccs0 [322.604039] Dynamic subtest ccs0: SUCCESS (0.068s) [322.605740] Subtest preempt-other: SUCCESS (0.417s) [323.442204] [057/156] (699s left) syncobj_timeline (multi-wait-signaled) [323.485179] Starting subtest: multi-wait-signaled [323.486114] Subtest multi-wait-signaled: SUCCESS (0.000s) [323.589912] [058/156] (699s left) gem_pwrite (basic-exhaustion) [323.633808] Subtest basic-exhaustion: SKIP (0.000s) [323.687737] [059/156] (699s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite) [323.776573] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite [323.778223] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [323.881266] [060/156] (698s left) sw_sync (sync_merge_same) [323.915351] Starting subtest: sync_merge_same [323.916401] Subtest sync_merge_same: SUCCESS (0.000s) [323.965842] [061/156] (698s left) i915_suspend (basic-s2idle-without-i915) [323.993413] Starting subtest: basic-s2idle-without-i915 [346.724528] Subtest basic-s2idle-without-i915: SUCCESS (7.580s) [351.889083] [062/156] (676s left) kms_psr (fbc-pr-sprite-plane-move) [351.983246] Starting subtest: fbc-pr-sprite-plane-move [351.985251] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [352.051079] [063/156] (675s left) core_setmaster (master-drop-set-user) [352.141420] Starting subtest: master-drop-set-user [352.155878] Subtest master-drop-set-user: SUCCESS (0.015s) [352.190827] [064/156] (675s left) gem_exec_reloc (basic-gtt-wc-active) [352.246093] Subtest basic-gtt-wc-active: SKIP (0.000s) [352.323765] [065/156] (675s left) gem_mmap_gtt (big-copy-odd) [352.375106] Subtest big-copy-odd: SKIP (0.000s) [352.430748] [066/156] (675s left) i915_pm_freq_api (freq-basic-api) [352.484606] Starting subtest: freq-basic-api [352.485800] Starting dynamic subtest: gt0 [352.488417] Dynamic subtest gt0: SUCCESS (0.003s) [352.497517] Starting dynamic subtest: gt1 [352.498377] Dynamic subtest gt1: SUCCESS (0.002s) [352.499253] Subtest freq-basic-api: SUCCESS (0.007s) [352.599771] [067/156] (675s left) perf_pmu (busy-accuracy-98) [352.633304] Starting subtest: busy-accuracy-98 [352.634173] Starting dynamic subtest: rcs0 [355.682473] Dynamic subtest rcs0: SUCCESS (3.040s) [355.694595] Starting dynamic subtest: bcs0 [358.733068] Dynamic subtest bcs0: SUCCESS (3.046s) [358.744726] Starting dynamic subtest: vcs0 [361.780934] Dynamic subtest vcs0: SUCCESS (3.043s) [361.791754] Starting dynamic subtest: vcs1 [364.821107] Dynamic subtest vcs1: SUCCESS (3.036s) [364.833549] Starting dynamic subtest: vecs0 [367.864668] Dynamic subtest vecs0: SUCCESS (3.041s) [367.876096] Starting dynamic subtest: ccs0 [370.919766] Dynamic subtest ccs0: SUCCESS (3.052s) [370.920920] Subtest busy-accuracy-98: SUCCESS (18.271s) [371.042206] [068/156] (657s left) i915_pm_rpm (debugfs-read) [372.677387] Starting subtest: debugfs-read [373.835664] Subtest debugfs-read: SUCCESS (1.159s) [374.221664] [069/156] (654s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt) [374.311167] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt [374.313013] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [374.397941] [070/156] (653s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [374.494797] Starting subtest: crc-primary-suspend-y-tiled-ccs [374.495703] Starting dynamic subtest: pipe-A-eDP-1 [374.499139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [374.507903] Starting dynamic subtest: pipe-B-eDP-1 [374.511334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [374.519425] Starting dynamic subtest: pipe-C-eDP-1 [374.523052] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [374.531353] Starting dynamic subtest: pipe-D-eDP-1 [374.535288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [374.537167] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [376.773355] [071/156] (651s left) kms_content_protection (dp-mst-type-0) [376.907158] Starting subtest: dp-mst-type-0 [376.909400] Subtest dp-mst-type-0: SKIP (0.000s) [377.010580] [072/156] (651s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff) [377.099982] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff [377.101750] Subtest hdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [377.198520] [073/156] (651s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [377.313721] Starting subtest: flip-vs-cursor-busy-crc-legacy [378.039128] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.725s) [378.903136] [074/156] (649s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc) [378.992449] Starting subtest: psrhdr-rgb565-draw-mmap-wc [378.994189] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [379.075709] [075/156] (649s left) kms_frontbuffer_tracking (fbc-tiling-linear) [379.159748] Starting subtest: fbc-tiling-linear [382.951059] Subtest fbc-tiling-linear: SUCCESS (3.791s) [384.116717] [076/156] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [384.205056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [384.206703] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [384.292069] [077/156] (644s left) prime_vgem (busy) [384.352022] Starting subtest: busy [384.352917] Starting dynamic subtest: rcs0 [384.395999] Dynamic subtest rcs0: SUCCESS (0.045s) [384.404876] Starting dynamic subtest: bcs0 [384.458136] Dynamic subtest bcs0: SUCCESS (0.061s) [384.467856] Starting dynamic subtest: vcs0 [384.504861] Dynamic subtest vcs0: SUCCESS (0.046s) [384.513819] Starting dynamic subtest: vcs1 [384.548932] Dynamic subtest vcs1: SUCCESS (0.043s) [384.557814] Starting dynamic subtest: vecs0 [384.594680] Dynamic subtest vecs0: SUCCESS (0.045s) [384.603530] Starting dynamic subtest: ccs0 [384.641255] Dynamic subtest ccs0: SUCCESS (0.046s) [384.642008] Subtest busy: SUCCESS (0.291s) [384.746253] [078/156] (643s left) gem_close (basic) [384.801675] Starting subtest: basic [384.802663] Subtest basic: SUCCESS (0.000s) [384.900424] [079/156] (643s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt) [384.989057] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt [384.990782] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [385.101007] [080/156] (643s left) kms_pm_rpm (basic-pci-d3-state) [386.633745] Starting subtest: basic-pci-d3-state [388.114499] Subtest basic-pci-d3-state: SUCCESS (1.484s) [388.210232] [081/156] (640s left) kms_psr (fbc-psr-sprite-blt) [388.300458] Starting subtest: fbc-psr-sprite-blt [388.301473] Starting dynamic subtest: eDP-1 [388.303398] Dynamic subtest eDP-1: SKIP (0.000s) [388.305212] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [388.368577] [082/156] (640s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [388.470897] Starting subtest: 4-tiled-addfb-size-offset-overflow [388.471739] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [388.568511] [083/156] (640s left) gem_mmap_wc (close) [388.624227] Subtest close: SKIP (0.000s) [388.689462] [084/156] (640s left) gem_exec_schedule (smoketest-all) [388.748396] Starting subtest: smoketest-all [421.099246] Subtest smoketest-all: SUCCESS (32.321s) [422.555353] [085/156] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [422.661563] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [426.278052] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.617s) [427.484925] [086/156] (601s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [427.537249] Starting subtest: invalid-multi-wait-all-unsubmitted [427.538372] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [427.633581] [087/156] (601s left) kms_pm_rpm (modeset-pc8-residency-stress) [429.551447] Starting subtest: modeset-pc8-residency-stress [429.553678] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [429.927726] [088/156] (598s left) gem_exec_balancer (persistence) [430.190939] Starting subtest: persistence [431.192126] Subtest persistence: SUCCESS (0.998s) [431.300398] [089/156] (597s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [431.408959] Starting subtest: 2x-cursor-vs-flip-legacy [431.410884] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [431.550192] [090/156] (597s left) kms_flip (2x-dpms-vs-vblank-race) [431.637294] Starting subtest: 2x-dpms-vs-vblank-race [431.648838] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [431.741090] [091/156] (597s left) gem_ctx_shared (disjoint-timelines) [431.796229] Starting subtest: disjoint-timelines [431.825662] Subtest disjoint-timelines: SUCCESS (0.029s) [432.050451] [092/156] (596s left) kms_sequence (queue-busy) [432.131402] Starting subtest: queue-busy [432.132279] Starting dynamic subtest: pipe-A-eDP-1 [434.063018] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s) [434.073289] Starting dynamic subtest: pipe-B-eDP-1 [436.639123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s) [436.648493] Starting dynamic subtest: pipe-C-eDP-1 [439.250536] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s) [439.259697] Starting dynamic subtest: pipe-D-eDP-1 [441.898857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s) [441.899765] Subtest queue-busy: SUCCESS (9.765s) [442.768565] [093/156] (586s left) kms_setmode (basic-clone-single-crtc) [442.819871] Starting subtest: basic-clone-single-crtc [442.822620] Subtest basic-clone-single-crtc: SKIP (0.000s) [442.930041] [094/156] (586s left) kms_joiner (basic-ultra-joiner) [443.016458] Starting subtest: basic-ultra-joiner [443.018129] Subtest basic-ultra-joiner: SKIP (0.000s) [443.084952] [095/156] (586s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render) [443.191899] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render [443.193521] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [443.301212] [096/156] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [443.391455] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [443.392943] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [443.493501] [097/156] (585s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [443.584707] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [443.586510] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [443.682919] [098/156] (585s left) gem_mmap_offset (pf-nonblock) [443.727463] Starting subtest: pf-nonblock [443.733191] Subtest pf-nonblock: SUCCESS (0.007s) [443.855739] [099/156] (585s left) gem_exec_schedule (wide) [444.043854] Starting subtest: wide [444.044851] Starting dynamic subtest: rcs0 [454.980780] Dynamic subtest rcs0: SUCCESS (10.900s) [454.992923] Starting dynamic subtest: vcs0 [465.999633] Dynamic subtest vcs0: SUCCESS (11.055s) [466.012090] Starting dynamic subtest: vcs1 [477.844628] Dynamic subtest vcs1: SUCCESS (11.844s) [477.856400] Starting dynamic subtest: vecs0 [490.117291] Dynamic subtest vecs0: SUCCESS (12.271s) [490.130009] Starting dynamic subtest: ccs0 [504.487875] Dynamic subtest ccs0: SUCCESS (14.331s) [504.489744] Subtest wide: SUCCESS (60.407s) [506.245876] [100/156] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [506.340064] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [506.341998] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [506.426001] [101/156] (522s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [506.537976] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [506.539588] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [506.635057] [102/156] (522s left) gem_basic (bad-close) [506.682716] Starting subtest: bad-close [506.684532] Subtest bad-close: SUCCESS (0.000s) [506.775466] [103/156] (522s left) api_intel_allocator (reopen) [506.823346] Starting subtest: reopen [506.825397] Subtest reopen: SUCCESS (0.004s) [506.937576] [104/156] (522s left) gen9_exec_parse (secure-batches) [506.995730] Subtest secure-batches: SKIP (0.000s) [507.052231] [105/156] (522s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt) [507.143650] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt [507.145246] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [507.238325] [106/156] (522s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render) [507.337558] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render [507.339280] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [507.438709] [107/156] (522s left) gem_ctx_engines (none) [507.487820] Starting subtest: none [507.489044] Subtest none: SUCCESS (0.001s) [507.667430] [108/156] (521s left) kms_lease (invalid-create-leases) [507.757798] Starting subtest: invalid-create-leases [507.761925] Subtest invalid-create-leases: SUCCESS (0.005s) [507.877264] [109/156] (521s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [508.250596] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [509.057421] [110/156] (520s left) gem_ringfill (legacy-basic) [514.454372] Starting subtest: legacy-basic [514.455619] Starting dynamic subtest: default [514.503804] Dynamic subtest default: SUCCESS (0.056s) [514.518303] Starting dynamic subtest: render [514.545610] Dynamic subtest render: SUCCESS (0.040s) [514.557043] Starting dynamic subtest: bsd [514.591034] Dynamic subtest bsd: SUCCESS (0.042s) [514.603353] Starting dynamic subtest: bsd1 [514.632521] Dynamic subtest bsd1: SUCCESS (0.039s) [514.643886] Starting dynamic subtest: bsd2 [514.676354] Dynamic subtest bsd2: SUCCESS (0.041s) [514.690907] Starting dynamic subtest: blt [514.723548] Dynamic subtest blt: SUCCESS (0.045s) [514.735825] Starting dynamic subtest: vebox [514.768691] Dynamic subtest vebox: SUCCESS (0.043s) [514.769997] Subtest legacy-basic: SUCCESS (0.323s) [514.844478] [111/156] (514s left) gem_tiled_swapping (non-threaded) [514.891202] Subtest non-threaded: SKIP (0.000s) [514.950429] [112/156] (514s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [515.044561] Starting subtest: psr-1p-pri-indfb-multidraw [538.672043] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.626s) [538.784082] [113/156] (491s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [538.880116] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [546.665047] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.787s) [547.797340] [114/156] (482s left) kms_getfb (getfb-handle-zero) [547.888157] Starting subtest: getfb-handle-zero [547.888940] Subtest getfb-handle-zero: SUCCESS (0.000s) [547.987406] [115/156] (481s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [548.077021] Starting subtest: psr-rgb101010-draw-render [555.523555] Subtest psr-rgb101010-draw-render: SUCCESS (7.446s) [555.633086] [116/156] (474s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [555.735798] Starting subtest: yf-tiled-16bpp-rotate-0 [555.737791] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [555.830293] [117/156] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [555.920349] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [555.921935] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [556.034251] [118/156] (473s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [556.134471] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [556.136208] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [556.207121] [119/156] (473s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [556.302182] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [556.303256] Starting dynamic subtest: pipe-A-eDP-1 [557.659005] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.347s) [557.937176] Starting dynamic subtest: pipe-B-eDP-1 [558.992099] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.056s) [559.258857] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.957s) [560.087114] [120/156] (469s left) gem_basic (create-close) [560.134234] Starting subtest: create-close [560.135809] Subtest create-close: SUCCESS (0.000s) [560.231498] [121/156] (469s left) kms_flip (flip-vs-fences) [560.318235] Starting subtest: flip-vs-fences [560.320149] Subtest flip-vs-fences: SKIP (0.000s) [560.431162] [122/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [560.521278] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [560.523153] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [560.613309] [123/156] (469s left) syncobj_basic (bad-destroy) [560.671422] Starting subtest: bad-destroy [560.672270] Subtest bad-destroy: SUCCESS (0.000s) [560.780297] [124/156] (469s left) kms_cursor_crc (cursor-rapid-movement-512x170) [561.068106] Starting subtest: cursor-rapid-movement-512x170 [561.069868] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [561.204941] [125/156] (469s left) gem_ctx_param (invalid-get-no-zeromap) [561.249907] Starting subtest: invalid-get-no-zeromap [561.251001] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [561.344868] [126/156] (468s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [561.431654] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [561.432501] Starting dynamic subtest: pipe-A-eDP-1 [561.590695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.154s) [561.601961] Starting dynamic subtest: pipe-B-eDP-1 [561.609641] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.014s) [561.619451] Starting dynamic subtest: pipe-C-eDP-1 [561.626792] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s) [561.636065] Starting dynamic subtest: pipe-D-eDP-1 [561.643789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [561.644610] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.197s) [563.968948] [127/156] (466s left) gem_sync (basic-many-each) [564.022333] Starting subtest: basic-many-each [566.298594] Subtest basic-many-each: SUCCESS (2.276s) [566.491667] [128/156] (463s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [566.607600] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [566.609417] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [566.751649] [129/156] (463s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [566.847522] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [566.849241] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [566.955480] [130/156] (463s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [567.048168] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [567.050189] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [567.120000] [131/156] (463s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [567.231633] Starting subtest: basic-flip-after-cursor-legacy [568.160998] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.928s) [569.010875] [132/156] (461s left) kms_scaling_modes (scaling-mode-none) [569.097884] Starting subtest: scaling-mode-none [569.098885] Starting dynamic subtest: pipe-A-eDP-1 [569.194598] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s) [569.208821] Starting dynamic subtest: pipe-B-eDP-1 [569.231980] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s) [569.244310] Starting dynamic subtest: pipe-C-eDP-1 [569.265726] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s) [569.276523] Starting dynamic subtest: pipe-D-eDP-1 [569.301405] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s) [569.303094] Subtest scaling-mode-none: SKIP (0.205s) [569.421691] [133/156] (461s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [569.521208] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [569.522810] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [569.616793] [134/156] (460s left) kms_busy (extended-modeset-hang-oldfb) [569.705697] Starting subtest: extended-modeset-hang-oldfb [569.706530] Starting dynamic subtest: pipe-A [581.552952] Dynamic subtest pipe-A: SUCCESS (11.845s) [581.562916] Starting dynamic subtest: pipe-D [594.013799] Dynamic subtest pipe-D: SUCCESS (12.458s) [594.015035] Subtest extended-modeset-hang-oldfb: SUCCESS (24.308s) [594.911052] [135/156] (435s left) prime_vgem (basic-read) [594.981768] Starting subtest: basic-read [594.994868] Subtest basic-read: SKIP (0.012s) [595.115517] [136/156] (435s left) i915_drm_fdinfo (virtual-busy) [595.157781] Starting subtest: virtual-busy [595.160518] Subtest virtual-busy: SKIP (0.000s) [595.240670] [137/156] (435s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte) [595.331648] Starting subtest: fbcpsrhdr-2p-rte [595.333584] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s) [595.428096] [138/156] (435s left) kms_cursor_crc (cursor-onscreen-32x10) [595.585668] Starting subtest: cursor-onscreen-32x10 [595.634781] Subtest cursor-onscreen-32x10: SKIP (0.046s) [595.897276] [139/156] (434s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [595.992559] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [595.994527] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [596.097141] [140/156] (434s left) gem_exec_flush (basic-uc-rw-default) [596.160394] Starting subtest: basic-uc-rw-default [601.610801] Subtest basic-uc-rw-default: SUCCESS (5.451s) [601.795336] [141/156] (429s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [601.911472] Starting subtest: 2x-cursor-vs-flip-atomic [601.914282] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [602.060397] [142/156] (428s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render) [602.155013] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render [602.156746] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [602.242788] [143/156] (428s left) kms_chamelium_edid (dp-edid-change-during-suspend) [602.620150] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [603.418803] [144/156] (427s left) gem_softpin (allocator-evict) [603.468876] Starting subtest: allocator-evict [603.469980] Starting dynamic subtest: rcs0 [627.099568] Dynamic subtest rcs0: SUCCESS (23.629s) [627.109953] Starting dynamic subtest: bcs0 [650.892579] Dynamic subtest bcs0: SUCCESS (23.791s) [650.905229] Starting dynamic subtest: vcs0 [674.842184] Dynamic subtest vcs0: SUCCESS (23.946s) [674.854437] Starting dynamic subtest: vcs1 [698.937764] Dynamic subtest vcs1: SUCCESS (24.092s) [698.951739] Starting dynamic subtest: vecs0 [722.666662] Dynamic subtest vecs0: SUCCESS (23.726s) [722.679942] Starting dynamic subtest: ccs0 [746.983255] Dynamic subtest ccs0: SUCCESS (24.313s) [746.984588] Subtest allocator-evict: SUCCESS (143.506s) [747.067127] [145/156] (283s left) perf (per-context-mode-unprivileged) [747.367846] Starting subtest: per-context-mode-unprivileged [747.369507] Subtest per-context-mode-unprivileged: SKIP (0.000s) [747.409748] [146/156] (283s left) kms_prop_blob (invalid-set-prop) [747.459130] Starting subtest: invalid-set-prop [747.460026] Subtest invalid-set-prop: SUCCESS (0.000s) [747.554693] [147/156] (283s left) gem_exec_schedule (submit-early-slice) [747.617569] Starting subtest: submit-early-slice [747.618888] Starting dynamic subtest: rcs0 [747.682155] Dynamic subtest rcs0: SUCCESS (0.064s) [747.695774] Starting dynamic subtest: bcs0 [747.744611] Dynamic subtest bcs0: SUCCESS (0.060s) [747.756788] Starting dynamic subtest: vcs0 [747.805546] Dynamic subtest vcs0: SUCCESS (0.061s) [747.819403] Starting dynamic subtest: vcs1 [747.867641] Dynamic subtest vcs1: SUCCESS (0.061s) [747.881863] Starting dynamic subtest: vecs0 [747.913723] Dynamic subtest vecs0: SUCCESS (0.045s) [747.925312] Starting dynamic subtest: ccs0 [747.973938] Dynamic subtest ccs0: SUCCESS (0.059s) [747.975251] Subtest submit-early-slice: SUCCESS (0.356s) [749.529606] [148/156] (281s left) kms_color (legacy-gamma-reset) [749.619786] Starting subtest: legacy-gamma-reset [749.620721] Starting dynamic subtest: pipe-A-eDP-1 [749.994238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s) [750.004374] Starting dynamic subtest: pipe-B-eDP-1 [750.007384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [750.018522] Starting dynamic subtest: pipe-C-eDP-1 [750.020982] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [750.031116] Starting dynamic subtest: pipe-D-eDP-1 [750.033973] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [750.035057] Subtest legacy-gamma-reset: SUCCESS (0.415s) [750.861112] [149/156] (280s left) kms_vblank (wait-forked-hang) [750.959979] Starting subtest: wait-forked-hang [750.960874] Starting dynamic subtest: pipe-A-eDP-1 [777.292157] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.329s) [777.304214] Starting dynamic subtest: pipe-D-eDP-1 [802.255966] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s) [802.256944] Subtest wait-forked-hang: SUCCESS (51.292s) [803.135860] [150/156] (228s left) gem_mmap_wc (read-write-distinct) [803.184997] Subtest read-write-distinct: SKIP (0.000s) [803.246976] [151/156] (227s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [803.352592] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [807.814137] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.461s) [808.954667] [152/156] (222s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render) [809.044013] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render [809.045806] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [809.145846] [153/156] (222s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [809.241233] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [812.986042] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.747s) [814.159130] [154/156] (217s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [814.216608] Starting subtest: multi-wait-for-submit-submitted-signaled [814.217593] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [814.311110] [155/156] (217s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [814.416350] Starting subtest: primary-y-tiled-reflect-x-90 [814.418196] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [814.479123] [156/156] (216s left) kms_draw_crc (draw-method-mmap-cpu) [814.572697] Starting subtest: draw-method-mmap-cpu [814.573782] Starting dynamic subtest: xrgb8888-untiled [814.839129] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s) [814.849418] Starting dynamic subtest: rgb565-untiled [815.072501] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [815.084620] Starting dynamic subtest: xrgb2101010-untiled [815.294680] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [815.305265] Starting dynamic subtest: xbgr16161616f-untiled [815.528012] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [815.538196] Starting dynamic subtest: xrgb8888-xtiled [815.672386] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [815.683392] Starting dynamic subtest: rgb565-xtiled [815.816890] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s) [815.827263] Starting dynamic subtest: xrgb2101010-xtiled [815.950224] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [815.960547] Starting dynamic subtest: xbgr16161616f-xtiled [816.094604] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s) [816.105429] Starting dynamic subtest: xrgb8888-4tiled [816.251058] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [816.263528] Starting dynamic subtest: rgb565-4tiled [816.394909] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s) [816.406408] Starting dynamic subtest: xrgb2101010-4tiled [816.539246] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s) [816.550652] Starting dynamic subtest: xbgr16161616f-4tiled [816.695115] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s) [816.696253] Subtest draw-method-mmap-cpu: SUCCESS (2.123s) [816.800138] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: api_intel_bb results: parsing output: 3/ for test: gem_exec_balancer results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_userptr_blits results: parsing output: 6/ for test: gem_render_copy results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_render_copy results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_pipe_stress results: parsing output: 12/ for test: gem_ctx_persistence results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_pm_backlight results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_chamelium_audio results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: kms_flip_scaled_crc results: parsing output: 23/ for test: gem_ppgtt results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: kms_addfb_basic results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: gem_ccs results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: kms_plane_scaling results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_whisper results: parsing output: 48/ for test: perf results: parsing output: 49/ for test: syncobj_eventfd results: parsing output: 50/ for test: kms_psr2_su results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_pwrite results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: sw_sync results: parsing output: 60/ for test: i915_suspend results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: core_setmaster results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: i915_pm_freq_api results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: i915_pm_rpm results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_content_protection results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_cursor_legacy results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: prime_vgem results: parsing output: 77/ for test: gem_close results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_pm_rpm results: parsing output: 80/ for test: kms_psr results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: gem_mmap_wc results: parsing output: 83/ for test: gem_exec_schedule results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_pm_rpm results: parsing output: 87/ for test: gem_exec_balancer results: parsing output: 88/ for test: kms_cursor_legacy results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_ctx_shared results: parsing output: 91/ for test: kms_sequence results: parsing output: 92/ for test: kms_setmode results: parsing output: 93/ for test: kms_joiner results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_mmap_offset results: parsing output: 98/ for test: gem_exec_schedule results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_basic results: parsing output: 102/ for test: api_intel_allocator results: parsing output: 103/ for test: gen9_exec_parse results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_ctx_engines results: parsing output: 107/ for test: kms_lease results: parsing output: 108/ for test: kms_chamelium_hpd results: parsing output: 109/ for test: gem_ringfill results: parsing output: 110/ for test: gem_tiled_swapping results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_getfb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: kms_atomic_transition results: parsing output: 119/ for test: gem_basic results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: syncobj_basic results: parsing output: 123/ for test: kms_cursor_crc results: parsing output: 124/ for test: gem_ctx_param results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: gem_sync results: parsing output: 127/ for test: kms_cursor_legacy results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: kms_cursor_legacy results: parsing output: 131/ for test: kms_scaling_modes results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_busy results: parsing output: 134/ for test: prime_vgem results: parsing output: 135/ for test: i915_drm_fdinfo results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_cursor_crc results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: gem_exec_flush results: parsing output: 140/ for test: kms_cursor_legacy results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_chamelium_edid results: parsing output: 143/ for test: gem_softpin results: parsing output: 144/ for test: perf results: parsing output: 145/ for test: kms_prop_blob results: parsing output: 146/ for test: gem_exec_schedule results: parsing output: 147/ for test: kms_color results: parsing output: 148/ for test: kms_vblank results: parsing output: 149/ for test: gem_mmap_wc results: parsing output: 150/ for test: kms_frontbuffer_tracking 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_wait results: parsing output: 154/ for test: kms_rotation_crc results: parsing output: 155/ for test: kms_draw_crc Done.