[55.974974] Initializing watchdogs [55.975042] /dev/watchdog0 [56.000232] [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] [56.004472] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.006779] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.010066] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.141521] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.146199] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [56.253901] [002/131] (960s left) gem_exec_fence (submit3) [56.451079] Starting subtest: submit3 [56.455228] Subtest submit3: SKIP (0.000s) [58.016985] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [58.020122] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [58.126642] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [58.130882] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [58.240836] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [58.338484] Starting subtest: fbc-rgb101010-draw-mmap-wc [62.922053] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.598s) [64.055836] [005/131] (952s left) gem_exec_balancer (noheartbeat) [64.328559] Starting subtest: noheartbeat [64.333320] Subtest noheartbeat: SKIP (0.000s) [64.464221] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red) [64.557421] Subtest ctm-blue-to-red: SKIP (0.000s) [64.600014] [007/131] (952s left) gem_workarounds (suspend-resume) [64.674437] Starting subtest: suspend-resume [81.037186] Subtest suspend-resume: SUCCESS (5.625s) [81.197539] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [81.305744] Starting subtest: planes-downscale-factor-0-75-unity-scaling [81.308670] Starting dynamic subtest: pipe-A [81.370362] Dynamic subtest pipe-A: SUCCESS (0.066s) [81.379481] Starting dynamic subtest: pipe-B [82.503604] Dynamic subtest pipe-B: SUCCESS (1.149s) [82.514740] Starting dynamic subtest: pipe-C [83.593507] Dynamic subtest pipe-C: SUCCESS (1.104s) [83.603716] Starting dynamic subtest: pipe-D [84.715527] Dynamic subtest pipe-D: SUCCESS (1.135s) [84.718574] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.455s) [85.880309] [009/131] (930s left) gem_pxp (create-regular-buffer) [86.016713] Starting subtest: create-regular-buffer [86.019176] Subtest create-regular-buffer: SUCCESS (0.000s) [86.159884] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [86.226801] Starting subtest: rel-constants-invalid-rel-gen5 [86.229545] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [86.361316] [011/131] (930s left) gem_exec_nop (basic-series) [86.444501] Starting subtest: basic-series [102.676058] Subtest basic-series: SUCCESS (16.305s) [102.930281] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [103.039550] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [103.045345] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [103.166629] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [103.257519] Starting subtest: fbc-psr-primary-page-flip [103.259990] Starting dynamic subtest: eDP-1 [103.264999] Dynamic subtest eDP-1: SKIP (0.000s) [103.270024] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [103.354996] [014/131] (913s left) i915_pm_rps (engine-order) [103.418996] Starting subtest: engine-order [108.376721] Subtest engine-order: SUCCESS (4.965s) [108.540888] [015/131] (908s left) gem_softpin (evict-active) [108.599790] Starting subtest: evict-active [108.611385] Subtest evict-active: SUCCESS (0.012s) [108.771886] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [108.835611] Starting subtest: wait-delayed-signal [108.937317] Subtest wait-delayed-signal: SUCCESS (0.103s) [109.052467] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [109.153165] Starting subtest: atomic-fastset [109.155804] Starting dynamic subtest: pipe-A-eDP-1 [109.296167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s) [109.305742] Starting dynamic subtest: pipe-B-eDP-1 [110.525499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s) [110.539780] Starting dynamic subtest: pipe-C-eDP-1 [111.705744] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s) [111.717117] Starting dynamic subtest: pipe-D-eDP-1 [112.843513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s) [112.846334] Subtest atomic-fastset: SUCCESS (3.691s) [114.037160] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [114.149710] Starting subtest: x-tiled-16bpp-rotate-270 [114.171629] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s) [114.315809] [019/131] (902s left) api_intel_bb (render-ccs) [114.377738] Starting subtest: render-ccs [114.736095] Subtest render-ccs: SUCCESS (0.358s) [114.885013] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [114.980649] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [114.983457] Starting dynamic subtest: pipe-A-eDP-1 [115.008197] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [115.018995] Starting dynamic subtest: pipe-B-eDP-1 [115.044736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [115.053971] Starting dynamic subtest: pipe-C-eDP-1 [115.079612] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [115.088652] Starting dynamic subtest: pipe-D-eDP-1 [115.114759] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [115.119569] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [117.284637] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [117.349722] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [117.450979] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [117.552416] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [117.652869] Starting subtest: psr-2p-primscrn-cur-indfb-move [117.657588] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [117.786389] [023/131] (899s left) gem_lmem_swapping (heavy-multi) [117.826468] Subtest heavy-multi: SKIP (0.000s) [117.867550] [024/131] (899s left) kms_async_flips (test-cursor) [117.965399] Starting subtest: test-cursor [117.970221] Subtest test-cursor: SKIP (0.000s) [119.214511] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [124.289009] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [124.291681] Starting dynamic subtest: pipe-A-eDP-1 [125.064446] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s) [125.074983] Starting dynamic subtest: pipe-B-eDP-1 [126.189618] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [126.195382] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.899s) [127.399757] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [127.489664] Starting subtest: 2x-tiling-4 [127.495165] Subtest 2x-tiling-4: SKIP (0.000s) [127.584293] [027/131] (890s left) gem_ctx_param (invalid-param-set) [127.648076] Starting subtest: invalid-param-set [127.651010] Subtest invalid-param-set: SUCCESS (0.000s) [127.752057] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [127.850110] Starting subtest: bad-pixel-format-y-tiled-ccs [127.852445] Starting dynamic subtest: pipe-A-eDP-1 [127.876130] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [127.886640] Starting dynamic subtest: pipe-B-eDP-1 [127.909450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [127.918173] Starting dynamic subtest: pipe-C-eDP-1 [127.940886] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [127.949175] Starting dynamic subtest: pipe-D-eDP-1 [127.972897] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [127.977599] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [130.156093] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [130.261308] Starting subtest: plane-downscale-factor-0-5-with-modifiers [130.263617] Starting dynamic subtest: pipe-A [130.282194] Dynamic subtest pipe-A: SKIP (0.017s) [130.291989] Starting dynamic subtest: pipe-B [130.311607] Dynamic subtest pipe-B: SKIP (0.031s) [130.321381] Starting dynamic subtest: pipe-C [130.342384] Dynamic subtest pipe-C: SKIP (0.030s) [130.351353] Starting dynamic subtest: pipe-D [130.374965] Dynamic subtest pipe-D: SKIP (0.030s) [130.379018] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.110s) [130.506546] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [130.569661] Starting subtest: multi-wait-all-available-submitted-signaled [130.572586] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [130.690305] [031/131] (887s left) perf (missing-sample-flags) [130.846570] Starting subtest: missing-sample-flags [130.849301] Subtest missing-sample-flags: SUCCESS (0.000s) [130.893405] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [130.990440] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [137.202893] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.218s) [138.376913] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [139.931638] Starting subtest: system-suspend-idle [159.264845] Subtest system-suspend-idle: SUCCESS (4.323s) [159.665472] [034/131] (858s left) kms_vblank (wait-forked) [159.771891] Starting subtest: wait-forked [159.774039] Starting dynamic subtest: pipe-A-eDP-1 [161.553521] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s) [161.569761] Starting dynamic subtest: pipe-D-eDP-1 [163.999850] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.475s) [164.002220] Subtest wait-forked: SUCCESS (4.275s) [164.878949] [035/131] (853s left) kms_big_fb (y-tiled-32bpp-rotate-0) [164.992833] Starting subtest: y-tiled-32bpp-rotate-0 [164.997248] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [165.112336] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [165.204547] Starting subtest: read-crc [165.206458] Starting dynamic subtest: pipe-A-eDP-1 [165.910674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [165.921818] Starting dynamic subtest: pipe-B-eDP-1 [167.308893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s) [167.320862] Starting dynamic subtest: pipe-C-eDP-1 [168.602240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s) [168.612304] Starting dynamic subtest: pipe-D-eDP-1 [169.931319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [169.933482] Subtest read-crc: SUCCESS (4.758s) [170.776101] [037/131] (847s left) kms_cursor_legacy (single-move) [170.902224] Starting subtest: single-move [170.904941] Starting dynamic subtest: pipe-A [176.268320] Dynamic subtest pipe-A: SUCCESS (5.379s) [176.280360] Starting dynamic subtest: pipe-B [181.639511] Dynamic subtest pipe-B: SUCCESS (5.380s) [181.650702] Starting dynamic subtest: pipe-C [187.014330] Dynamic subtest pipe-C: SUCCESS (5.379s) [187.025429] Starting dynamic subtest: pipe-D [192.391507] Dynamic subtest pipe-D: SUCCESS (5.380s) [192.403384] Starting dynamic subtest: all-pipes [197.782971] Dynamic subtest all-pipes: SUCCESS (5.387s) [197.785708] Subtest single-move: SUCCESS (26.914s) [197.948300] [038/131] (820s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [202.925091] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [202.929683] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [203.790794] [039/131] (814s left) gem_unref_active_buffers [204.021540] [040/131] (814s left) kms_psr (fbc-psr2-primary-mmap-gtt) [204.123501] Starting subtest: fbc-psr2-primary-mmap-gtt [204.125823] Starting dynamic subtest: eDP-1 [204.129962] Dynamic subtest eDP-1: SKIP (0.000s) [204.134162] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [204.223526] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [204.287541] Starting subtest: invalid-signal-zero-handles [204.289769] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [204.418979] [042/131] (813s left) gen9_exec_parse (bb-oversize) [204.487483] Subtest bb-oversize: SKIP (0.000s) [204.571566] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [204.616435] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [204.722031] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [204.824059] [044/131] (813s left) gem_exec_reloc (basic-write-cpu-noreloc) [204.894545] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [204.963881] [045/131] (813s left) gem_mmap_offset (bad-flags) [205.024121] Starting subtest: bad-flags [205.026301] Subtest bad-flags: SUCCESS (0.000s) [205.173163] [046/131] (813s left) kms_cursor_legacy (cursor-vs-flip-legacy) [205.289641] Starting subtest: cursor-vs-flip-legacy [234.569021] Subtest cursor-vs-flip-legacy: SUCCESS (29.285s) [235.408815] [047/131] (783s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [235.504206] Starting subtest: sprite-rotation-90-pos-100-0 [235.508507] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [235.600045] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [235.696598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [236.797312] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.100s) [236.958771] [049/131] (781s left) gem_create (busy-create) [237.022169] Starting subtest: busy-create [237.024040] Starting dynamic subtest: smem0 [270.665200] Dynamic subtest smem0: SUCCESS (33.644s) [270.667680] Subtest busy-create: SUCCESS (33.645s) [270.876875] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [270.996257] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [275.193313] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.200s) [276.418995] [051/131] (742s left) perf (invalid-open-flags) [276.544506] Starting subtest: invalid-open-flags [276.547001] Subtest invalid-open-flags: SUCCESS (0.000s) [276.588033] [052/131] (742s left) perf (oa-formats) [276.702585] Starting subtest: oa-formats [276.704506] Starting dynamic subtest: 0-rcs0 [276.715174] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [276.727422] Starting dynamic subtest: 1-vcs0 [276.738453] Dynamic subtest 1-vcs0: SUCCESS (0.023s) [276.740783] Subtest oa-formats: SUCCESS (0.039s) [276.790718] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [276.898569] Starting subtest: 4-tiled-8bpp-rotate-270 [276.919442] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [277.078060] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [277.257018] Starting subtest: cursor-onscreen-64x21 [277.303986] Subtest cursor-onscreen-64x21: SKIP (0.042s) [277.548022] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [277.645137] Starting subtest: primary-4-tiled-reflect-x-180 [284.769109] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.125s) [285.979316] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [286.217152] Starting subtest: cursor-onscreen-256x256 [286.219389] Starting dynamic subtest: pipe-A-eDP-1 [288.343946] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s) [288.371296] Starting dynamic subtest: pipe-D-eDP-1 [291.126223] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s) [291.128521] Subtest cursor-onscreen-256x256: SUCCESS (4.910s) [291.945994] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [292.055980] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [299.396938] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.343s) [299.561764] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [299.663977] Starting subtest: async-flip-with-page-flip-events-tiled [300.035960] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [302.791675] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.756s) [302.804884] Starting dynamic subtest: pipe-A-eDP-1-4 [304.965993] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [304.979037] Starting dynamic subtest: pipe-A-eDP-1-4 [306.976003] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [306.988713] Starting dynamic subtest: pipe-A-eDP-1-x [309.166761] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [309.535712] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [312.318786] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.793s) [312.331593] Starting dynamic subtest: pipe-B-eDP-1-4 [314.503248] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [314.514198] Starting dynamic subtest: pipe-B-eDP-1-4 [316.512773] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [316.523693] Starting dynamic subtest: pipe-B-eDP-1-x [318.703049] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [319.090562] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [321.848331] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s) [321.859248] Starting dynamic subtest: pipe-C-eDP-1-4 [324.022358] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [324.032454] Starting dynamic subtest: pipe-C-eDP-1-4 [326.032772] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [326.043058] Starting dynamic subtest: pipe-C-eDP-1-x [328.233383] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s) [328.607993] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [331.378795] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.779s) [331.390490] Starting dynamic subtest: pipe-D-eDP-1-4 [333.564111] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s) [333.577149] Starting dynamic subtest: pipe-D-eDP-1-4 [335.574219] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [335.590285] Starting dynamic subtest: pipe-D-eDP-1-x [337.829954] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.255s) [337.832320] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.173s) [339.093864] [059/131] (679s left) perf (polling) [339.194737] Starting subtest: polling [339.197280] Starting dynamic subtest: 0-rcs0 [349.217854] Dynamic subtest 0-rcs0: SUCCESS (10.023s) [349.228460] Starting dynamic subtest: 1-vcs1 [359.233562] Dynamic subtest 1-vcs1: SUCCESS (10.016s) [359.236081] Subtest polling: SUCCESS (20.042s) [359.286011] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [359.400241] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [359.404558] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [359.525941] [061/131] (659s left) syncobj_timeline (reset-signaled) [359.587566] Starting subtest: reset-signaled [359.590038] Subtest reset-signaled: SUCCESS (0.000s) [359.717836] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [359.808708] Starting subtest: rmfb-ioctl [359.810954] Starting dynamic subtest: pipe-A-eDP-1 [359.911269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [359.923606] Starting dynamic subtest: pipe-B-eDP-1 [361.106248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s) [361.121225] Starting dynamic subtest: pipe-C-eDP-1 [362.231456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [362.242382] Starting dynamic subtest: pipe-D-eDP-1 [363.360504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [363.362855] Subtest rmfb-ioctl: SUCCESS (3.558s) [364.605948] [063/131] (654s left) gem_userptr_blits (create-destroy-sync) [364.679119] Starting subtest: create-destroy-sync [369.695213] Subtest create-destroy-sync: SUCCESS (5.016s) [369.871471] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active) [369.957157] Subtest basic-gtt-cpu-active: SKIP (0.000s) [370.040772] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator) [370.101861] Starting subtest: execbuf-with-allocator [370.109677] Subtest execbuf-with-allocator: SUCCESS (0.010s) [370.279250] [066/131] (648s left) kms_lease (cursor-implicit-plane) [370.387756] Starting subtest: cursor-implicit-plane [370.390030] Starting dynamic subtest: pipe-A-eDP-1 [370.851629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s) [370.867523] Starting dynamic subtest: pipe-B-eDP-1 [371.989581] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s) [372.000442] Starting dynamic subtest: pipe-C-eDP-1 [373.109267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s) [373.120522] Starting dynamic subtest: pipe-D-eDP-1 [374.240147] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [374.242514] Subtest cursor-implicit-plane: SUCCESS (3.854s) [375.125149] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [375.254327] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [375.258840] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [375.446534] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [375.509575] Starting subtest: invalid-signal-illegal-handle [375.511871] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [375.644784] [069/131] (643s left) kms_psr (psr-primary-blt) [375.751088] Starting subtest: psr-primary-blt [375.753296] Starting dynamic subtest: eDP-1 [377.493826] Dynamic subtest eDP-1: SUCCESS (1.742s) [377.496144] Subtest psr-primary-blt: SUCCESS (1.743s) [378.385069] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [378.487130] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [378.489325] Starting dynamic subtest: pipe-A-eDP-1 [378.547370] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [378.559088] Starting dynamic subtest: pipe-B-eDP-1 [378.616172] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [378.629001] Starting dynamic subtest: pipe-C-eDP-1 [378.686371] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [378.697643] Starting dynamic subtest: pipe-D-eDP-1 [378.754472] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [378.758652] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [380.761178] [071/131] (638s left) kms_psr (pr-primary-blt) [380.860261] Starting subtest: pr-primary-blt [380.864730] Subtest pr-primary-blt: SKIP (0.000s) [380.957841] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [381.057787] Starting subtest: psr-2p-primscrn-spr-indfb-move [381.061680] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [381.174408] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [381.294859] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [381.297118] Starting dynamic subtest: pipe-A-default-mode [382.414455] Dynamic subtest pipe-A-default-mode: SKIP (1.116s) [382.418179] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.119s) [382.610004] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip) [382.686164] Starting subtest: u-semaphore-noskip [383.071588] Subtest u-semaphore-noskip: SUCCESS (0.393s) [383.450413] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle) [383.492114] Starting subtest: memory-info-idle [383.494390] Starting dynamic subtest: smem0 [383.552099] Dynamic subtest smem0: SUCCESS (0.061s) [383.554890] Subtest memory-info-idle: SUCCESS (0.062s) [383.650838] [076/131] (636s left) i915_selftest (live) [385.634361] Starting subtest: live [385.636426] Starting dynamic subtest: sanitycheck [390.147281] Dynamic subtest sanitycheck: SUCCESS (4.510s) [390.157903] Starting dynamic subtest: uncore [394.620773] Dynamic subtest uncore: SUCCESS (4.469s) [394.630430] Starting dynamic subtest: workarounds [399.520284] Dynamic subtest workarounds: SUCCESS (4.896s) [399.530417] Starting dynamic subtest: gt_engines [404.152589] Dynamic subtest gt_engines: SUCCESS (4.629s) [404.167469] Starting dynamic subtest: gt_timelines [420.365715] Dynamic subtest gt_timelines: SUCCESS (16.207s) [420.381873] Starting dynamic subtest: gt_contexts [424.834989] Dynamic subtest gt_contexts: SUCCESS (4.466s) [424.844598] Starting dynamic subtest: gt_lrc [431.197250] Dynamic subtest gt_lrc: SUCCESS (6.359s) [431.207606] Starting dynamic subtest: gt_mocs [434.295867] Dynamic subtest gt_mocs: SUCCESS (3.097s) [434.305540] Starting dynamic subtest: gt_pm [441.238490] Dynamic subtest gt_pm: SUCCESS (6.940s) [441.248755] Starting dynamic subtest: gt_heartbeat [445.722891] Dynamic subtest gt_heartbeat: SUCCESS (4.483s) [445.733130] Starting dynamic subtest: gt_tlb [455.941304] Dynamic subtest gt_tlb: SUCCESS (10.215s) [455.951706] Starting dynamic subtest: requests [468.222459] Dynamic subtest requests: SUCCESS (12.279s) [468.233238] Starting dynamic subtest: migrate [476.255869] Dynamic subtest migrate: SUCCESS (8.032s) [476.264848] Starting dynamic subtest: active [480.747855] Dynamic subtest active: SUCCESS (4.490s) [480.757821] Starting dynamic subtest: objects [485.682783] Dynamic subtest objects: SUCCESS (4.933s) [485.691972] Starting dynamic subtest: mman [490.823201] Dynamic subtest mman: SUCCESS (5.139s) [490.832789] Starting dynamic subtest: dmabuf [495.331101] Dynamic subtest dmabuf: SUCCESS (4.506s) [495.341269] Starting dynamic subtest: vma [498.361752] Dynamic subtest vma: SUCCESS (3.028s) [498.371769] Starting dynamic subtest: coherency [503.472604] Dynamic subtest coherency: SUCCESS (5.109s) [503.482855] Starting dynamic subtest: gtt [515.841086] Dynamic subtest gtt: SUCCESS (12.369s) [515.850736] Starting dynamic subtest: gem [521.523854] Dynamic subtest gem: SUCCESS (5.682s) [521.534708] Starting dynamic subtest: evict [527.123847] Dynamic subtest evict: SUCCESS (5.599s) [527.139843] Starting dynamic subtest: hugepages [537.058866] Dynamic subtest hugepages: SUCCESS (9.934s) [537.069487] Starting dynamic subtest: gem_contexts [565.101156] Dynamic subtest gem_contexts: SUCCESS (28.045s) [565.111185] Starting dynamic subtest: client [569.578071] Dynamic subtest client: SUCCESS (4.477s) [569.588461] Starting dynamic subtest: gem_migrate [574.053277] Dynamic subtest gem_migrate: SUCCESS (4.473s) [574.063831] Starting dynamic subtest: reset [577.046440] Dynamic subtest reset: SUCCESS (2.991s) [577.056710] Starting dynamic subtest: memory_region [581.545088] Dynamic subtest memory_region: SUCCESS (4.498s) [581.553865] Starting dynamic subtest: hangcheck [596.302108] Dynamic subtest hangcheck: SUCCESS (14.756s) [596.312911] Starting dynamic subtest: execlists [600.780064] Dynamic subtest execlists: SUCCESS (4.477s) [600.789709] Starting dynamic subtest: ring_submission [605.235080] Dynamic subtest ring_submission: SUCCESS (4.453s) [605.245606] Starting dynamic subtest: perf [609.746794] Dynamic subtest perf: SUCCESS (4.510s) [609.756755] Starting dynamic subtest: slpc [624.408553] Dynamic subtest slpc: SUCCESS (14.662s) [624.419326] Starting dynamic subtest: guc [628.496260] Dynamic subtest guc: SUCCESS (4.086s) [628.512933] Starting dynamic subtest: guc_multi_lrc [632.943524] Dynamic subtest guc_multi_lrc: SUCCESS (4.446s) [632.953770] Starting dynamic subtest: guc_hang [638.035695] Dynamic subtest guc_hang: SUCCESS (5.091s) [638.046263] Starting dynamic subtest: late_gt_pm [642.591635] Dynamic subtest late_gt_pm: SUCCESS (4.553s) [642.594620] Subtest live: SUCCESS (256.968s) [642.624879] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [642.625608] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [642.628933] [077/131] (377s left) gem_userptr_blits (nohangcheck) [644.382207] Starting subtest: nohangcheck [644.635424] Subtest nohangcheck: SUCCESS (0.253s) [644.756965] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [644.758230] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [644.762075] [078/131] (375s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [644.851072] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [644.853339] Starting dynamic subtest: pipe-A-eDP-1 [645.681443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s) [645.700837] Starting dynamic subtest: pipe-B-eDP-1 [647.274382] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.590s) [647.284908] Starting dynamic subtest: pipe-C-eDP-1 [648.819373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s) [648.829575] Starting dynamic subtest: pipe-D-eDP-1 [650.359376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s) [650.361280] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.496s) [651.620221] [079/131] (368s left) gem_softpin (allocator-nopin) [651.677678] Starting subtest: allocator-nopin [651.782508] Subtest allocator-nopin: SUCCESS (0.105s) [651.947398] [080/131] (367s left) kms_draw_crc (draw-method-pwrite) [652.045947] Starting subtest: draw-method-pwrite [652.048110] Starting dynamic subtest: xrgb8888-untiled [652.613061] Dynamic subtest xrgb8888-untiled: SUCCESS (0.568s) [652.623624] Starting dynamic subtest: rgb565-untiled [653.046878] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [653.057069] Starting dynamic subtest: xrgb2101010-untiled [653.603491] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s) [653.614605] Starting dynamic subtest: xbgr16161616f-untiled [654.369969] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s) [654.379767] Starting dynamic subtest: xrgb8888-xtiled [656.194125] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.822s) [656.203706] Starting dynamic subtest: rgb565-xtiled [657.305707] Dynamic subtest rgb565-xtiled: SUCCESS (1.110s) [657.320551] Starting dynamic subtest: xrgb2101010-xtiled [659.084111] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.777s) [659.094197] Starting dynamic subtest: xbgr16161616f-xtiled [662.308295] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.221s) [662.318316] Starting dynamic subtest: xrgb8888-4tiled [663.400546] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.088s) [663.410075] Starting dynamic subtest: rgb565-4tiled [663.965578] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s) [663.975419] Starting dynamic subtest: xrgb2101010-4tiled [665.066005] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s) [665.076285] Starting dynamic subtest: xbgr16161616f-4tiled [668.023202] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.954s) [668.025439] Subtest draw-method-pwrite: SUCCESS (15.969s) [668.175057] [081/131] (351s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [668.276429] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [668.280713] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [668.410767] [082/131] (351s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [668.510447] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [668.514974] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [668.627190] [083/131] (351s left) syncobj_timeline (host-signal-points) [668.690404] Starting subtest: host-signal-points [668.692614] Subtest host-signal-points: SUCCESS (0.004s) [668.817350] [084/131] (351s left) gem_mmap_gtt (basic-small-bo) [668.878281] Subtest basic-small-bo: SKIP (0.000s) [668.958667] [085/131] (351s left) perf_pmu (semaphore-wait-idle) [669.002125] Starting subtest: semaphore-wait-idle [669.004033] Starting dynamic subtest: rcs0 [669.518469] Dynamic subtest rcs0: SUCCESS (0.513s) [669.532524] Starting dynamic subtest: bcs0 [670.032702] Dynamic subtest bcs0: SUCCESS (0.510s) [670.045533] Starting dynamic subtest: vcs0 [670.546413] Dynamic subtest vcs0: SUCCESS (0.510s) [670.559132] Starting dynamic subtest: vcs1 [671.057997] Dynamic subtest vcs1: SUCCESS (0.509s) [671.071149] Starting dynamic subtest: vecs0 [671.573088] Dynamic subtest vecs0: SUCCESS (0.511s) [671.584847] Starting dynamic subtest: ccs0 [672.087862] Dynamic subtest ccs0: SUCCESS (0.512s) [672.090852] Subtest semaphore-wait-idle: SUCCESS (3.083s) [672.227204] [086/131] (347s left) kms_addfb_basic (no-handle) [672.287691] Starting subtest: no-handle [672.289743] Subtest no-handle: SUCCESS (0.000s) [672.460704] [087/131] (347s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [672.566151] Starting subtest: fbcpsr-rgb101010-draw-pwrite [679.611169] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.043s) [679.761907] [088/131] (340s left) gem_render_copy (yf-tiled-ccs-to-linear) [679.828479] Starting subtest: yf-tiled-ccs-to-linear [679.832770] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [680.035254] [089/131] (340s left) kms_flip (wf_vblank-ts-check) [680.135672] Starting subtest: wf_vblank-ts-check [680.138149] Starting dynamic subtest: A-eDP1 [689.055771] Dynamic subtest A-eDP1: SUCCESS (8.918s) [689.068974] Starting dynamic subtest: B-eDP1 [697.992134] Dynamic subtest B-eDP1: SUCCESS (8.932s) [698.003789] Starting dynamic subtest: C-eDP1 [706.920309] Dynamic subtest C-eDP1: SUCCESS (8.922s) [706.931096] Starting dynamic subtest: D-eDP1 [715.858216] Dynamic subtest D-eDP1: SUCCESS (8.935s) [715.863581] Subtest wf_vblank-ts-check: SUCCESS (35.720s) [717.118168] [090/131] (303s left) gem_exec_schedule (deep) [717.298841] Starting subtest: deep [717.301704] Starting dynamic subtest: rcs0 [722.715268] Dynamic subtest rcs0: SKIP (5.412s) [722.728339] Starting dynamic subtest: vcs0 [733.106915] Dynamic subtest vcs0: SUCCESS (10.392s) [733.124628] Starting dynamic subtest: vcs1 [744.967952] Dynamic subtest vcs1: SUCCESS (11.859s) [744.981397] Starting dynamic subtest: vecs0 [756.730952] Dynamic subtest vecs0: SUCCESS (11.758s) [756.747121] Starting dynamic subtest: ccs0 [768.499233] Dynamic subtest ccs0: SUCCESS (11.768s) [768.501482] Subtest deep: SUCCESS (51.194s) [769.675685] [091/131] (250s left) kms_sequence (queue-idle) [769.774597] Starting subtest: queue-idle [769.776448] Starting dynamic subtest: pipe-A-eDP-1 [771.604147] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.829s) [771.615057] Starting dynamic subtest: pipe-B-eDP-1 [774.066270] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.458s) [774.076930] Starting dynamic subtest: pipe-C-eDP-1 [776.497589] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.430s) [776.513840] Starting dynamic subtest: pipe-D-eDP-1 [778.920159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s) [778.922590] Subtest queue-idle: SUCCESS (9.144s) [779.745810] [092/131] (240s left) gem_gtt_cpu_tlb [779.873529] [093/131] (240s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [779.975078] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [786.510337] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.539s) [786.663425] [094/131] (233s left) gem_eio (create-ext) [786.888692] Starting subtest: create-ext [787.210759] Subtest create-ext: SUCCESS (0.322s) [787.396815] [095/131] (233s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [787.462271] Subtest writes-after-reads-uncached: SKIP (0.000s) [787.551827] [096/131] (233s left) sysfs_preempt_timeout (idempotent) [787.608345] Starting subtest: idempotent [787.610512] Starting dynamic subtest: vecs0 [787.612544] Dynamic subtest vecs0: SUCCESS (0.000s) [787.624450] Starting dynamic subtest: ccs0 [787.626217] Dynamic subtest ccs0: SUCCESS (0.000s) [787.637861] Starting dynamic subtest: vcs0 [787.639380] Dynamic subtest vcs0: SUCCESS (0.000s) [787.648649] Starting dynamic subtest: bcs0 [787.650281] Dynamic subtest bcs0: SUCCESS (0.000s) [787.659593] Starting dynamic subtest: rcs0 [787.661231] Dynamic subtest rcs0: SUCCESS (0.000s) [787.670744] Starting dynamic subtest: vcs1 [787.672892] Dynamic subtest vcs1: SUCCESS (0.000s) [787.674851] Subtest idempotent: SUCCESS (0.007s) [787.750144] [097/131] (232s left) gem_busy (semaphore) [787.928702] Subtest semaphore: SKIP (0.000s) [788.187207] [098/131] (232s left) sriov_basic (enable-vfs-bind-unbind-each) [788.254842] Starting subtest: enable-vfs-bind-unbind-each [788.256717] Starting dynamic subtest: numvfs-1 [788.335341] Dynamic subtest numvfs-1: FAIL (0.029s) [788.347949] Starting dynamic subtest: numvfs-2 [788.421118] Dynamic subtest numvfs-2: FAIL (0.004s) [788.433233] Starting dynamic subtest: numvfs-3 [788.507577] Dynamic subtest numvfs-3: FAIL (0.003s) [788.519625] Starting dynamic subtest: numvfs-4 [788.592262] Dynamic subtest numvfs-4: FAIL (0.003s) [788.603751] Starting dynamic subtest: numvfs-5 [788.677070] Dynamic subtest numvfs-5: FAIL (0.004s) [788.688352] Starting dynamic subtest: numvfs-6 [788.761553] Dynamic subtest numvfs-6: FAIL (0.004s) [788.773877] Starting dynamic subtest: numvfs-7 [788.847201] Dynamic subtest numvfs-7: FAIL (0.003s) [788.858371] Starting dynamic subtest: numvfs-random [788.931096] Dynamic subtest numvfs-random: FAIL (0.004s) [788.933167] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s) [788.974320] [099/131] (231s left) kms_pm_lpsp (screens-disabled) [790.082129] Starting subtest: screens-disabled [790.086507] Subtest screens-disabled: SKIP (0.000s) [790.180755] [100/131] (230s left) gem_exec_capture (capture-invisible) [790.250939] Starting subtest: capture-invisible [790.253251] Starting dynamic subtest: smem0 [790.257578] Dynamic subtest smem0: SKIP (0.000s) [790.261959] Subtest capture-invisible: SKIP (0.001s) [790.388154] [101/131] (230s left) gem_lmem_swapping (verify-ccs) [790.429761] Subtest verify-ccs: SKIP (0.000s) [790.471132] [102/131] (230s left) kms_joiner (basic-force-ultra-joiner) [790.576666] Starting subtest: basic-force-ultra-joiner [790.581008] Subtest basic-force-ultra-joiner: SKIP (0.000s) [790.672832] [103/131] (230s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [790.771642] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [797.336893] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.568s) [797.488243] [104/131] (223s left) kms_color (legacy-gamma) [797.593439] Starting subtest: legacy-gamma [797.595892] Starting dynamic subtest: pipe-A-eDP-1 [798.305650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s) [798.318926] Starting dynamic subtest: pipe-B-eDP-1 [799.696327] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s) [799.717847] Starting dynamic subtest: pipe-C-eDP-1 [801.105865] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s) [801.117311] Starting dynamic subtest: pipe-D-eDP-1 [802.481712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.377s) [802.484072] Subtest legacy-gamma: SUCCESS (4.890s) [803.303397] [105/131] (217s left) gem_exec_schedule (wide) [803.493685] Starting subtest: wide [803.496155] Starting dynamic subtest: rcs0 [814.241872] Dynamic subtest rcs0: SUCCESS (10.750s) [814.255548] Starting dynamic subtest: vcs0 [825.290875] Dynamic subtest vcs0: SUCCESS (11.048s) [825.304662] Starting dynamic subtest: vcs1 [836.453898] Dynamic subtest vcs1: SUCCESS (11.162s) [836.468004] Starting dynamic subtest: vecs0 [845.821471] Dynamic subtest vecs0: SUCCESS (9.366s) [845.835315] Starting dynamic subtest: ccs0 [859.400137] Dynamic subtest ccs0: SUCCESS (13.578s) [859.402845] Subtest wide: SUCCESS (55.910s) [861.298489] [106/131] (159s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [861.407504] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [861.409728] Starting dynamic subtest: pipe-A-default-mode [861.701639] Dynamic subtest pipe-A-default-mode: SKIP (0.291s) [861.705995] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.293s) [862.526232] [107/131] (158s left) kms_big_fb (linear-64bpp-rotate-180) [862.634347] Starting subtest: linear-64bpp-rotate-180 [864.311040] Subtest linear-64bpp-rotate-180: SUCCESS (1.679s) [864.498128] [108/131] (156s left) gem_ppgtt (blt-vs-render-ctxn) [864.556240] Starting subtest: blt-vs-render-ctxN [897.735131] Subtest blt-vs-render-ctxN: SUCCESS (33.177s) [897.906145] [109/131] (123s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [898.049532] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [898.053584] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [898.162716] [110/131] (123s left) kms_chamelium_frames (dp-frame-dump) [898.567421] Subtest dp-frame-dump: SKIP (0.000s) [899.411608] [111/131] (121s left) kms_psr2_su (page_flip-nv12) [899.470447] Subtest page_flip-NV12: SKIP (0.000s) [899.542528] [112/131] (121s left) gem_tiling_max_stride [899.661780] [113/131] (121s left) perf_pmu (busy-idle) [899.706438] Starting subtest: busy-idle [899.708757] Starting dynamic subtest: rcs0 [900.411390] Dynamic subtest rcs0: SUCCESS (0.705s) [900.425506] Starting dynamic subtest: bcs0 [901.086453] Dynamic subtest bcs0: SUCCESS (0.672s) [901.100622] Starting dynamic subtest: vcs0 [902.646133] Dynamic subtest vcs0: SUCCESS (1.555s) [902.660193] Starting dynamic subtest: vcs1 [904.693755] Dynamic subtest vcs1: SUCCESS (2.044s) [904.708007] Starting dynamic subtest: vecs0 [906.677678] Dynamic subtest vecs0: SUCCESS (1.981s) [906.692566] Starting dynamic subtest: ccs0 [907.356403] Dynamic subtest ccs0: SUCCESS (0.677s) [907.358972] Subtest busy-idle: SUCCESS (7.650s) [907.486492] [114/131] (113s left) dmabuf_sync_file (export-before-signal) [907.533345] Starting subtest: export-before-signal [907.535498] Subtest export-before-signal: SUCCESS (0.001s) [907.616131] [115/131] (113s left) gem_exec_reloc (basic-cpu-read) [907.676902] Subtest basic-cpu-read: SKIP (0.000s) [907.758972] [116/131] (113s left) kms_hdr (bpc-switch) [907.855609] Starting subtest: bpc-switch [908.902053] Starting dynamic subtest: pipe-A-eDP-1 [912.286223] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.384s) [912.288574] Subtest bpc-switch: SUCCESS (4.432s) [912.447797] [117/131] (109s left) perf (i915-ref-count) [912.559854] Starting subtest: i915-ref-count [912.630860] Subtest i915-ref-count: SUCCESS (0.068s) [912.689069] [118/131] (108s left) gem_ctx_isolation (nonpriv) [912.745357] Starting subtest: nonpriv [912.747289] Starting dynamic subtest: rcs0 [912.966036] Dynamic subtest rcs0: SUCCESS (0.223s) [912.980092] Starting dynamic subtest: bcs0 [913.222610] Dynamic subtest bcs0: SUCCESS (0.256s) [913.236154] Starting dynamic subtest: vcs0 [913.509259] Dynamic subtest vcs0: SUCCESS (0.286s) [913.522764] Starting dynamic subtest: vcs1 [914.909522] Dynamic subtest vcs1: SUCCESS (1.399s) [914.921321] Starting dynamic subtest: vecs0 [916.924913] Dynamic subtest vecs0: SUCCESS (2.014s) [916.938523] Starting dynamic subtest: ccs0 [918.929849] Dynamic subtest ccs0: SUCCESS (2.003s) [918.932251] Subtest nonpriv: SUCCESS (6.187s) [919.213907] [119/131] (102s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [919.280706] Starting subtest: y-tiled-to-vebox-x-tiled [919.285215] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [919.495526] [120/131] (102s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [919.597936] Starting subtest: plane-use-after-nonblocking-unbind [919.600258] Starting dynamic subtest: pipe-A-eDP-1 [919.658646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [919.969947] Starting dynamic subtest: pipe-B-eDP-1 [920.771847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.813s) [921.079145] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.480s) [921.947209] [121/131] ( 99s left) i915_hangman (engine-error-state-capture) [922.018549] Starting subtest: engine-error-state-capture [922.021017] Starting dynamic subtest: rcs0 [925.652750] Dynamic subtest rcs0: SUCCESS (3.632s) [925.666606] Starting dynamic subtest: bcs0 [931.603247] Dynamic subtest bcs0: SUCCESS (5.947s) [931.618218] Starting dynamic subtest: vcs0 [937.620171] Dynamic subtest vcs0: SUCCESS (6.013s) [937.634367] Starting dynamic subtest: vcs1 [943.635248] Dynamic subtest vcs1: SUCCESS (6.011s) [943.649896] Starting dynamic subtest: vecs0 [949.587620] Dynamic subtest vecs0: SUCCESS (5.949s) [949.601578] Starting dynamic subtest: ccs0 [954.643948] Dynamic subtest ccs0: SUCCESS (5.053s) [954.646840] Subtest engine-error-state-capture: SUCCESS (32.621s) [954.754563] [122/131] ( 66s left) gem_exec_schedule (pi-shared-iova) [954.942593] Starting subtest: pi-shared-iova [954.944541] Starting dynamic subtest: rcs0 [955.069390] Dynamic subtest rcs0: SUCCESS (0.128s) [955.083652] Starting dynamic subtest: vcs0 [955.155980] Dynamic subtest vcs0: SUCCESS (0.087s) [955.167509] Starting dynamic subtest: vcs1 [955.239895] Dynamic subtest vcs1: SUCCESS (0.083s) [955.253996] Starting dynamic subtest: vecs0 [955.325742] Dynamic subtest vecs0: SUCCESS (0.085s) [955.339606] Starting dynamic subtest: ccs0 [955.445378] Dynamic subtest ccs0: SUCCESS (0.117s) [955.447918] Subtest pi-shared-iova: SUCCESS (0.506s) [956.803248] [123/131] ( 64s left) syncobj_wait (invalid-reset-illegal-handle) [956.864722] Starting subtest: invalid-reset-illegal-handle [956.867207] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [956.984374] [124/131] ( 64s left) syncobj_wait (single-wait-all-for-submit-signaled) [957.040370] Starting subtest: single-wait-all-for-submit-signaled [957.042764] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [957.161261] [125/131] ( 64s left) kms_cursor_crc (cursor-sliding-512x170) [957.469685] Starting subtest: cursor-sliding-512x170 [957.474139] Subtest cursor-sliding-512x170: SKIP (0.001s) [957.636256] [126/131] ( 64s left) kms_chamelium_hpd (hdmi-hpd-fast) [958.014917] Subtest hdmi-hpd-fast: SKIP (0.000s) [958.826698] [127/131] ( 63s left) gem_ctx_persistence (hostile) [958.898958] Starting subtest: hostile [969.047861] Subtest hostile: SUCCESS (10.144s) [969.203300] [128/131] ( 52s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [969.320653] Starting subtest: fbc-rgb565-draw-blt [973.555370] Subtest fbc-rgb565-draw-blt: SUCCESS (4.238s) [974.774921] [129/131] ( 47s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [974.877483] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [984.084793] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.208s) [984.257465] [130/131] ( 37s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [984.364603] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [984.368932] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [984.507687] [131/131] ( 37s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [984.605354] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [984.609439] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [984.751791] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.