[62.045804] Initializing watchdogs [62.045851] /dev/watchdog0 [62.060767] [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] [62.065287] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.067769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.070075] [001/133] (960s left) gem_exec_whisper (basic-forked-all) [62.148335] Starting subtest: basic-forked-all [76.132729] Subtest basic-forked-all: SUCCESS (13.989s) [76.320948] [002/133] (946s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [76.405059] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [76.406821] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [76.476151] [003/133] (946s left) gem_exec_reloc (basic-write-read-active) [76.526487] Subtest basic-write-read-active: SKIP (0.000s) [76.584084] [004/133] (946s left) kms_psr2_su (page_flip-xrgb8888) [76.629086] Subtest page_flip-XRGB8888: SKIP (0.000s) [76.672540] [005/133] (946s left) kms_atomic (plane-immutable-zpos) [76.752957] Starting subtest: plane-immutable-zpos [76.753923] Starting dynamic subtest: pipe-A-eDP-1 [77.435110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.682s) [77.436054] Subtest plane-immutable-zpos: SUCCESS (0.683s) [78.245171] [006/133] (944s left) gem_exec_schedule (deep) [78.419716] Starting subtest: deep [78.420710] Starting dynamic subtest: rcs0 [83.680403] Dynamic subtest rcs0: SKIP (5.258s) [83.689791] Starting dynamic subtest: vcs0 [93.733800] Dynamic subtest vcs0: SUCCESS (10.055s) [93.745943] Starting dynamic subtest: vcs1 [105.236835] Dynamic subtest vcs1: SUCCESS (11.502s) [105.248831] Starting dynamic subtest: vecs0 [116.734189] Dynamic subtest vecs0: SUCCESS (11.498s) [116.746894] Starting dynamic subtest: ccs0 [128.633993] Dynamic subtest ccs0: SUCCESS (11.898s) [128.635492] Subtest deep: SUCCESS (50.213s) [130.494866] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true [130.496577] [007/133] (892s left) syncobj_basic (bad-fd-to-handle) [130.546025] Starting subtest: bad-fd-to-handle [130.546975] Subtest bad-fd-to-handle: SUCCESS (0.000s) [130.657783] [008/133] (892s left) kms_content_protection (mei-interface) [130.791820] Starting subtest: mei-interface [130.793676] Subtest mei-interface: SKIP (0.001s) [130.907874] [009/133] (891s left) kms_psr (fbc-psr2-primary-page-flip) [130.999116] Starting subtest: fbc-psr2-primary-page-flip [130.999925] Starting dynamic subtest: eDP-1 [131.001792] Dynamic subtest eDP-1: SKIP (0.000s) [131.003503] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [131.085895] [010/133] (891s left) gem_create (create-massive) [131.137845] Starting subtest: create-massive [131.139262] Subtest create-massive: SUCCESS (0.000s) [131.316514] [011/133] (891s left) gem_ctx_persistence (userptr) [131.375136] Starting subtest: userptr [131.541933] Subtest userptr: SUCCESS (0.167s) [131.627701] [012/133] (891s left) gem_partial_pwrite_pread (reads-snoop) [131.688376] Subtest reads-snoop: SKIP (0.000s) [131.747985] [013/133] (891s left) kms_prop_blob (blob-prop-validate) [131.791109] Starting subtest: blob-prop-validate [131.792275] Subtest blob-prop-validate: SUCCESS (0.000s) [131.880076] [014/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [131.969123] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [131.971019] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [132.063055] [015/133] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [132.149728] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [138.700014] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.551s) [138.806390] [016/133] (884s left) gem_exec_reloc (basic-wc-gtt-noreloc) [138.871726] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [138.944195] [017/133] (884s left) gem_ctx_param (invalid-get-engines) [138.987550] Starting subtest: invalid-get-engines [138.988505] Subtest invalid-get-engines: SUCCESS (0.001s) [139.095537] [018/133] (884s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [139.196239] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [139.197120] Starting dynamic subtest: pipe-A-eDP-1 [139.205611] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [139.213255] Starting dynamic subtest: pipe-B-eDP-1 [139.221812] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [139.228693] Starting dynamic subtest: pipe-C-eDP-1 [139.237873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [139.244481] Starting dynamic subtest: pipe-D-eDP-1 [139.253395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [139.255071] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [141.419384] [019/133] (881s left) kms_big_fb (x-tiled-64bpp-rotate-270) [141.526119] Starting subtest: x-tiled-64bpp-rotate-270 [141.546909] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s) [141.646860] [020/133] (881s left) syncobj_timeline (single-wait-signaled) [141.705058] Starting subtest: single-wait-signaled [141.706042] Subtest single-wait-signaled: SUCCESS (0.001s) [141.806590] [021/133] (881s left) gem_ctx_create (basic-files) [141.868683] Starting subtest: basic-files [143.878613] Subtest basic-files: SUCCESS (2.009s) [144.601661] [022/133] (878s left) gem_exec_balancer (parallel-keep-in-fence) [144.868494] Starting subtest: parallel-keep-in-fence [146.159136] Subtest parallel-keep-in-fence: SUCCESS (1.291s) [146.259180] [023/133] (877s left) gem_exec_fence (syncobj-invalid-wait) [146.715437] Starting subtest: syncobj-invalid-wait [146.716532] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [148.013988] [024/133] (875s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [148.397824] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [149.234206] [025/133] (874s left) gem_exec_balancer (nop) [149.280130] Starting subtest: nop [195.985580] Subtest nop: SUCCESS (46.704s) [196.286456] [026/133] (827s left) syncobj_wait (wait-for-submit-snapshot) [196.340037] Starting subtest: wait-for-submit-snapshot [196.421815] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [196.493800] [027/133] (826s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [196.618622] Starting subtest: short-flip-before-cursor-atomic-transitions [197.580976] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.962s) [198.402592] [028/133] (825s left) gem_exec_reloc (basic-range-active) [198.454952] Subtest basic-range-active: SKIP (0.000s) [198.523434] [029/133] (825s left) kms_big_fb (4-tiled-32bpp-rotate-270) [198.609636] Starting subtest: 4-tiled-32bpp-rotate-270 [198.629227] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s) [198.729826] [030/133] (824s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [198.821906] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [198.852085] Starting dynamic subtest: pipe-A-plane-0 [199.140918] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [199.149441] Starting dynamic subtest: pipe-A-plane-3 [199.385373] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [199.394445] Starting dynamic subtest: pipe-A-plane-5 [199.396231] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [200.484949] Starting dynamic subtest: pipe-B-plane-0 [200.776938] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [200.785428] Starting dynamic subtest: pipe-B-plane-3 [201.021165] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s) [201.029177] Starting dynamic subtest: pipe-B-plane-5 [201.030845] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [201.342312] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.519s) [202.159998] [031/133] (821s left) gem_partial_pwrite_pread (writes-after-reads) [202.211733] Subtest writes-after-reads: SKIP (0.000s) [202.277852] [032/133] (821s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [202.359388] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [202.360511] Starting dynamic subtest: pipe-A-eDP-1 [202.505246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s) [202.514675] Starting dynamic subtest: pipe-B-eDP-1 [202.522648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [202.530286] Starting dynamic subtest: pipe-C-eDP-1 [202.539445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [202.546567] Starting dynamic subtest: pipe-D-eDP-1 [202.554463] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [202.555344] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s) [204.812832] [033/133] (818s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [204.900168] Starting subtest: fbc-psr2-sprite-mmap-cpu [204.901073] Starting dynamic subtest: eDP-1 [204.902829] Dynamic subtest eDP-1: SKIP (0.000s) [204.904729] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [204.966978] [034/133] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [205.050038] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [205.051840] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [205.144766] [035/133] (818s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [205.246769] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [205.248981] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [205.325656] [036/133] (818s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [205.379957] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [205.442113] [037/133] (818s left) gem_mmap_offset (blt-coherency) [205.505924] Starting subtest: blt-coherency [205.511319] Subtest blt-coherency: SUCCESS (0.007s) [205.650756] [038/133] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [205.739231] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [205.741333] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [205.835146] [039/133] (818s left) kms_rotation_crc (sprite-rotation-270) [205.931728] Starting subtest: sprite-rotation-270 [205.933553] Subtest sprite-rotation-270: SKIP (0.001s) [205.998452] [040/133] (817s left) sw_sync (sync_merge_same) [206.032225] Starting subtest: sync_merge_same [206.033077] Subtest sync_merge_same: SUCCESS (0.000s) [206.084632] [041/133] (817s left) syncobj_wait (single-wait-all-for-submit-signaled) [206.145757] Starting subtest: single-wait-all-for-submit-signaled [206.147025] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [206.230236] [042/133] (817s left) kms_chamelium_color (gamma) [206.324024] Subtest gamma: SKIP (0.000s) [206.364470] [043/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [206.459544] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [206.461148] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [206.540622] [044/133] (817s left) kms_draw_crc (draw-method-mmap-wc) [206.622382] Starting subtest: draw-method-mmap-wc [206.623333] Starting dynamic subtest: xrgb8888-untiled [206.888908] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [206.897676] Starting dynamic subtest: rgb565-untiled [207.100042] Dynamic subtest rgb565-untiled: SUCCESS (0.211s) [207.108052] Starting dynamic subtest: xrgb2101010-untiled [207.322232] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [207.331159] Starting dynamic subtest: xbgr16161616f-untiled [207.544784] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [207.553428] Starting dynamic subtest: xrgb8888-xtiled [207.677689] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [207.685621] Starting dynamic subtest: rgb565-xtiled [207.811215] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [207.820263] Starting dynamic subtest: xrgb2101010-xtiled [207.944294] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [207.951333] Starting dynamic subtest: xbgr16161616f-xtiled [208.077816] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [208.086061] Starting dynamic subtest: xrgb8888-4tiled [208.233212] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s) [208.247717] Starting dynamic subtest: rgb565-4tiled [208.399735] Dynamic subtest rgb565-4tiled: SUCCESS (0.165s) [208.413639] Starting dynamic subtest: xrgb2101010-4tiled [208.555366] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s) [208.564528] Starting dynamic subtest: xbgr16161616f-4tiled [208.744254] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s) [208.746891] Subtest draw-method-mmap-wc: SUCCESS (2.124s) [208.855825] [045/133] (815s left) kms_pm_rpm (cursor) [211.084284] Starting subtest: cursor [211.086712] Subtest cursor: SKIP (0.000s) [211.458416] [046/133] (812s left) gem_eio (in-flight-immediate) [211.711355] Starting subtest: in-flight-immediate [219.817756] Subtest in-flight-immediate: SUCCESS (8.107s) [219.966346] [047/133] (804s left) gem_exec_schedule (u-fairslice-all) [220.034347] Starting subtest: u-fairslice-all [222.090573] Subtest u-fairslice-all: SUCCESS (2.056s) [222.387953] [048/133] (801s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [222.481657] Starting subtest: switch-modeset-ultra-joiner-big-joiner [222.483331] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [222.548461] [049/133] (801s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [222.633065] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [222.633935] Starting dynamic subtest: pipe-A-eDP-1 [222.732822] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [222.741836] Starting dynamic subtest: pipe-B-eDP-1 [223.920880] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s) [223.922647] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.289s) [225.096978] [050/133] (799s left) kms_busy (extended-modeset-hang-oldfb) [225.189381] Starting subtest: extended-modeset-hang-oldfb [225.190349] Starting dynamic subtest: pipe-A [236.981957] Dynamic subtest pipe-A: SUCCESS (11.792s) [236.990698] Starting dynamic subtest: pipe-D [249.257774] Dynamic subtest pipe-D: SUCCESS (12.272s) [249.258798] Subtest extended-modeset-hang-oldfb: SUCCESS (24.068s) [250.155075] [051/133] (774s left) i915_selftest (live) [253.384264] Starting subtest: live [253.385371] Starting dynamic subtest: sanitycheck [257.712276] Dynamic subtest sanitycheck: SUCCESS (4.330s) [257.720235] Starting dynamic subtest: uncore [262.097059] Dynamic subtest uncore: SUCCESS (4.383s) [262.105470] Starting dynamic subtest: workarounds [266.753422] Dynamic subtest workarounds: SUCCESS (4.653s) [266.762023] Starting dynamic subtest: gt_engines [271.316708] Dynamic subtest gt_engines: SUCCESS (4.568s) [271.327381] Starting dynamic subtest: gt_timelines [289.073547] Dynamic subtest gt_timelines: SUCCESS (17.747s) [289.081912] Starting dynamic subtest: gt_contexts [293.416744] Dynamic subtest gt_contexts: SUCCESS (4.341s) [293.425552] Starting dynamic subtest: gt_lrc [297.834975] Dynamic subtest gt_lrc: SUCCESS (4.416s) [297.843848] Starting dynamic subtest: gt_mocs [302.298281] Dynamic subtest gt_mocs: SUCCESS (4.461s) [302.307473] Starting dynamic subtest: gt_pm [309.080884] Dynamic subtest gt_pm: SUCCESS (6.782s) [309.089717] Starting dynamic subtest: gt_heartbeat [313.426031] Dynamic subtest gt_heartbeat: SUCCESS (4.344s) [313.434558] Starting dynamic subtest: gt_tlb [322.778176] Dynamic subtest gt_tlb: SUCCESS (9.350s) [322.786886] Starting dynamic subtest: requests [336.163296] Dynamic subtest requests: SUCCESS (13.384s) [336.171887] Starting dynamic subtest: migrate [341.964542] Dynamic subtest migrate: SUCCESS (5.799s) [341.975567] Starting dynamic subtest: active [346.314994] Dynamic subtest active: SUCCESS (4.358s) [346.322641] Starting dynamic subtest: objects [351.195964] Dynamic subtest objects: SUCCESS (4.870s) [351.204786] Starting dynamic subtest: mman [354.511691] Dynamic subtest mman: SUCCESS (3.315s) [354.519379] Starting dynamic subtest: dmabuf [357.270448] Dynamic subtest dmabuf: SUCCESS (2.756s) [357.277717] Starting dynamic subtest: vma [361.653062] Dynamic subtest vma: SUCCESS (4.380s) [361.661491] Starting dynamic subtest: coherency [366.596222] Dynamic subtest coherency: SUCCESS (4.941s) [366.606234] Starting dynamic subtest: gtt [376.535920] Dynamic subtest gtt: SUCCESS (9.938s) [376.544178] Starting dynamic subtest: gem [384.596716] Dynamic subtest gem: SUCCESS (8.059s) [384.604223] Starting dynamic subtest: evict [390.130070] Dynamic subtest evict: SUCCESS (5.531s) [390.138703] Starting dynamic subtest: hugepages [398.893462] Dynamic subtest hugepages: SUCCESS (8.761s) [398.902264] Starting dynamic subtest: gem_contexts [425.833151] Dynamic subtest gem_contexts: SUCCESS (26.939s) [425.841349] Starting dynamic subtest: client [430.232834] Dynamic subtest client: SUCCESS (4.399s) [430.240851] Starting dynamic subtest: gem_migrate [434.629416] Dynamic subtest gem_migrate: SUCCESS (4.395s) [434.637024] Starting dynamic subtest: reset [438.945411] Dynamic subtest reset: SUCCESS (4.313s) [438.952538] Starting dynamic subtest: memory_region [441.718053] Dynamic subtest memory_region: SUCCESS (2.771s) [441.724901] Starting dynamic subtest: hangcheck [454.782480] Dynamic subtest hangcheck: SUCCESS (13.061s) [454.791497] Starting dynamic subtest: execlists [459.139528] Dynamic subtest execlists: SUCCESS (4.354s) [459.148279] Starting dynamic subtest: ring_submission [461.850488] Dynamic subtest ring_submission: SUCCESS (2.708s) [461.859395] Starting dynamic subtest: perf [466.220066] Dynamic subtest perf: SUCCESS (4.369s) [466.229469] Starting dynamic subtest: slpc [478.329583] Dynamic subtest slpc: SUCCESS (12.107s) [478.338271] Starting dynamic subtest: guc [482.246059] Dynamic subtest guc: SUCCESS (3.914s) [482.255166] Starting dynamic subtest: guc_multi_lrc [486.595800] Dynamic subtest guc_multi_lrc: SUCCESS (4.348s) [486.605464] Starting dynamic subtest: guc_hang [491.461916] Dynamic subtest guc_hang: SUCCESS (4.865s) [491.470554] Starting dynamic subtest: late_gt_pm [495.776398] Dynamic subtest late_gt_pm: SUCCESS (4.313s) [495.777691] Subtest live: SUCCESS (242.386s) [495.799622] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [495.800365] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [495.802212] [052/133] (528s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [497.375566] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [497.376445] Starting dynamic subtest: pipe-A-eDP-1 [497.379790] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [497.386883] Starting dynamic subtest: pipe-B-eDP-1 [497.390514] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [497.397282] Starting dynamic subtest: pipe-C-eDP-1 [497.400815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [497.407265] Starting dynamic subtest: pipe-D-eDP-1 [497.410882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [497.412609] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s) [499.716622] [FACT kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [499.718451] [FACT kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)] new: kernel.kmod_is_loaded.i915: true [499.720821] [053/133] (524s left) i915_pm_freq_api (freq-reset) [499.776642] Starting subtest: freq-reset [499.777908] Starting dynamic subtest: gt0 [499.919885] Dynamic subtest gt0: SUCCESS (0.143s) [499.927276] Starting dynamic subtest: gt1 [500.058267] Dynamic subtest gt1: SUCCESS (0.128s) [500.059367] Subtest freq-reset: SUCCESS (0.272s) [500.125422] [054/133] (524s left) kms_pm_rpm (modeset-pc8-residency-stress) [502.075298] Starting subtest: modeset-pc8-residency-stress [502.077520] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [502.450721] [055/133] (521s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [502.549437] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [502.550333] Starting dynamic subtest: pipe-A-eDP-1 [503.311544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s) [503.320434] Starting dynamic subtest: pipe-B-eDP-1 [505.188520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.876s) [505.195903] Starting dynamic subtest: pipe-C-eDP-1 [507.007140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.817s) [507.014667] Starting dynamic subtest: pipe-D-eDP-1 [508.856523] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.848s) [508.857431] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.305s) [509.980501] [056/133] (514s left) kms_invalid_mode (bad-hsync-end) [510.063457] Starting subtest: bad-hsync-end [510.064407] Starting dynamic subtest: pipe-A-eDP-1 [510.355075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [510.363844] Starting dynamic subtest: pipe-B-eDP-1 [510.364775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [510.371453] Starting dynamic subtest: pipe-C-eDP-1 [510.372387] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [510.378819] Starting dynamic subtest: pipe-D-eDP-1 [510.379734] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [510.380787] Subtest bad-hsync-end: SUCCESS (0.299s) [511.220167] [057/133] (513s left) gem_lmem_swapping (basic) [511.261504] Subtest basic: SKIP (0.000s) [511.304516] [058/133] (513s left) gem_mmap_gtt (cpuset-medium-copy) [511.350577] Subtest cpuset-medium-copy: SKIP (0.000s) [511.410071] [059/133] (513s left) kms_plane_alpha_blend (alpha-transparent-fb) [511.487522] Starting subtest: alpha-transparent-fb [511.775847] Starting dynamic subtest: pipe-A-eDP-1 [512.388227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s) [512.395625] Starting dynamic subtest: pipe-D-eDP-1 [513.767257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s) [513.768066] Subtest alpha-transparent-fb: SUCCESS (2.281s) [514.584735] [060/133] (510s left) gem_partial_pwrite_pread (write-snoop) [514.634213] Subtest write-snoop: SKIP (0.000s) [514.686380] [061/133] (509s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [514.771432] Starting subtest: plane-lut1d-ctm3x4-lut1d [514.964462] Starting dynamic subtest: pipe-A-plane-0 [515.164538] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s) [515.178720] Starting dynamic subtest: pipe-A-plane-1 [515.330494] Dynamic subtest pipe-A-plane-1: SUCCESS (0.164s) [515.339199] Starting dynamic subtest: pipe-A-plane-2 [515.497287] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [516.710151] Starting dynamic subtest: pipe-B-plane-0 [516.868565] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [516.875901] Starting dynamic subtest: pipe-B-plane-1 [517.057586] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [517.066278] Starting dynamic subtest: pipe-B-plane-2 [517.224070] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s) [518.420759] Starting dynamic subtest: pipe-C-plane-0 [518.558167] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [518.565354] Starting dynamic subtest: pipe-C-plane-1 [518.714441] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [518.724449] Starting dynamic subtest: pipe-C-plane-2 [518.880551] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [520.091954] Starting dynamic subtest: pipe-D-plane-0 [520.250587] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [520.260626] Starting dynamic subtest: pipe-D-plane-1 [520.417401] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [520.424905] Starting dynamic subtest: pipe-D-plane-2 [520.561925] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [520.846649] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.074s) [521.644683] [062/133] (503s left) kms_universal_plane (universal-plane-sanity) [521.736403] Starting subtest: universal-plane-sanity [521.737348] Starting dynamic subtest: pipe-A-eDP-1 [522.333575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s) [522.342304] Starting dynamic subtest: pipe-B-eDP-1 [523.563126] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s) [523.570474] Starting dynamic subtest: pipe-C-eDP-1 [524.786499] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s) [524.809919] Starting dynamic subtest: pipe-D-eDP-1 [526.014695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [526.015585] Subtest universal-plane-sanity: SUCCESS (4.278s) [526.884327] [063/133] (497s left) kms_getfb (getfb-handle-closed) [526.976463] Starting subtest: getfb-handle-closed [526.977431] Subtest getfb-handle-closed: SUCCESS (0.000s) [527.067484] [064/133] (497s left) gem_workarounds (basic-read) [527.135883] Starting subtest: basic-read [527.146202] Subtest basic-read: SUCCESS (0.011s) [527.258173] [065/133] (497s left) gem_exec_flush (basic-uc-ro-default) [527.310475] Starting subtest: basic-uc-ro-default [532.769791] Subtest basic-uc-ro-default: SUCCESS (5.459s) [532.972257] [066/133] (491s left) gen9_exec_parse (valid-registers) [533.028826] Subtest valid-registers: SKIP (0.000s) [533.095792] [067/133] (491s left) syncobj_wait (multi-wait-for-submit-signaled) [533.153888] Starting subtest: multi-wait-for-submit-signaled [533.154902] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [533.271998] [068/133] (491s left) gem_mmap_gtt (fault-concurrent) [533.322132] Subtest fault-concurrent: SKIP (0.000s) [533.376764] [069/133] (491s left) gem_softpin (evict-prime-sanity-check) [533.436782] Starting subtest: evict-prime-sanity-check [533.437829] Starting dynamic subtest: rcs0 [534.579778] Dynamic subtest rcs0: SUCCESS (1.142s) [534.590162] Starting dynamic subtest: bcs0 [535.695355] Dynamic subtest bcs0: SUCCESS (1.115s) [535.705336] Starting dynamic subtest: vcs0 [536.890455] Dynamic subtest vcs0: SUCCESS (1.193s) [536.904186] Starting dynamic subtest: vcs1 [538.913499] Dynamic subtest vcs1: SUCCESS (2.010s) [538.924894] Starting dynamic subtest: vecs0 [540.890287] Dynamic subtest vecs0: SUCCESS (1.974s) [540.899780] Starting dynamic subtest: ccs0 [542.005770] Dynamic subtest ccs0: SUCCESS (1.123s) [542.016773] Starting dynamic subtest: all [543.122418] Dynamic subtest all: SUCCESS (1.115s) [543.126293] Subtest evict-prime-sanity-check: SUCCESS (9.687s) [543.199246] [070/133] (481s left) gem_ccs (block-multicopy-compressed) [543.252444] Starting subtest: block-multicopy-compressed [543.254445] Subtest block-multicopy-compressed: SKIP (0.000s) [543.358991] [071/133] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [543.472100] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [550.273186] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.800s) [550.417471] [072/133] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [550.522588] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [550.524428] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [550.607438] [073/133] (474s left) kms_big_fb (linear-64bpp-rotate-270) [550.695697] Starting subtest: linear-64bpp-rotate-270 [550.716604] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [550.828787] [074/133] (474s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [550.912446] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [550.913484] Starting dynamic subtest: pipe-A-default-mode [553.641541] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s) [553.642428] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.730s) [554.482756] [075/133] (470s left) syncobj_timeline (multi-wait-available-signaled) [554.540258] Starting subtest: multi-wait-available-signaled [554.541191] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [554.647873] [076/133] (470s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [554.696585] Starting subtest: etime-multi-wait-all-submitted-signaled [554.800826] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s) [554.872061] [077/133] (470s left) gem_userptr_blits (create-destroy-sync) [554.953132] Starting subtest: create-destroy-sync [560.016600] Subtest create-destroy-sync: SUCCESS (5.018s) [560.095138] [078/133] (465s left) kms_cursor_crc (cursor-sliding-128x42) [560.348265] Starting subtest: cursor-sliding-128x42 [560.394811] Subtest cursor-sliding-128x42: SKIP (0.044s) [560.609027] [079/133] (464s left) kms_flip (blocking-wf_vblank) [560.699417] Starting subtest: blocking-wf_vblank [560.700322] Starting dynamic subtest: A-eDP1 [569.667238] Dynamic subtest A-eDP1: SUCCESS (8.941s) [569.677764] Starting dynamic subtest: B-eDP1 [578.588752] Dynamic subtest B-eDP1: SUCCESS (8.918s) [578.598572] Starting dynamic subtest: C-eDP1 [587.524543] Dynamic subtest C-eDP1: SUCCESS (8.921s) [587.534818] Starting dynamic subtest: D-eDP1 [596.462395] Dynamic subtest D-eDP1: SUCCESS (8.933s) [596.463687] Subtest blocking-wf_vblank: SUCCESS (35.727s) [597.649884] [080/133] (427s left) gem_exec_schedule (preempt-contexts) [597.716643] Starting subtest: preempt-contexts [597.717583] Starting dynamic subtest: rcs0 [597.786943] Dynamic subtest rcs0: SUCCESS (0.070s) [597.795802] Starting dynamic subtest: bcs0 [597.835640] Dynamic subtest bcs0: SUCCESS (0.048s) [597.846193] Starting dynamic subtest: vcs0 [597.882592] Dynamic subtest vcs0: SUCCESS (0.046s) [597.890180] Starting dynamic subtest: vcs1 [597.933676] Dynamic subtest vcs1: SUCCESS (0.050s) [597.947167] Starting dynamic subtest: vecs0 [597.980196] Dynamic subtest vecs0: SUCCESS (0.045s) [597.990209] Starting dynamic subtest: ccs0 [598.031988] Dynamic subtest ccs0: SUCCESS (0.051s) [598.032903] Subtest preempt-contexts: SUCCESS (0.316s) [599.977445] [081/133] (425s left) kms_cursor_legacy (single-bo) [600.098154] Starting subtest: single-bo [600.099073] Starting dynamic subtest: pipe-A [605.525224] Dynamic subtest pipe-A: SUCCESS (5.379s) [605.535229] Starting dynamic subtest: pipe-B [610.871023] Dynamic subtest pipe-B: SUCCESS (5.380s) [610.880637] Starting dynamic subtest: pipe-C [616.292015] Dynamic subtest pipe-C: SUCCESS (5.380s) [616.301578] Starting dynamic subtest: pipe-D [621.673419] Dynamic subtest pipe-D: SUCCESS (5.379s) [621.683870] Starting dynamic subtest: all-pipes [627.062955] Dynamic subtest all-pipes: SUCCESS (5.386s) [627.064350] Subtest single-bo: SUCCESS (26.918s) [627.172067] [082/133] (398s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [627.281312] Starting subtest: fbcpsr-rgb101010-draw-render [634.041676] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.760s) [634.149152] [083/133] (391s left) gem_eio (context-create) [634.377576] Starting subtest: context-create [634.724756] Subtest context-create: SUCCESS (0.348s) [634.833464] [084/133] (390s left) i915_pm_rpm (gem-execbuf-stress) [637.059328] Starting subtest: gem-execbuf-stress [637.060560] Starting dynamic subtest: smem0 [650.802731] Dynamic subtest smem0: SUCCESS (13.733s) [650.812684] Starting dynamic subtest: extra-wait-smem0 [713.009528] Dynamic subtest extra-wait-smem0: SUCCESS (62.166s) [713.010579] Subtest gem-execbuf-stress: SUCCESS (75.906s) [713.346971] [085/133] (312s left) perf_pmu (busy-start) [713.385755] Starting subtest: busy-start [713.386696] Starting dynamic subtest: rcs0 [715.937896] Dynamic subtest rcs0: SUCCESS (2.551s) [715.948523] Starting dynamic subtest: bcs0 [718.501242] Dynamic subtest bcs0: SUCCESS (2.548s) [718.511233] Starting dynamic subtest: vcs0 [721.884739] Dynamic subtest vcs0: SUCCESS (3.385s) [721.894856] Starting dynamic subtest: vcs1 [725.917117] Dynamic subtest vcs1: SUCCESS (4.029s) [725.926111] Starting dynamic subtest: vecs0 [729.948922] Dynamic subtest vecs0: SUCCESS (4.029s) [729.957826] Starting dynamic subtest: ccs0 [732.503371] Dynamic subtest ccs0: SUCCESS (2.548s) [732.504376] Subtest busy-start: SUCCESS (19.105s) [732.608682] [086/133] (292s left) gem_linear_blits (interruptible) [733.138810] Starting subtest: interruptible [738.724348] Subtest interruptible: SUCCESS (5.579s) [738.881147] [087/133] (286s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [739.019320] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [739.020974] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [739.120299] [088/133] (286s left) gem_mmap_offset (pf-nonblock) [739.173809] Starting subtest: pf-nonblock [739.179413] Subtest pf-nonblock: SUCCESS (0.006s) [739.294179] [089/133] (286s left) kms_scaling_modes (scaling-mode-center) [739.382483] Starting subtest: scaling-mode-center [739.383382] Starting dynamic subtest: pipe-A-eDP-1 [739.480281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s) [739.491580] Starting dynamic subtest: pipe-B-eDP-1 [740.668092] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s) [740.683704] Starting dynamic subtest: pipe-C-eDP-1 [741.777251] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [741.787972] Starting dynamic subtest: pipe-D-eDP-1 [742.910045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [742.912241] Subtest scaling-mode-center: SUCCESS (3.530s) [744.064878] [090/133] (281s left) kms_psr (psr2-primary-mmap-cpu) [744.157359] Starting subtest: psr2-primary-mmap-cpu [744.158271] Starting dynamic subtest: eDP-1 [745.860213] Dynamic subtest eDP-1: SUCCESS (1.702s) [745.861083] Subtest psr2-primary-mmap-cpu: SUCCESS (1.703s) [746.725023] [091/133] (278s left) kms_cursor_crc (cursor-onscreen-64x64) [746.888962] Starting subtest: cursor-onscreen-64x64 [746.893502] Starting dynamic subtest: pipe-A-eDP-1 [749.012699] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s) [749.051773] Starting dynamic subtest: pipe-D-eDP-1 [751.821588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s) [751.822534] Subtest cursor-onscreen-64x64: SUCCESS (4.932s) [752.693316] [092/133] (273s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [752.805917] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [752.807943] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [752.915932] [093/133] (272s left) vgem_basic (bad-pad) [752.957593] Starting subtest: bad-pad [752.958558] Subtest bad-pad: SUCCESS (0.000s) [753.010997] [094/133] (272s left) kms_hdr (bpc-switch-dpms) [753.097139] Starting subtest: bpc-switch-dpms [754.164112] Starting dynamic subtest: pipe-A-eDP-1 [758.694761] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.531s) [758.695759] Subtest bpc-switch-dpms: SUCCESS (5.598s) [758.801924] [095/133] (266s left) kms_cursor_edge_walk (256x256-left-edge) [758.893335] Starting subtest: 256x256-left-edge [758.894298] Starting dynamic subtest: pipe-A-eDP-1 [762.342835] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s) [762.352177] Starting dynamic subtest: pipe-D-eDP-1 [765.532787] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.188s) [765.534027] Subtest 256x256-left-edge: SUCCESS (6.640s) [766.338658] [096/133] (259s left) kms_big_fb (y-tiled-32bpp-rotate-180) [766.445954] Starting subtest: y-tiled-32bpp-rotate-180 [766.447957] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [766.534320] [097/133] (259s left) core_setmaster (master-drop-set-shared-fd) [766.675201] Starting subtest: master-drop-set-shared-fd [766.739354] Subtest master-drop-set-shared-fd: SUCCESS (0.011s) [766.794395] [098/133] (259s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [766.840749] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [766.842533] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [767.020689] [099/133] (258s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [767.108616] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [767.110534] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [767.190257] [100/133] (258s left) syncobj_wait (wait-all-for-submit-complex) [767.236315] Starting subtest: wait-all-for-submit-complex [767.458950] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [767.533156] [101/133] (258s left) api_intel_allocator (reloc-allocator) [767.575954] Starting subtest: reloc-allocator [767.576853] Starting dynamic subtest: basic [767.578906] Dynamic subtest basic: SUCCESS (0.003s) [767.586950] Starting dynamic subtest: parallel-one [767.587886] Dynamic subtest parallel-one: SUCCESS (0.008s) [767.596026] Starting dynamic subtest: print [767.596924] Dynamic subtest print: SUCCESS (0.000s) [767.605460] Starting dynamic subtest: reuse [767.606516] Dynamic subtest reuse: SUCCESS (0.000s) [767.614186] Starting dynamic subtest: fork-reopen-allocator [767.615142] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [767.616054] Subtest reloc-allocator: SUCCESS (0.026s) [767.722708] [102/133] (258s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [767.830597] Starting subtest: cursorA-vs-flipB-varying-size [767.832439] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [767.970484] [103/133] (258s left) kms_async_flips (async-flip-dpms) [768.054749] Starting subtest: async-flip-dpms [768.428437] Starting dynamic subtest: pipe-A-eDP-1 [772.263335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s) [772.644396] Starting dynamic subtest: pipe-B-eDP-1 [775.435939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.799s) [775.814157] Starting dynamic subtest: pipe-C-eDP-1 [778.617886] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.811s) [779.000788] Starting dynamic subtest: pipe-D-eDP-1 [781.777539] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s) [781.778455] Subtest async-flip-dpms: SUCCESS (13.724s) [782.953152] [104/133] (243s left) kms_flip_event_leak (basic) [783.052696] Starting subtest: basic [783.053644] Starting dynamic subtest: pipe-A-eDP-1 [783.483221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s) [783.491587] Starting dynamic subtest: pipe-B-eDP-1 [784.581208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.097s) [784.593768] Starting dynamic subtest: pipe-C-eDP-1 [785.690282] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [785.703322] Starting dynamic subtest: pipe-D-eDP-1 [786.808322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s) [786.809162] Subtest basic: SUCCESS (3.756s) [787.671748] [105/133] (238s left) kms_setmode (invalid-clone-exclusive-crtc) [787.724377] Starting subtest: invalid-clone-exclusive-crtc [787.726896] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [787.821865] [106/133] (238s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [787.942793] Starting subtest: basic-flip-before-cursor-atomic [788.855861] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s) [789.710553] [107/133] (236s left) api_intel_bb (delta-check) [789.760619] Starting subtest: delta-check [789.768086] Subtest delta-check: SUCCESS (0.007s) [789.887045] [108/133] (236s left) kms_force_connector_basic (prune-stale-modes) [789.955416] Starting subtest: prune-stale-modes [790.416887] Subtest prune-stale-modes: SUCCESS (0.463s) [790.549723] [109/133] (235s left) gem_exec_reloc (basic-wc-read) [790.599981] Subtest basic-wc-read: SKIP (0.000s) [790.663690] [110/133] (235s left) gem_userptr_blits (sd-probe) [790.722553] Starting subtest: sd-probe [790.723578] Subtest sd-probe: SUCCESS (0.000s) [790.850483] [111/133] (235s left) perf_pmu (busy-check-all) [790.887968] Starting subtest: busy-check-all [790.888935] Starting dynamic subtest: rcs0 [791.446415] Dynamic subtest rcs0: SUCCESS (0.558s) [791.458772] Starting dynamic subtest: bcs0 [791.997679] Dynamic subtest bcs0: SUCCESS (0.549s) [792.010189] Starting dynamic subtest: vcs0 [793.949409] Dynamic subtest vcs0: SUCCESS (1.940s) [793.960644] Starting dynamic subtest: vcs1 [795.935464] Dynamic subtest vcs1: SUCCESS (1.983s) [795.946635] Starting dynamic subtest: vecs0 [797.917053] Dynamic subtest vecs0: SUCCESS (1.979s) [797.928911] Starting dynamic subtest: ccs0 [798.466328] Dynamic subtest ccs0: SUCCESS (0.555s) [798.467916] Subtest busy-check-all: SUCCESS (7.579s) [798.564229] [112/133] (227s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [798.652547] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [798.653537] Starting dynamic subtest: pipe-A-eDP-1 [798.677484] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [798.686907] Starting dynamic subtest: pipe-B-eDP-1 [798.709270] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [798.718074] Starting dynamic subtest: pipe-C-eDP-1 [798.740230] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [798.748770] Starting dynamic subtest: pipe-D-eDP-1 [798.771198] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [798.772930] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s) [800.939963] [113/133] (225s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [801.065315] Starting subtest: verify-pxp-stale-buf-optout-execution [802.123888] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.059s) [802.256821] [114/133] (224s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [802.363230] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [802.365059] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [802.455430] [115/133] (224s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [802.520933] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [802.625038] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s) [802.709402] [116/133] (223s left) perf_pmu (all-busy-idle-check-all) [802.743690] Starting subtest: all-busy-idle-check-all [803.934582] Subtest all-busy-idle-check-all: SUCCESS (1.180s) [804.028973] [117/133] (222s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [804.124497] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [811.276751] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.153s) [811.385064] [118/133] (215s left) kms_addfb_basic (addfb25-bad-modifier) [811.475337] Starting subtest: addfb25-bad-modifier [811.476132] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [811.563961] [119/133] (215s left) kms_vblank (query-forked-hang) [811.642185] Starting subtest: query-forked-hang [811.642991] Starting dynamic subtest: pipe-A-eDP-1 [837.726167] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.082s) [837.738466] Starting dynamic subtest: pipe-D-eDP-1 [861.654212] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.925s) [861.655063] Subtest query-forked-hang: SUCCESS (50.011s) [862.520604] [120/133] (164s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [862.609527] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [862.611089] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [862.710789] [121/133] (164s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [862.800508] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [862.801441] Starting dynamic subtest: pipe-A [863.917746] Dynamic subtest pipe-A: SUCCESS (1.118s) [863.926040] Starting dynamic subtest: pipe-B [866.100506] Dynamic subtest pipe-B: SUCCESS (2.182s) [866.108840] Starting dynamic subtest: pipe-C [867.272609] Dynamic subtest pipe-C: SUCCESS (1.171s) [867.280830] Starting dynamic subtest: pipe-D [868.459809] Dynamic subtest pipe-D: SUCCESS (1.186s) [868.462068] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.661s) [869.634696] [122/133] (157s left) gen9_exec_parse (batch-invalid-length) [869.698409] Subtest batch-invalid-length: SKIP (0.000s) [869.761516] [123/133] (157s left) kms_flip (bo-too-big) [869.845666] Starting subtest: bo-too-big [869.847789] Starting dynamic subtest: A-eDP1 [871.154626] Dynamic subtest A-eDP1: SUCCESS (1.303s) [871.166221] Starting dynamic subtest: B-eDP1 [872.440407] Dynamic subtest B-eDP1: SUCCESS (1.282s) [872.450955] Starting dynamic subtest: C-eDP1 [873.758718] Dynamic subtest C-eDP1: SUCCESS (1.317s) [873.769845] Starting dynamic subtest: D-eDP1 [875.062713] Dynamic subtest D-eDP1: SUCCESS (1.305s) [875.063748] Subtest bo-too-big: SUCCESS (5.217s) [876.215894] [124/133] (150s left) gem_softpin (noreloc-interruptible) [876.278207] Starting subtest: noreloc-interruptible [881.716411] Subtest noreloc-interruptible: SUCCESS (5.393s) [881.776587] [125/133] (145s left) syncobj_timeline (invalid-query-zero-handles) [881.830540] Starting subtest: invalid-query-zero-handles [881.831761] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [881.929481] [126/133] (144s left) kms_addfb_basic (too-high) [882.026345] Starting subtest: too-high [882.027199] Subtest too-high: SUCCESS (0.001s) [882.121877] [127/133] (144s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [882.220538] Starting subtest: yf-tiled-32bpp-rotate-0 [882.222270] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [882.318377] [128/133] (144s left) sw_sync (sync_multi_timeline_wait) [882.347244] Starting subtest: sync_multi_timeline_wait [882.348390] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [882.403117] [129/133] (144s left) kms_addfb_basic (bo-too-small) [882.492049] Starting subtest: bo-too-small [882.493044] Subtest bo-too-small: SUCCESS (0.000s) [882.607448] [130/133] (144s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [882.691513] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [882.692448] Starting dynamic subtest: pipe-A [882.712420] Dynamic subtest pipe-A: SKIP (0.018s) [882.731508] Starting dynamic subtest: pipe-B [882.750474] Dynamic subtest pipe-B: SKIP (0.035s) [882.763368] Starting dynamic subtest: pipe-C [882.810890] Dynamic subtest pipe-C: SKIP (0.062s) [882.819854] Starting dynamic subtest: pipe-D [882.845397] Dynamic subtest pipe-D: SKIP (0.033s) [882.847225] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.154s) [882.951360] [131/133] (144s left) kms_psr (pr-cursor-mmap-gtt) [883.066332] Starting subtest: pr-cursor-mmap-gtt [883.068098] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [883.134451] [132/133] (143s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [883.235301] Starting subtest: fbc-rgb565-draw-mmap-gtt [883.236901] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [883.347822] [133/133] (143s left) perf_pmu (semaphore-busy) [883.385319] Starting subtest: semaphore-busy [883.386360] Starting dynamic subtest: rcs0 [885.038767] Dynamic subtest rcs0: SUCCESS (1.643s) [885.049836] Starting dynamic subtest: bcs0 [886.673702] Dynamic subtest bcs0: SUCCESS (1.632s) [886.684261] Starting dynamic subtest: vcs0 [890.454356] Dynamic subtest vcs0: SUCCESS (3.778s) [890.464300] Starting dynamic subtest: vcs1 [896.405816] Dynamic subtest vcs1: SUCCESS (5.948s) [896.416539] Starting dynamic subtest: vecs0 [902.421736] Dynamic subtest vecs0: SUCCESS (6.014s) [902.431863] Starting dynamic subtest: ccs0 [905.499454] Dynamic subtest ccs0: SUCCESS (3.074s) [905.500403] Subtest semaphore-busy: SUCCESS (22.106s) [905.603125] Closing watchdogs results: parsing output: 0/ for test: gem_exec_whisper results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: gem_exec_reloc results: parsing output: 3/ for test: kms_psr2_su results: parsing output: 4/ for test: kms_atomic results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: syncobj_basic results: parsing output: 7/ for test: kms_content_protection results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: gem_create results: parsing output: 10/ for test: gem_ctx_persistence results: parsing output: 11/ for test: gem_partial_pwrite_pread results: parsing output: 12/ for test: kms_prop_blob results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: gem_ctx_param results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: gem_ctx_create results: parsing output: 21/ for test: gem_exec_balancer results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: kms_chamelium_hpd results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_plane results: parsing output: 30/ for test: gem_partial_pwrite_pread results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_b_c_ivb results: parsing output: 36/ for test: gem_mmap_offset results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_rotation_crc results: parsing output: 39/ for test: sw_sync results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: kms_chamelium_color results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_draw_crc results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: gem_eio results: parsing output: 46/ for test: gem_exec_schedule results: parsing output: 47/ for test: kms_joiner results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: kms_busy results: parsing output: 50/ for test: i915_selftest results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: i915_pm_freq_api results: parsing output: 53/ for test: kms_pm_rpm results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_invalid_mode results: parsing output: 56/ for test: gem_lmem_swapping results: parsing output: 57/ for test: gem_mmap_gtt results: parsing output: 58/ for test: kms_plane_alpha_blend results: parsing output: 59/ for test: gem_partial_pwrite_pread results: parsing output: 60/ for test: kms_color_pipeline results: parsing output: 61/ for test: kms_universal_plane results: parsing output: 62/ for test: kms_getfb results: parsing output: 63/ for test: gem_workarounds results: parsing output: 64/ for test: gem_exec_flush results: parsing output: 65/ for test: gen9_exec_parse results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_mmap_gtt results: parsing output: 68/ for test: gem_softpin results: parsing output: 69/ for test: gem_ccs results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_flip_scaled_crc results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: gem_exec_schedule results: parsing output: 80/ for test: kms_cursor_legacy results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_eio results: parsing output: 83/ for test: i915_pm_rpm results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: gem_linear_blits results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_mmap_offset results: parsing output: 88/ for test: kms_scaling_modes results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: vgem_basic results: parsing output: 93/ for test: kms_hdr results: parsing output: 94/ for test: kms_cursor_edge_walk results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: core_setmaster results: parsing output: 97/ for test: gem_render_copy results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: api_intel_allocator results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: kms_flip_event_leak results: parsing output: 104/ for test: kms_setmode results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: api_intel_bb results: parsing output: 107/ for test: kms_force_connector_basic results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: gem_userptr_blits results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: gem_pxp results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: perf_pmu results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_addfb_basic results: parsing output: 118/ for test: kms_vblank results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_plane_scaling results: parsing output: 121/ for test: gen9_exec_parse results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: gem_softpin results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_addfb_basic results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: sw_sync results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: kms_plane_scaling results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: perf_pmu Done.