[140.072335] Initializing watchdogs [140.072385] /dev/watchdog0 [140.087613] [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] [140.092543] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [140.094994] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [140.099539] [001/156] (960s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [140.229769] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [140.234278] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.001s) [140.321619] [002/156] (960s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [140.422248] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [140.434380] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s) [140.507586] [003/156] (960s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [140.626869] Starting subtest: cursorB-vs-flipA-atomic [140.631626] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [140.775060] [004/156] (959s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [140.842542] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [140.898580] [005/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [140.996679] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [141.000580] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [141.089635] [006/156] (959s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [141.144045] Starting subtest: etime-multi-wait-available-unsubmitted [141.250038] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s) [141.322220] [007/156] (959s left) kms_chamelium_edid (hdmi-edid-read) [141.707951] Subtest hdmi-edid-read: SKIP (0.000s) [142.559115] [008/156] (958s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [142.685321] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [174.671840] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.984s) [175.534073] [009/156] (925s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [175.634438] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [175.638507] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [175.747679] [010/156] (925s left) gem_lmem_swapping (verify) [175.791131] Subtest verify: SKIP (0.000s) [175.832904] [011/156] (925s left) kms_big_fb (linear-64bpp-rotate-90) [175.933203] Starting subtest: linear-64bpp-rotate-90 [175.952775] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [176.074669] [012/156] (924s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [176.163501] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [176.165791] Starting dynamic subtest: pipe-A-eDP-1 [176.185878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [176.195564] Starting dynamic subtest: pipe-B-eDP-1 [176.216246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [176.224323] Starting dynamic subtest: pipe-C-eDP-1 [176.243638] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [176.252381] Starting dynamic subtest: pipe-D-eDP-1 [176.271778] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [176.273997] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [178.475962] [013/156] (922s left) gem_ctx_sseu (mmap-args) [178.538227] Subtest mmap-args: SKIP (0.000s) [178.594881] [014/156] (922s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite) [178.697698] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite [178.701809] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [178.796780] [015/156] (922s left) perf_pmu (semaphore-wait) [178.836281] Starting subtest: semaphore-wait [178.838581] Starting dynamic subtest: rcs0 [179.354677] Dynamic subtest rcs0: SUCCESS (0.516s) [179.366285] Starting dynamic subtest: bcs0 [179.866265] Dynamic subtest bcs0: SUCCESS (0.511s) [179.877233] Starting dynamic subtest: vcs0 [180.377619] Dynamic subtest vcs0: SUCCESS (0.510s) [180.388694] Starting dynamic subtest: vcs1 [180.889727] Dynamic subtest vcs1: SUCCESS (0.511s) [180.899625] Starting dynamic subtest: vecs0 [181.405348] Dynamic subtest vecs0: SUCCESS (0.514s) [181.415368] Starting dynamic subtest: ccs0 [181.920706] Dynamic subtest ccs0: SUCCESS (0.514s) [181.923103] Subtest semaphore-wait: SUCCESS (3.083s) [183.368342] [016/156] (917s left) kms_vblank (query-busy) [183.475740] Starting subtest: query-busy [183.478397] Starting dynamic subtest: pipe-A-eDP-1 [185.350084] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [185.365325] Starting dynamic subtest: pipe-D-eDP-1 [187.925288] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s) [187.927655] Subtest query-busy: SUCCESS (4.451s) [188.741244] [017/156] (912s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [188.841360] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [188.843380] Starting dynamic subtest: pipe-A-eDP-1 [190.114771] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.275s) [190.124764] Starting dynamic subtest: pipe-B-eDP-1 [192.488646] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.373s) [192.504844] Starting dynamic subtest: pipe-C-eDP-1 [194.824591] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.335s) [194.835233] Starting dynamic subtest: pipe-D-eDP-1 [197.133494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.307s) [197.135879] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.295s) [198.372416] [018/156] (902s left) gem_ctx_engines (none) [198.428355] Starting subtest: none [198.430706] Subtest none: SUCCESS (0.001s) [198.613255] [019/156] (902s left) gem_exec_schedule (u-submit-golden-slice) [198.675622] Starting subtest: u-submit-golden-slice [198.677843] Starting dynamic subtest: rcs0 [198.706484] Dynamic subtest rcs0: SUCCESS (0.034s) [198.718835] Starting dynamic subtest: bcs0 [198.741542] Dynamic subtest bcs0: SUCCESS (0.035s) [198.750614] Starting dynamic subtest: vcs0 [198.781140] Dynamic subtest vcs0: SUCCESS (0.039s) [198.789705] Starting dynamic subtest: vcs1 [198.817725] Dynamic subtest vcs1: SUCCESS (0.036s) [198.827525] Starting dynamic subtest: vecs0 [198.846601] Dynamic subtest vecs0: SUCCESS (0.029s) [198.855101] Starting dynamic subtest: ccs0 [198.882596] Dynamic subtest ccs0: SUCCESS (0.036s) [198.884892] Subtest u-submit-golden-slice: SUCCESS (0.211s) [200.412213] [020/156] (900s left) kms_plane (planar-pixel-format-settings) [200.502676] Starting subtest: planar-pixel-format-settings [200.575206] Subtest planar-pixel-format-settings: SUCCESS (0.073s) [200.695919] [021/156] (900s left) gem_ctx_persistence (engines-hostile-preempt) [200.763464] Starting subtest: engines-hostile-preempt [200.765937] Starting dynamic subtest: rcs0 [200.833993] Dynamic subtest rcs0: SUCCESS (0.070s) [200.844434] Starting dynamic subtest: bcs0 [200.881802] Dynamic subtest bcs0: SUCCESS (0.047s) [200.892542] Starting dynamic subtest: vcs0 [202.301318] Dynamic subtest vcs0: SUCCESS (1.417s) [202.312602] Starting dynamic subtest: vcs1 [204.289524] Dynamic subtest vcs1: SUCCESS (1.987s) [204.302572] Starting dynamic subtest: vecs0 [206.263343] Dynamic subtest vecs0: SUCCESS (1.973s) [206.273273] Starting dynamic subtest: ccs0 [206.293445] Dynamic subtest ccs0: SUCCESS (0.031s) [206.295671] Subtest engines-hostile-preempt: SUCCESS (5.530s) [206.416155] [022/156] (895s left) gem_exec_schedule (lateslice) [206.485822] Starting subtest: lateslice [206.487837] Starting dynamic subtest: rcs0 [206.508783] Dynamic subtest rcs0: SUCCESS (0.032s) [206.517596] Starting dynamic subtest: bcs0 [206.532162] Dynamic subtest bcs0: SUCCESS (0.023s) [206.540994] Starting dynamic subtest: vcs0 [206.553778] Dynamic subtest vcs0: SUCCESS (0.022s) [206.564309] Starting dynamic subtest: vcs1 [206.576807] Dynamic subtest vcs1: SUCCESS (0.023s) [206.585276] Starting dynamic subtest: vecs0 [206.597985] Dynamic subtest vecs0: SUCCESS (0.021s) [206.609183] Starting dynamic subtest: ccs0 [206.619767] Dynamic subtest ccs0: SUCCESS (0.021s) [206.621943] Subtest lateslice: SUCCESS (0.143s) [208.393928] [023/156] (893s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [208.501615] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [208.505853] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [208.580579] [024/156] (892s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [208.687865] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [208.692372] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [208.786740] [025/156] (892s left) syncobj_timeline (reset-during-wait-for-submit) [208.848971] Starting subtest: reset-during-wait-for-submit [208.955088] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [209.037825] [026/156] (892s left) gem_exec_balancer (full-pulse) [209.096999] Starting subtest: full-pulse [214.230899] Subtest full-pulse: SUCCESS (5.134s) [214.582120] [027/156] (887s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render) [214.687288] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render [214.691672] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [214.803627] [028/156] (886s left) gem_exec_fence (basic-await) [214.991157] Starting subtest: basic-await [214.993684] Starting dynamic subtest: rcs0 [215.066686] Dynamic subtest rcs0: SUCCESS (0.076s) [215.075864] Starting dynamic subtest: bcs0 [215.142252] Dynamic subtest bcs0: SUCCESS (0.074s) [215.153142] Starting dynamic subtest: vcs0 [215.215844] Dynamic subtest vcs0: SUCCESS (0.073s) [215.227189] Starting dynamic subtest: vcs1 [215.290353] Dynamic subtest vcs1: SUCCESS (0.073s) [215.302326] Starting dynamic subtest: vecs0 [215.363860] Dynamic subtest vecs0: SUCCESS (0.073s) [215.373872] Starting dynamic subtest: ccs0 [215.447997] Dynamic subtest ccs0: SUCCESS (0.083s) [215.450822] Subtest basic-await: SUCCESS (0.458s) [217.363662] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true [217.369126] [029/156] (884s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [217.484902] Starting subtest: extended-modeset-hang-oldfb-with-reset [217.487297] Starting dynamic subtest: pipe-A [229.151087] Dynamic subtest pipe-A: SUCCESS (11.663s) [229.163078] Starting dynamic subtest: pipe-D [241.437901] Dynamic subtest pipe-D: SUCCESS (12.285s) [241.440267] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.951s) [242.340275] [030/156] (859s left) kms_flip (nonblocking-read) [242.433580] Starting subtest: nonblocking-read [242.435815] Subtest nonblocking-read: SUCCESS (0.000s) [242.512279] [031/156] (859s left) gem_madvise (dontneed-after-mmap) [242.547998] Starting subtest: dontneed-after-mmap [242.570956] Subtest dontneed-after-mmap: SUCCESS (0.023s) [242.684949] [032/156] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [242.777168] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [250.145760] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.374s) [250.270807] [033/156] (851s left) kms_invalid_mode (overflow-vrefresh) [250.365122] Starting subtest: overflow-vrefresh [250.367406] Starting dynamic subtest: pipe-A-eDP-1 [250.647660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [250.657965] Starting dynamic subtest: pipe-B-eDP-1 [250.660251] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [250.668702] Starting dynamic subtest: pipe-C-eDP-1 [250.671041] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [250.679907] Starting dynamic subtest: pipe-D-eDP-1 [250.682725] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [250.685336] Subtest overflow-vrefresh: SUCCESS (0.289s) [251.469878] [034/156] (850s left) kms_dsc (dsc-basic) [251.566238] Starting subtest: dsc-basic [251.579560] Subtest dsc-basic: SKIP (0.000s) [251.638492] [035/156] (850s left) kms_chamelium_hpd (dp-hpd) [252.029663] Subtest dp-hpd: SKIP (0.000s) [252.876636] [036/156] (849s left) core_getstats (basic) [252.933783] Starting subtest: basic [252.935927] Subtest basic: SUCCESS (0.000s) [253.050911] [037/156] (849s left) kms_plane_scaling (planes-upscale-factor-0-25) [253.137066] Starting subtest: planes-upscale-factor-0-25 [253.139378] Starting dynamic subtest: pipe-A [253.198237] Dynamic subtest pipe-A: SUCCESS (0.063s) [253.209608] Starting dynamic subtest: pipe-B [254.316038] Dynamic subtest pipe-B: SUCCESS (1.116s) [254.327497] Starting dynamic subtest: pipe-C [255.432960] Dynamic subtest pipe-C: SUCCESS (1.116s) [255.444461] Starting dynamic subtest: pipe-D [256.572258] Dynamic subtest pipe-D: SUCCESS (1.138s) [256.574552] Subtest planes-upscale-factor-0-25: SUCCESS (3.438s) [257.728749] [038/156] (844s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [257.821047] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [257.825246] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [257.892764] [039/156] (844s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [257.984520] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [257.988700] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [258.075460] [040/156] (844s left) kms_rotation_crc (sprite-rotation-270) [258.163127] Starting subtest: sprite-rotation-270 [258.167606] Subtest sprite-rotation-270: SKIP (0.001s) [258.237684] [041/156] (844s left) kms_content_protection (content-type-change) [258.383083] Starting subtest: content-type-change [258.387646] Subtest content-type-change: SKIP (0.000s) [258.518247] [042/156] (843s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [258.617297] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu [258.621339] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [258.723320] [043/156] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [258.822321] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [258.826075] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [258.915587] [044/156] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [259.005916] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [259.009561] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [259.104876] [045/156] (843s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [259.214143] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [260.330764] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.117s) [260.453160] [046/156] (841s left) gem_softpin (allocator-evict) [260.507384] Starting subtest: allocator-evict [260.509840] Starting dynamic subtest: rcs0 [283.896209] Dynamic subtest rcs0: SUCCESS (23.387s) [283.906665] Starting dynamic subtest: bcs0 [308.202495] Dynamic subtest bcs0: SUCCESS (24.304s) [308.212910] Starting dynamic subtest: vcs0 [332.161115] Dynamic subtest vcs0: SUCCESS (23.958s) [332.171022] Starting dynamic subtest: vcs1 [356.092673] Dynamic subtest vcs1: SUCCESS (23.930s) [356.105106] Starting dynamic subtest: vecs0 [380.121917] Dynamic subtest vecs0: SUCCESS (24.027s) [380.142270] Starting dynamic subtest: ccs0 [404.290460] Dynamic subtest ccs0: SUCCESS (24.167s) [404.292987] Subtest allocator-evict: SUCCESS (143.778s) [404.371390] [047/156] (698s left) kms_color_pipeline (plane-lut1d-lut1d) [404.529350] Starting subtest: plane-lut1d-lut1d [404.687816] Starting dynamic subtest: pipe-A-plane-0 [404.865393] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [404.875537] Starting dynamic subtest: pipe-A-plane-1 [405.042884] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s) [405.052967] Starting dynamic subtest: pipe-A-plane-2 [405.199665] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [406.418944] Starting dynamic subtest: pipe-B-plane-0 [406.587280] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [406.597386] Starting dynamic subtest: pipe-B-plane-1 [406.776615] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s) [406.786879] Starting dynamic subtest: pipe-B-plane-2 [406.965660] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [408.154486] Starting dynamic subtest: pipe-C-plane-0 [408.290106] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [408.301233] Starting dynamic subtest: pipe-C-plane-1 [408.456872] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [408.469320] Starting dynamic subtest: pipe-C-plane-2 [408.625807] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [409.884107] Starting dynamic subtest: pipe-D-plane-0 [410.041899] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s) [410.054566] Starting dynamic subtest: pipe-D-plane-1 [410.197355] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [410.207494] Starting dynamic subtest: pipe-D-plane-2 [410.364329] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [410.656090] Subtest plane-lut1d-lut1d: SUCCESS (6.127s) [411.534798] [048/156] (691s left) kms_dp_link_training (uhbr-sst) [411.638681] Starting subtest: uhbr-sst [411.647445] Subtest uhbr-sst: SKIP (0.000s) [411.721637] [049/156] (690s left) gem_ctx_persistence (legacy-engines-persistence) [411.777840] Starting subtest: legacy-engines-persistence [411.780185] Starting dynamic subtest: render [412.549859] Dynamic subtest render: SUCCESS (0.771s) [412.564869] Starting dynamic subtest: bsd1 [413.309926] Dynamic subtest bsd1: SUCCESS (0.757s) [413.323129] Starting dynamic subtest: bsd2 [414.076035] Dynamic subtest bsd2: SUCCESS (0.763s) [414.092055] Starting dynamic subtest: blt [414.820248] Dynamic subtest blt: SUCCESS (0.741s) [414.832259] Starting dynamic subtest: vebox [415.612930] Dynamic subtest vebox: SUCCESS (0.791s) [415.615695] Subtest legacy-engines-persistence: SUCCESS (3.836s) [415.698599] [050/156] (686s left) gem_userptr_blits (unsync-overlap) [415.767088] Subtest unsync-overlap: SKIP (0.000s) [415.918895] [051/156] (686s left) syncobj_wait (invalid-reset-zero-handles) [415.971356] Starting subtest: invalid-reset-zero-handles [415.973802] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [416.071198] [052/156] (686s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [416.170484] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [416.174782] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [416.272336] [053/156] (686s left) perf (invalid-oa-format-id) [416.419912] Starting subtest: invalid-oa-format-id [416.431471] Subtest invalid-oa-format-id: SUCCESS (0.012s) [416.468735] [054/156] (686s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [416.573209] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [416.577264] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [416.665772] [055/156] (686s left) syncobj_timeline (invalid-signal-bad-pad) [416.715839] Starting subtest: invalid-signal-bad-pad [416.717934] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [416.802529] [056/156] (686s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [416.935105] Starting subtest: cursorB-vs-flipA-legacy [416.938811] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [417.089609] [057/156] (685s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt) [417.188387] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt [417.191976] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [417.286131] [058/156] (685s left) gem_exec_fence (parallel) [417.457235] Starting subtest: parallel [417.459395] Starting dynamic subtest: rcs0 [419.604604] Dynamic subtest rcs0: SUCCESS (2.150s) [419.618111] Starting dynamic subtest: bcs0 [421.754675] Dynamic subtest bcs0: SUCCESS (2.149s) [421.767193] Starting dynamic subtest: vcs0 [423.905191] Dynamic subtest vcs0: SUCCESS (2.150s) [423.916746] Starting dynamic subtest: vcs1 [426.055855] Dynamic subtest vcs1: SUCCESS (2.149s) [426.067200] Starting dynamic subtest: vecs0 [428.211231] Dynamic subtest vecs0: SUCCESS (2.155s) [428.224938] Starting dynamic subtest: ccs0 [430.361364] Dynamic subtest ccs0: SUCCESS (2.149s) [430.363311] Subtest parallel: SUCCESS (12.908s) [431.401050] [059/156] (671s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [431.464755] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [431.467555] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [431.565416] [060/156] (671s left) gem_mmap_offset (pf-nonblock) [431.611154] Starting subtest: pf-nonblock [431.616610] Subtest pf-nonblock: SUCCESS (0.007s) [431.742277] [061/156] (671s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [431.806433] Starting subtest: x-tiled-to-vebox-yf-tiled [431.810661] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [432.007819] [062/156] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [432.108785] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [432.113194] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [432.207638] [063/156] (670s left) gem_lmem_swapping (parallel-random-verify) [432.252578] Subtest parallel-random-verify: SKIP (0.000s) [432.292038] [064/156] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [432.392453] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [432.396590] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [432.498693] [065/156] (670s left) sysfs_heartbeat_interval (nopreempt) [432.555451] Starting subtest: nopreempt [432.557618] Starting dynamic subtest: vecs0 [442.297660] Dynamic subtest vecs0: SUCCESS (9.741s) [442.312325] Starting dynamic subtest: ccs0 [446.290620] Dynamic subtest ccs0: SUCCESS (3.990s) [446.302541] Starting dynamic subtest: vcs0 [456.322356] Dynamic subtest vcs0: SUCCESS (10.030s) [456.335668] Starting dynamic subtest: bcs0 [460.243817] Dynamic subtest bcs0: SUCCESS (3.918s) [460.254821] Starting dynamic subtest: rcs0 [464.297644] Dynamic subtest rcs0: SUCCESS (4.052s) [464.310784] Starting dynamic subtest: vcs1 [473.273774] Dynamic subtest vcs1: SUCCESS (8.976s) [473.276480] Subtest nopreempt: SUCCESS (40.718s) [473.352965] [066/156] (629s left) kms_cursor_crc (cursor-dpms) [473.505088] Starting subtest: cursor-dpms [473.507066] Starting dynamic subtest: pipe-A-eDP-1 [476.614473] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.107s) [476.626941] Starting dynamic subtest: pipe-D-eDP-1 [480.280812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.667s) [480.283303] Subtest cursor-dpms: SUCCESS (6.776s) [481.114526] [067/156] (622s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw) [481.220996] Starting subtest: psrhdr-2p-pri-indfb-multidraw [481.225406] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [481.311253] [068/156] (622s left) kms_plane_cursor (primary) [481.406248] Starting subtest: primary [481.410410] Starting dynamic subtest: pipe-A-eDP-1-size-64 [484.091103] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.686s) [484.118377] Starting dynamic subtest: pipe-A-eDP-1-size-128 [486.793090] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.683s) [486.817503] Starting dynamic subtest: pipe-A-eDP-1-size-256 [489.492176] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.683s) [489.820032] Starting dynamic subtest: pipe-B-eDP-1-size-64 [493.237963] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.429s) [493.263243] Starting dynamic subtest: pipe-B-eDP-1-size-128 [495.929616] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.672s) [495.952746] Starting dynamic subtest: pipe-B-eDP-1-size-256 [498.641628] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.694s) [498.961679] Starting dynamic subtest: pipe-C-eDP-1-size-64 [502.014449] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.066s) [502.042613] Starting dynamic subtest: pipe-C-eDP-1-size-128 [504.392531] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.359s) [504.420045] Starting dynamic subtest: pipe-C-eDP-1-size-256 [506.759042] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.348s) [507.082220] Starting dynamic subtest: pipe-D-eDP-1-size-64 [510.156205] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.087s) [510.185711] Starting dynamic subtest: pipe-D-eDP-1-size-128 [512.500373] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.325s) [512.528293] Starting dynamic subtest: pipe-D-eDP-1-size-256 [514.845141] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.325s) [515.152516] Subtest primary: SUCCESS (33.746s) [516.039903] [069/156] (587s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [516.131287] Starting subtest: fbc-psr2-cursor-mmap-cpu [516.133649] Starting dynamic subtest: eDP-1 [516.137940] Dynamic subtest eDP-1: SKIP (0.000s) [516.142242] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [516.219970] [070/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc) [516.325865] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc [516.330226] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [516.432261] [071/156] (587s left) kms_cursor_edge_walk (64x64-left-edge) [516.519234] Starting subtest: 64x64-left-edge [516.521546] Starting dynamic subtest: pipe-A-eDP-1 [520.005745] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [520.017829] Starting dynamic subtest: pipe-D-eDP-1 [523.141357] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s) [523.143765] Subtest 64x64-left-edge: SUCCESS (6.620s) [523.947500] [072/156] (579s left) kms_frontbuffer_tracking (hdr-1p-rte) [524.044623] Starting subtest: hdr-1p-rte [524.048953] Subtest hdr-1p-rte: SKIP (0.000s) [524.161210] [073/156] (579s left) gem_readwrite (beyond-eob) [524.211599] Subtest beyond-EOB: SKIP (0.000s) [524.269726] [074/156] (579s left) kms_atomic (plane-immutable-zpos) [524.378978] Starting subtest: plane-immutable-zpos [524.381169] Starting dynamic subtest: pipe-A-eDP-1 [525.025468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s) [525.027905] Subtest plane-immutable-zpos: SUCCESS (0.646s) [525.886765] [075/156] (577s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [525.985835] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [525.990166] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [526.090295] [076/156] (577s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [526.184099] Starting subtest: plane-all-modeset-transition-fencing [526.188485] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [526.258123] [077/156] (577s left) gen7_exec_parse (basic-allowed) [526.325304] Subtest basic-allowed: SKIP (0.000s) [526.401939] [078/156] (577s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [526.512107] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [526.514427] Starting dynamic subtest: pipe-A-eDP-1 [526.536313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [526.547579] Starting dynamic subtest: pipe-B-eDP-1 [526.568469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [526.577921] Starting dynamic subtest: pipe-C-eDP-1 [526.599190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [526.610998] Starting dynamic subtest: pipe-D-eDP-1 [526.632753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [526.637363] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s) [528.829997] [079/156] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [528.936137] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [528.940546] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [529.029470] [080/156] (574s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt) [529.133449] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt [529.137610] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [529.243040] [081/156] (574s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [529.351089] Starting subtest: psrhdr-slowdraw [529.355170] Subtest psrhdr-slowdraw: SKIP (0.000s) [529.444406] [082/156] (574s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-pwrite) [529.542051] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-pwrite [529.546602] Subtest fbchdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [529.653188] [083/156] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [529.748472] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [529.752600] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [529.848484] [084/156] (574s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [529.956627] Starting subtest: pr-overlay-plane-update-continuous-sf [529.960254] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [530.024483] [085/156] (574s left) i915_hangman (hangcheck-unterminated) [530.094452] Starting subtest: hangcheck-unterminated [541.277794] Subtest hangcheck-unterminated: SUCCESS (11.181s) [541.409064] [086/156] (562s left) kms_psr (psr2-sprite-render) [541.505871] Starting subtest: psr2-sprite-render [541.508169] Starting dynamic subtest: eDP-1 [543.228539] Dynamic subtest eDP-1: SUCCESS (1.722s) [543.230921] Subtest psr2-sprite-render: SUCCESS (1.723s) [544.113580] [087/156] (560s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [544.236610] Starting subtest: flip-vs-cursor-crc-legacy [544.959550] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.722s) [545.860174] [088/156] (558s left) gem_pread (exhaustion) [545.922344] Subtest exhaustion: SKIP (0.000s) [545.976654] [089/156] (558s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [546.032188] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [546.137830] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [546.213119] [090/156] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [546.309618] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [546.313757] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [546.411170] [091/156] (557s left) gem_set_tiling_vs_pwrite [546.536937] [092/156] (557s left) gem_userptr_blits (stress-mm) [546.613443] Starting subtest: stress-mm [551.983479] Subtest stress-mm: SUCCESS (5.369s) [552.114871] [093/156] (552s left) gem_userptr_blits (dmabuf-unsync) [552.186113] Subtest dmabuf-unsync: SKIP (0.000s) [552.337056] [094/156] (552s left) perf (oa-exponents) [552.436423] Starting subtest: oa-exponents [552.438405] Starting dynamic subtest: 0-rcs0 [554.229642] Dynamic subtest 0-rcs0: SUCCESS (1.794s) [554.242349] Starting dynamic subtest: 1-vcs1 [556.059600] Dynamic subtest 1-vcs1: SUCCESS (1.829s) [556.062038] Subtest oa-exponents: SUCCESS (3.625s) [556.112281] [095/156] (548s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [556.236301] Starting subtest: cursor-vs-flip-atomic-transitions [586.676986] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.438s) [587.546307] [096/156] (517s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [587.649423] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc [587.653538] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [587.754997] [097/156] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [587.860625] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [587.864643] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [587.974411] [098/156] (516s left) kms_psr (pr-suspend) [588.065517] Starting subtest: pr-suspend [588.069728] Subtest pr-suspend: SKIP (0.000s) [588.138111] [099/156] (516s left) gen9_exec_parse (bb-chained) [588.197653] Subtest bb-chained: SKIP (0.000s) [588.269396] [100/156] (516s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [588.358176] Starting subtest: fbc-rgb565-draw-render [592.568259] Subtest fbc-rgb565-draw-render: SUCCESS (4.217s) [593.745661] [101/156] (511s left) kms_pm_rpm (pm-caching) [595.493544] Starting subtest: pm-caching [595.498426] Subtest pm-caching: SKIP (0.000s) [596.095491] [102/156] (508s left) gem_busy (busy) [596.163715] Starting subtest: busy [596.165929] Starting dynamic subtest: all-engines [596.219408] Dynamic subtest all-engines: SUCCESS (0.055s) [596.231338] Starting dynamic subtest: rcs0 [597.319473] Dynamic subtest rcs0: SUCCESS (1.098s) [597.331527] Starting dynamic subtest: bcs0 [597.371900] Dynamic subtest bcs0: SUCCESS (0.050s) [597.382806] Starting dynamic subtest: vcs0 [597.412064] Dynamic subtest vcs0: SUCCESS (0.040s) [597.421966] Starting dynamic subtest: vcs1 [599.299659] Dynamic subtest vcs1: SUCCESS (1.883s) [599.311490] Starting dynamic subtest: vecs0 [601.284782] Dynamic subtest vecs0: SUCCESS (1.983s) [601.297772] Starting dynamic subtest: ccs0 [603.331664] Dynamic subtest ccs0: SUCCESS (2.046s) [603.333894] Subtest busy: SUCCESS (7.164s) [603.682234] [103/156] (501s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [603.792434] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [603.796775] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [603.893218] [104/156] (501s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render) [604.003970] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render [604.008343] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [604.122849] [105/156] (500s left) i915_pm_rps (reset) [604.185687] Starting subtest: reset [612.654797] Subtest reset: SUCCESS (8.472s) [612.792610] [106/156] (492s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [612.900102] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [612.902359] Starting dynamic subtest: pipe-A-eDP-1 [612.911509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [612.923641] Starting dynamic subtest: pipe-B-eDP-1 [612.932326] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [612.942593] Starting dynamic subtest: pipe-C-eDP-1 [612.951044] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [612.960714] Starting dynamic subtest: pipe-D-eDP-1 [612.968847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [612.972793] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [615.238468] [107/156] (489s left) kms_vrr (lobf) [615.340456] Starting subtest: lobf [615.345068] Subtest lobf: SKIP (0.000s) [615.433264] [108/156] (489s left) gem_mmap_gtt (big-copy-xy) [615.495866] Subtest big-copy-XY: SKIP (0.000s) [615.566204] [109/156] (489s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [615.675066] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [615.679133] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [615.780174] [110/156] (489s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [615.888638] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [615.893088] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [615.961324] [111/156] (489s left) kms_async_flips (async-flip-dpms) [616.064450] Starting subtest: async-flip-dpms [616.436850] Starting dynamic subtest: pipe-A-eDP-1 [620.341304] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.903s) [620.715034] Starting dynamic subtest: pipe-B-eDP-1 [623.575048] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s) [623.967518] Starting dynamic subtest: pipe-C-eDP-1 [626.838903] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.881s) [627.230263] Starting dynamic subtest: pipe-D-eDP-1 [630.024633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.804s) [630.027092] Subtest async-flip-dpms: SUCCESS (13.961s) [631.205768] [112/156] (474s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [631.304655] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [631.307229] Starting dynamic subtest: pipe-A-default-mode [634.059996] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s) [634.062195] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.755s) [634.896390] [113/156] (470s left) kms_cursor_crc (cursor-rapid-movement-128x128) [635.122211] Starting subtest: cursor-rapid-movement-128x128 [635.127149] Starting dynamic subtest: pipe-A-eDP-1 [635.696142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s) [635.730035] Starting dynamic subtest: pipe-D-eDP-1 [636.932033] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s) [636.934428] Subtest cursor-rapid-movement-128x128: SUCCESS (1.809s) [637.796703] [114/156] (467s left) gem_exec_whisper (basic-contexts-priority-all) [637.858552] Starting subtest: basic-contexts-priority-all [662.235350] Subtest basic-contexts-priority-all: SUCCESS (24.371s) [662.433848] [115/156] (443s left) perf_pmu (busy-accuracy-50) [662.474740] Starting subtest: busy-accuracy-50 [662.477080] Starting dynamic subtest: rcs0 [664.015171] Dynamic subtest rcs0: SUCCESS (1.537s) [664.028239] Starting dynamic subtest: bcs0 [665.561638] Dynamic subtest bcs0: SUCCESS (1.545s) [665.575308] Starting dynamic subtest: vcs0 [667.105687] Dynamic subtest vcs0: SUCCESS (1.541s) [667.118726] Starting dynamic subtest: vcs1 [668.646377] Dynamic subtest vcs1: SUCCESS (1.538s) [668.658693] Starting dynamic subtest: vecs0 [670.180356] Dynamic subtest vecs0: SUCCESS (1.533s) [670.193443] Starting dynamic subtest: ccs0 [671.726845] Dynamic subtest ccs0: SUCCESS (1.543s) [671.729269] Subtest busy-accuracy-50: SUCCESS (9.250s) [671.873107] [116/156] (433s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [671.923798] Starting subtest: invalid-multi-wait-unsubmitted-submitted [671.926191] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [672.021094] [117/156] (433s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite) [672.126273] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite [672.130814] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [672.222768] [118/156] (433s left) gem_exec_schedule (implicit-boths) [672.289319] Starting subtest: implicit-boths [672.291576] Starting dynamic subtest: rcs0 [672.394946] Dynamic subtest rcs0: SUCCESS (0.113s) [672.408598] Starting dynamic subtest: vcs0 [672.472790] Dynamic subtest vcs0: SUCCESS (0.077s) [672.485796] Starting dynamic subtest: vcs1 [672.553913] Dynamic subtest vcs1: SUCCESS (0.080s) [672.567319] Starting dynamic subtest: vecs0 [672.631798] Dynamic subtest vecs0: SUCCESS (0.076s) [672.646513] Starting dynamic subtest: ccs0 [672.725964] Dynamic subtest ccs0: SUCCESS (0.094s) [672.728461] Subtest implicit-boths: SUCCESS (0.445s) [674.400576] [119/156] (431s left) kms_pwrite_crc (basic) [674.496367] Starting subtest: basic [675.209965] Subtest basic: SUCCESS (0.715s) [676.100578] [120/156] (429s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [676.197581] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [676.201592] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [676.296363] [121/156] (429s left) kms_psr (fbc-psr-dpms) [676.392967] Starting subtest: fbc-psr-dpms [676.395243] Starting dynamic subtest: eDP-1 [676.399244] Dynamic subtest eDP-1: SKIP (0.000s) [676.403298] Subtest fbc-psr-dpms: SKIP (0.001s) [676.467365] [122/156] (429s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [676.563372] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [676.567694] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [676.663946] [123/156] (429s left) kms_big_fb (4-tiled-addfb-size-overflow) [676.754727] Starting subtest: 4-tiled-addfb-size-overflow [676.757003] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [676.857145] [124/156] (429s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu) [676.955200] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu [676.959150] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [677.050065] [125/156] (428s left) kms_pm_rpm (modeset-lpsp-stress) [678.573191] Starting subtest: modeset-lpsp-stress [693.983108] Subtest modeset-lpsp-stress: SUCCESS (15.408s) [694.085235] [126/156] (411s left) api_intel_allocator (fork-simple-stress-signal) [694.139935] Starting subtest: fork-simple-stress-signal [699.558318] Subtest fork-simple-stress-signal: SUCCESS (5.418s) [699.809911] [127/156] (406s left) gem_flink_basic (flink-lifetime) [699.901149] Starting subtest: flink-lifetime [699.903763] Subtest flink-lifetime: SUCCESS (0.003s) [700.215559] [128/156] (405s left) i915_query (query-topology-matches-eu-total) [700.412876] Starting subtest: query-topology-matches-eu-total [700.415645] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [700.612598] [129/156] (405s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [700.720040] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [700.724462] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [701.871575] [130/156] (404s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [701.986631] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [709.420394] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.437s) [709.565149] [131/156] (396s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [709.668293] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [709.672401] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [709.773352] [132/156] (396s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [709.874422] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [714.214834] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.346s) [715.386905] [133/156] (390s left) syncobj_timeline (transfer-timeline-point) [715.449476] Starting subtest: transfer-timeline-point [715.451670] Subtest transfer-timeline-point: SUCCESS (0.000s) [715.562435] [134/156] (390s left) kms_psr (fbc-pr-primary-page-flip) [715.650113] Starting subtest: fbc-pr-primary-page-flip [715.654403] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [715.738343] [135/156] (390s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt) [715.835892] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt [715.840138] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [715.934199] [136/156] (390s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [715.987539] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [715.991627] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [716.174211] [137/156] (390s left) kms_plane (plane-position-hole) [716.264243] Starting subtest: plane-position-hole [716.798284] Starting dynamic subtest: pipe-A-plane-1 [718.096021] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s) [718.107668] Starting dynamic subtest: pipe-A-plane-2 [719.392226] Dynamic subtest pipe-A-plane-2: SUCCESS (1.293s) [719.403491] Starting dynamic subtest: pipe-A-plane-3 [720.729893] Dynamic subtest pipe-A-plane-3: SUCCESS (1.337s) [720.741205] Starting dynamic subtest: pipe-A-plane-4 [722.062119] Dynamic subtest pipe-A-plane-4: SUCCESS (1.331s) [722.073373] Starting dynamic subtest: pipe-A-plane-5 [722.085486] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [723.339771] Starting dynamic subtest: pipe-B-plane-1 [724.663669] Dynamic subtest pipe-B-plane-1: SUCCESS (1.330s) [724.677367] Starting dynamic subtest: pipe-B-plane-2 [726.006076] Dynamic subtest pipe-B-plane-2: SUCCESS (1.345s) [726.017212] Starting dynamic subtest: pipe-B-plane-3 [727.344773] Dynamic subtest pipe-B-plane-3: SUCCESS (1.337s) [727.356900] Starting dynamic subtest: pipe-B-plane-4 [728.677226] Dynamic subtest pipe-B-plane-4: SUCCESS (1.332s) [728.690680] Starting dynamic subtest: pipe-B-plane-5 [728.701772] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [728.704086] Subtest plane-position-hole: SUCCESS (12.439s) [729.529597] [138/156] (376s left) prime_mmap_kms (buffer-sharing) [729.627323] Starting subtest: buffer-sharing [730.079894] Subtest buffer-sharing: SUCCESS (0.452s) [730.965842] [139/156] (375s left) kms_addfb_basic (unused-pitches) [731.025403] Starting subtest: unused-pitches [731.027386] Subtest unused-pitches: SUCCESS (0.000s) [731.184364] [140/156] (375s left) kms_addfb_basic (tile-pitch-mismatch) [731.241877] Starting subtest: tile-pitch-mismatch [731.245982] Subtest tile-pitch-mismatch: SKIP (0.000s) [731.377312] [141/156] (375s left) core_sysfs (read-all-entries) [731.451577] Starting subtest: read-all-entries [731.460603] Subtest read-all-entries: SUCCESS (0.010s) [731.566514] [142/156] (375s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [731.668619] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [738.379210] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.713s) [738.513413] [143/156] (368s left) vgem_basic (dmabuf-fence-before) [738.558706] Starting subtest: dmabuf-fence-before [738.561186] Subtest dmabuf-fence-before: SUCCESS (0.001s) [738.618215] [144/156] (368s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [738.720532] Starting subtest: psr-2p-primscrn-cur-indfb-move [738.724861] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [738.810853] [145/156] (368s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [738.911233] Starting subtest: yf-tiled-8bpp-rotate-270 [738.915159] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [739.014200] [146/156] (367s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [739.111387] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [743.584501] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.478s) [744.795588] [147/156] (362s left) perf (stress-open-close) [744.902827] Starting subtest: stress-open-close [744.905348] Starting dynamic subtest: 0-rcs0 [747.066781] Dynamic subtest 0-rcs0: SUCCESS (2.164s) [747.078287] Starting dynamic subtest: 1-vcs0 [749.231842] Dynamic subtest 1-vcs0: SUCCESS (2.164s) [749.233822] Subtest stress-open-close: SUCCESS (4.330s) [749.282230] [148/156] (357s left) kms_pipe_crc_basic (disable-crc-after-crtc) [749.377115] Starting subtest: disable-crc-after-crtc [749.379077] Starting dynamic subtest: pipe-A-eDP-1 [751.023781] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.646s) [751.036039] Starting dynamic subtest: pipe-B-eDP-1 [753.391047] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s) [753.403112] Starting dynamic subtest: pipe-C-eDP-1 [755.653514] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.260s) [755.664852] Starting dynamic subtest: pipe-D-eDP-1 [757.914126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s) [757.916468] Subtest disable-crc-after-crtc: SUCCESS (8.538s) [758.738473] [149/156] (348s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [758.844089] Starting subtest: fbc-psr2-cursor-plane-update-sf [758.846313] Starting dynamic subtest: pipe-A-eDP-1 [758.922625] Dynamic subtest pipe-A-eDP-1: SKIP (0.082s) [758.934070] Starting dynamic subtest: pipe-B-eDP-1 [760.124719] Dynamic subtest pipe-B-eDP-1: SKIP (1.201s) [760.129320] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.285s) [761.415083] [150/156] (345s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [761.513247] Starting subtest: primary-y-tiled-reflect-x-90 [761.517824] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [761.600860] [151/156] (345s left) gem_exec_params (rsvd2-dirt) [761.655363] Starting subtest: rsvd2-dirt [761.660500] Subtest rsvd2-dirt: SKIP (0.000s) [761.763628] [152/156] (345s left) i915_drm_fdinfo (memory-info-resident) [761.803352] Starting subtest: memory-info-resident [761.805664] Starting dynamic subtest: smem0 [764.524772] Dynamic subtest smem0: SUCCESS (2.723s) [764.527112] Subtest memory-info-resident: SUCCESS (2.723s) [764.613168] [153/156] (342s left) i915_suspend (basic-s3-without-i915) [764.641556] Starting subtest: basic-s3-without-i915 [767.387334] Subtest basic-s3-without-i915: SKIP (2.739s) [769.068536] [154/156] (338s left) gem_eio (hibernate) [769.215971] Starting subtest: hibernate [783.908803] Subtest hibernate: SUCCESS (14.690s) [793.053756] [155/156] (323s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [793.179708] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt [793.183660] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [793.307104] [156/156] (322s left) kms_setmode (invalid-clone-exclusive-crtc) [793.375648] Starting subtest: invalid-clone-exclusive-crtc [793.382323] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [793.489118] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: gem_mmap_gtt results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_chamelium_edid results: parsing output: 7/ for test: kms_cursor_legacy results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_lmem_swapping results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: gem_ctx_sseu results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_vblank results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: gem_ctx_engines results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: kms_plane results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_exec_fence results: parsing output: 28/ for test: kms_busy results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_madvise results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_invalid_mode results: parsing output: 33/ for test: kms_dsc results: parsing output: 34/ for test: kms_chamelium_hpd results: parsing output: 35/ for test: core_getstats results: parsing output: 36/ for test: kms_plane_scaling results: parsing output: 37/ for test: kms_plane results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_rotation_crc results: parsing output: 40/ for test: kms_content_protection results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: gem_softpin results: parsing output: 46/ for test: kms_color_pipeline results: parsing output: 47/ for test: kms_dp_link_training results: parsing output: 48/ for test: gem_ctx_persistence results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_cursor_legacy results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_exec_fence results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: gem_mmap_offset results: parsing output: 60/ for test: gem_render_copy results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_lmem_swapping results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: sysfs_heartbeat_interval results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_plane_cursor results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_cursor_edge_walk results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_readwrite results: parsing output: 73/ for test: kms_atomic results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_atomic_transition results: parsing output: 76/ for test: gen7_exec_parse results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr2_sf results: parsing output: 84/ for test: i915_hangman results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: gem_pread results: parsing output: 88/ for test: syncobj_wait results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_set_tiling_vs_pwrite results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: perf results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gen9_exec_parse results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_pm_rpm results: parsing output: 101/ for test: gem_busy results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: i915_pm_rps results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_vrr results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_flip_scaled_crc results: parsing output: 110/ for test: kms_async_flips results: parsing output: 111/ for test: kms_flip_scaled_crc results: parsing output: 112/ for test: kms_cursor_crc results: parsing output: 113/ for test: gem_exec_whisper results: parsing output: 114/ for test: perf_pmu results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_pwrite_crc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_pm_rpm results: parsing output: 125/ for test: api_intel_allocator results: parsing output: 126/ for test: gem_flink_basic results: parsing output: 127/ for test: i915_query results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: syncobj_timeline results: parsing output: 133/ for test: kms_psr results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: gem_render_copy results: parsing output: 136/ for test: kms_plane results: parsing output: 137/ for test: prime_mmap_kms results: parsing output: 138/ for test: kms_addfb_basic results: parsing output: 139/ for test: kms_addfb_basic results: parsing output: 140/ for test: core_sysfs results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_big_fb results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: perf results: parsing output: 147/ for test: kms_pipe_crc_basic results: parsing output: 148/ for test: kms_psr2_sf results: parsing output: 149/ for test: kms_rotation_crc results: parsing output: 150/ for test: gem_exec_params results: parsing output: 151/ for test: i915_drm_fdinfo results: parsing output: 152/ for test: i915_suspend results: parsing output: 153/ for test: gem_eio results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_setmode Done.