[57.315059] Initializing watchdogs [57.315110] /dev/watchdog0 [57.364799] [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] [57.369901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.372250] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.377811] [001/154] (960s left) kms_plane_cursor (primary) [57.491151] Starting subtest: primary [57.495761] Starting dynamic subtest: pipe-A-eDP-1-size-64 [60.104456] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.615s) [60.128847] Starting dynamic subtest: pipe-A-eDP-1-size-128 [62.715819] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.595s) [62.740425] Starting dynamic subtest: pipe-A-eDP-1-size-256 [65.272473] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.539s) [65.589438] Starting dynamic subtest: pipe-B-eDP-1-size-64 [68.923684] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.346s) [68.949743] Starting dynamic subtest: pipe-B-eDP-1-size-128 [71.513623] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s) [71.537933] Starting dynamic subtest: pipe-B-eDP-1-size-256 [74.137357] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.606s) [74.466883] Starting dynamic subtest: pipe-C-eDP-1-size-64 [77.396454] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.943s) [77.423835] Starting dynamic subtest: pipe-C-eDP-1-size-128 [79.618598] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s) [79.643555] Starting dynamic subtest: pipe-C-eDP-1-size-256 [81.829296] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s) [82.147434] Starting dynamic subtest: pipe-D-eDP-1-size-64 [85.036559] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.901s) [85.062070] Starting dynamic subtest: pipe-D-eDP-1-size-128 [87.282065] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s) [87.307141] Starting dynamic subtest: pipe-D-eDP-1-size-256 [89.492499] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s) [89.806095] Subtest primary: SUCCESS (32.316s) [90.679449] [002/154] (927s left) i915_power (sanity) [90.746850] Starting subtest: sanity [90.751496] Subtest sanity: SKIP (0.000s) [90.839400] [003/154] (927s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite) [90.946392] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite [90.950325] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [91.036637] [004/154] (926s left) syncobj_timeline (wait-any-complex) [91.091402] Starting subtest: wait-any-complex [91.153481] Subtest wait-any-complex: SUCCESS (0.063s) [91.239790] [005/154] (926s left) kms_chamelium_color (ctm-limited-range) [91.339797] Subtest ctm-limited-range: SKIP (0.000s) [91.384342] [006/154] (926s left) prime_vgem (fence-write-hang) [91.506644] Subtest fence-write-hang: SKIP (0.000s) [91.594286] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [91.597963] [007/154] (926s left) gem_mmap_offset (partial-remap) [91.658715] Starting subtest: partial-remap [91.660595] Starting dynamic subtest: smem0 [91.667863] Dynamic subtest smem0: SUCCESS (0.004s) [91.669465] Subtest partial-remap: SUCCESS (0.004s) [91.764414] [008/154] (926s left) gem_mmap_wc (bad-size) [91.817025] Subtest bad-size: SKIP (0.000s) [91.879981] [009/154] (926s left) kms_setmode (basic) [91.926479] Starting subtest: basic [92.287803] Starting dynamic subtest: pipe-A-eDP-1 [94.397840] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s) [94.739798] Starting dynamic subtest: pipe-B-eDP-1 [96.827883] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s) [97.134139] Subtest basic: SUCCESS (5.207s) [97.980384] [010/154] (920s left) kms_cursor_crc (cursor-offscreen-512x170) [98.266014] Starting subtest: cursor-offscreen-512x170 [98.270683] Subtest cursor-offscreen-512x170: SKIP (0.001s) [98.397790] [011/154] (919s left) gem_pxp (reject-modify-context-protection-off-2) [98.529057] Starting subtest: reject-modify-context-protection-off-2 [98.532036] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s) [98.654324] [012/154] (919s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [98.750426] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [98.754725] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [98.819184] [013/154] (919s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [98.910436] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [98.912269] Starting dynamic subtest: pipe-A-eDP-1 [98.930734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [98.939775] Starting dynamic subtest: pipe-B-eDP-1 [98.957069] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [98.964437] Starting dynamic subtest: pipe-C-eDP-1 [98.981936] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [98.989012] Starting dynamic subtest: pipe-D-eDP-1 [99.006884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [99.010446] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [101.267437] [014/154] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [101.369447] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [101.373523] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [101.467394] [015/154] (916s left) perf (invalid-remove-userspace-config) [101.598427] Starting subtest: invalid-remove-userspace-config [101.604048] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [101.653043] [016/154] (916s left) gem_mmap_gtt (basic-write-gtt) [101.713117] Subtest basic-write-gtt: SKIP (0.000s) [101.775620] [017/154] (916s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move) [101.873175] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move [101.877494] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [101.957182] [018/154] (916s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [102.051290] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [102.055662] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [102.137793] [019/154] (916s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt) [102.241256] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt [102.244662] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [102.366079] [020/154] (916s left) gem_mmap_gtt (big-bo-tiledx) [102.421436] Subtest big-bo-tiledX: SKIP (0.000s) [102.481207] [021/154] (916s left) gem_mmap_gtt (big-copy) [102.543713] Subtest big-copy: SKIP (0.000s) [102.601775] [022/154] (916s left) perf (buffer-fill) [102.685702] Starting subtest: buffer-fill [102.688597] Starting dynamic subtest: 0-rcs0 [104.966937] Dynamic subtest 0-rcs0: SUCCESS (2.278s) [104.975648] Starting dynamic subtest: 1-vcs0 [109.430381] Dynamic subtest 1-vcs0: SUCCESS (4.463s) [109.433243] Subtest buffer-fill: SUCCESS (6.744s) [109.483204] [023/154] (909s left) perf_pmu (init-busy) [109.523799] Starting subtest: init-busy [109.526155] Starting dynamic subtest: rcs0 [109.528445] Dynamic subtest rcs0: SUCCESS (0.001s) [109.539204] Starting dynamic subtest: bcs0 [109.541070] Dynamic subtest bcs0: SUCCESS (0.000s) [109.548438] Starting dynamic subtest: vcs0 [109.550336] Dynamic subtest vcs0: SUCCESS (0.001s) [109.557769] Starting dynamic subtest: vcs1 [109.559688] Dynamic subtest vcs1: SUCCESS (0.001s) [109.566973] Starting dynamic subtest: vecs0 [109.568938] Dynamic subtest vecs0: SUCCESS (0.001s) [109.576266] Starting dynamic subtest: ccs0 [109.578636] Dynamic subtest ccs0: SUCCESS (0.001s) [109.581138] Subtest init-busy: SUCCESS (0.010s) [109.637766] [024/154] (909s left) gem_eio (wait-10ms) [109.891246] Starting subtest: wait-10ms [110.301898] Subtest wait-10ms: SUCCESS (0.411s) [110.460262] [025/154] (908s left) kms_concurrent (multi-plane-atomic-lowres) [110.558214] Starting subtest: multi-plane-atomic-lowres [110.560217] Starting dynamic subtest: pipe-A-eDP-1 [111.067533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s) [111.076577] Starting dynamic subtest: pipe-B-eDP-1 [112.278074] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s) [112.286609] Starting dynamic subtest: pipe-C-eDP-1 [113.525177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s) [113.533774] Starting dynamic subtest: pipe-D-eDP-1 [114.736829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s) [114.739396] Subtest multi-plane-atomic-lowres: SUCCESS (4.179s) [115.573762] [026/154] (903s left) gem_ctx_persistence (engines-hostile-preempt) [115.627135] Starting subtest: engines-hostile-preempt [115.629585] Starting dynamic subtest: rcs0 [115.696864] Dynamic subtest rcs0: SUCCESS (0.069s) [115.708779] Starting dynamic subtest: bcs0 [115.740593] Dynamic subtest bcs0: SUCCESS (0.042s) [115.750585] Starting dynamic subtest: vcs0 [117.316567] Dynamic subtest vcs0: SUCCESS (1.573s) [117.327599] Starting dynamic subtest: vcs1 [119.320635] Dynamic subtest vcs1: SUCCESS (2.001s) [119.331461] Starting dynamic subtest: vecs0 [121.361760] Dynamic subtest vecs0: SUCCESS (1.985s) [121.372084] Starting dynamic subtest: ccs0 [121.374475] Dynamic subtest ccs0: SUCCESS (0.045s) [121.376419] Subtest engines-hostile-preempt: SUCCESS (5.727s) [121.430691] [027/154] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [121.536813] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [121.541200] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [121.632471] [028/154] (897s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [121.732527] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [121.736765] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [121.836635] [029/154] (897s left) gem_exec_suspend (basic-s3-devices) [121.903601] Starting subtest: basic-S3-devices [121.905818] Starting dynamic subtest: smem [133.342663] Dynamic subtest smem: SUCCESS (11.438s) [133.345064] Subtest basic-S3-devices: SUCCESS (11.440s) [141.615574] [030/154] (885s left) kms_universal_plane (disable-primary-vs-flip) [141.732912] Starting subtest: disable-primary-vs-flip [141.735072] Starting dynamic subtest: pipe-A-eDP-1 [143.348633] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.614s) [143.358782] Starting dynamic subtest: pipe-B-eDP-1 [145.609851] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s) [145.618969] Starting dynamic subtest: pipe-C-eDP-1 [147.856250] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s) [147.867244] Starting dynamic subtest: pipe-D-eDP-1 [150.134768] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.277s) [150.137032] Subtest disable-primary-vs-flip: SUCCESS (8.403s) [151.011838] [031/154] (876s left) prime_busy (after-wait) [151.072574] Starting subtest: after-wait [151.077664] Starting dynamic subtest: rcs0 [151.102217] Dynamic subtest rcs0: SUCCESS (0.026s) [151.112694] Starting dynamic subtest: bcs0 [151.150061] Dynamic subtest bcs0: SUCCESS (0.046s) [151.158655] Starting dynamic subtest: vcs0 [151.190814] Dynamic subtest vcs0: SUCCESS (0.041s) [151.202055] Starting dynamic subtest: vcs1 [151.234068] Dynamic subtest vcs1: SUCCESS (0.041s) [151.244862] Starting dynamic subtest: vecs0 [151.274981] Dynamic subtest vecs0: SUCCESS (0.040s) [151.284283] Starting dynamic subtest: ccs0 [151.314821] Dynamic subtest ccs0: SUCCESS (0.039s) [151.422437] Subtest after-wait: SUCCESS (0.348s) [151.499308] [032/154] (875s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [151.595799] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [152.430874] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s) [152.595498] [033/154] (874s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [152.686768] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [152.715438] Starting dynamic subtest: pipe-A-plane-0 [153.015252] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s) [153.024314] Starting dynamic subtest: pipe-A-plane-3 [153.250936] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s) [153.260753] Starting dynamic subtest: pipe-A-plane-5 [153.265244] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [154.400892] Starting dynamic subtest: pipe-B-plane-0 [154.703547] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [154.712906] Starting dynamic subtest: pipe-B-plane-3 [154.936791] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s) [154.946486] Starting dynamic subtest: pipe-B-plane-5 [154.950712] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [155.243977] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.557s) [156.068940] [034/154] (871s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt) [156.175230] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt [156.179531] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [156.284496] [035/154] (871s left) gem_exec_params (invalid-batch-start-offset) [156.339591] Starting subtest: invalid-batch-start-offset [156.345625] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [156.458815] [036/154] (870s left) gem_mmap_gtt (cpuset-basic-small-copy) [156.522290] Subtest cpuset-basic-small-copy: SKIP (0.000s) [156.587157] [037/154] (870s left) syncobj_wait (wait-for-submit-delayed-submit) [156.642499] Starting subtest: wait-for-submit-delayed-submit [156.747310] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [156.838657] [038/154] (870s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [156.891862] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [156.896665] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [157.074262] [039/154] (870s left) kms_cursor_crc (cursor-random-512x170) [157.363730] Starting subtest: cursor-random-512x170 [157.367689] Subtest cursor-random-512x170: SKIP (0.001s) [157.498781] [040/154] (870s left) kms_cursor_legacy (single-bo) [157.616404] Starting subtest: single-bo [157.618728] Starting dynamic subtest: pipe-A [163.051739] Dynamic subtest pipe-A: SUCCESS (5.379s) [163.063500] Starting dynamic subtest: pipe-B [168.433832] Dynamic subtest pipe-B: SUCCESS (5.379s) [168.445743] Starting dynamic subtest: pipe-C [173.815998] Dynamic subtest pipe-C: SUCCESS (5.379s) [173.827520] Starting dynamic subtest: pipe-D [179.195233] Dynamic subtest pipe-D: SUCCESS (5.379s) [179.206103] Starting dynamic subtest: all-pipes [184.585708] Dynamic subtest all-pipes: SUCCESS (5.386s) [184.588181] Subtest single-bo: SUCCESS (26.914s) [184.680845] [041/154] (842s left) kms_big_fb (4-tiled-64bpp-rotate-180) [184.789323] Starting subtest: 4-tiled-64bpp-rotate-180 [186.246464] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.457s) [186.411432] [042/154] (841s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [186.514086] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [193.209220] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.699s) [193.326550] [043/154] (834s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt) [193.434722] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt [193.438795] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [193.546683] [044/154] (834s left) device_reset (unbind-cold-reset-rebind) [193.599253] Starting subtest: unbind-cold-reset-rebind [193.603634] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [193.672627] [045/154] (834s left) gem_userptr_blits (stress-mm-invalidate-close) [193.733413] Starting subtest: stress-mm-invalidate-close [195.882860] Subtest stress-mm-invalidate-close: SUCCESS (2.149s) [196.001543] [046/154] (831s left) gem_exec_schedule (noreorder-priority) [196.177724] Starting subtest: noreorder-priority [196.180080] Starting dynamic subtest: rcs0 [197.337849] Dynamic subtest rcs0: SUCCESS (1.159s) [197.350479] Starting dynamic subtest: vcs0 [199.323241] Dynamic subtest vcs0: SUCCESS (1.981s) [199.335948] Starting dynamic subtest: vcs1 [201.284873] Dynamic subtest vcs1: SUCCESS (1.958s) [201.297352] Starting dynamic subtest: vecs0 [203.355213] Dynamic subtest vecs0: SUCCESS (2.067s) [203.368034] Starting dynamic subtest: ccs0 [204.505669] Dynamic subtest ccs0: SUCCESS (1.149s) [204.508119] Subtest noreorder-priority: SUCCESS (8.329s) [204.714919] [047/154] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [204.816564] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [209.409550] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.598s) [210.621027] [048/154] (817s left) gen9_exec_parse (allowed-single) [210.684320] Subtest allowed-single: SKIP (0.000s) [210.752404] [049/154] (817s left) gem_ctx_engines (execute-oneforall) [210.815090] Starting subtest: execute-oneforall [211.388245] Subtest execute-oneforall: SUCCESS (0.576s) [212.415112] [050/154] (815s left) sysfs_defaults (readonly) [212.474846] Starting subtest: readonly [212.477172] Starting dynamic subtest: vecs0 [212.479524] Dynamic subtest vecs0: SUCCESS (0.000s) [212.489393] Starting dynamic subtest: ccs0 [212.491282] Dynamic subtest ccs0: SUCCESS (0.000s) [212.501088] Starting dynamic subtest: vcs0 [212.503253] Dynamic subtest vcs0: SUCCESS (0.000s) [212.512763] Starting dynamic subtest: bcs0 [212.514638] Dynamic subtest bcs0: SUCCESS (0.000s) [212.523331] Starting dynamic subtest: rcs0 [212.525225] Dynamic subtest rcs0: SUCCESS (0.000s) [212.533940] Starting dynamic subtest: vcs1 [212.535859] Dynamic subtest vcs1: SUCCESS (0.000s) [212.537749] Subtest readonly: SUCCESS (0.006s) [212.576240] [051/154] (815s left) kms_frontbuffer_tracking (psrhdr-2p-rte) [212.670520] Starting subtest: psrhdr-2p-rte [212.674777] Subtest psrhdr-2p-rte: SKIP (0.000s) [212.768039] [052/154] (815s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [212.881472] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [231.204917] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.321s) [232.101413] [053/154] (795s left) perf (oa-exponents) [232.189184] Starting subtest: oa-exponents [232.191522] Starting dynamic subtest: 0-rcs0 [233.956460] Dynamic subtest 0-rcs0: SUCCESS (1.765s) [233.967511] Starting dynamic subtest: 1-vecs0 [235.760602] Dynamic subtest 1-vecs0: SUCCESS (1.804s) [235.763041] Subtest oa-exponents: SUCCESS (3.570s) [235.802291] [054/154] (792s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [235.915021] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [235.919208] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [235.989349] [055/154] (792s left) prime_vgem (basic-fence-read) [236.055551] Starting subtest: basic-fence-read [236.067241] Subtest basic-fence-read: SKIP (0.009s) [236.176172] [056/154] (792s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite) [236.281309] Starting subtest: fbchdr-rgb565-draw-pwrite [236.285721] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s) [236.376898] [057/154] (791s left) gem_mmap_gtt (basic-small-bo-tiledx) [236.439312] Subtest basic-small-bo-tiledX: SKIP (0.000s) [236.496327] [058/154] (791s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [236.591847] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [236.594185] Starting dynamic subtest: pipe-A-eDP-1 [253.052813] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.467s) [253.063034] Starting dynamic subtest: pipe-B-eDP-1 [270.283489] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.226s) [270.285403] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.696s) [271.180673] [059/154] (757s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [271.301062] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [271.305834] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [271.446583] [060/154] (756s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw) [271.547788] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw [271.551746] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [271.666086] [061/154] (756s left) kms_cursor_edge_walk (256x256-top-edge) [271.757402] Starting subtest: 256x256-top-edge [271.759772] Starting dynamic subtest: pipe-A-eDP-1 [275.248378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s) [275.259697] Starting dynamic subtest: pipe-D-eDP-1 [278.468548] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.218s) [278.470907] Subtest 256x256-top-edge: SUCCESS (6.712s) [279.271121] [062/154] (749s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [279.323519] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [279.427423] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [279.517664] [063/154] (748s left) kms_addfb_basic (bad-pitch-999) [279.585835] Starting subtest: bad-pitch-999 [279.588331] Subtest bad-pitch-999: SUCCESS (0.000s) [279.755704] [064/154] (748s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [279.839272] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [279.841581] Starting dynamic subtest: pipe-A-eDP-1 [279.864758] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [279.876109] Starting dynamic subtest: pipe-B-eDP-1 [279.897886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [279.907053] Starting dynamic subtest: pipe-C-eDP-1 [279.928548] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [279.937725] Starting dynamic subtest: pipe-D-eDP-1 [279.959561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [279.963805] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [282.145123] [065/154] (746s left) perf (gen12-oa-tlb-invalidate) [282.230148] Starting subtest: gen12-oa-tlb-invalidate [282.232620] Starting dynamic subtest: 0-rcs0 [292.328618] Dynamic subtest 0-rcs0: SUCCESS (10.045s) [292.340552] Starting dynamic subtest: 1-vcs1 [302.377844] Dynamic subtest 1-vcs1: SUCCESS (10.048s) [302.380358] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.096s) [302.421491] [066/154] (726s left) gem_exec_balancer (hang) [302.681613] Starting subtest: hang [304.387646] Subtest hang: SUCCESS (1.709s) [304.528588] [067/154] (724s left) prime_mmap (test_errors) [304.581049] Starting subtest: test_errors [304.582918] Starting dynamic subtest: test_errors-smem [304.690965] Dynamic subtest test_errors-smem: SUCCESS (0.110s) [304.693603] Subtest test_errors: SUCCESS (0.111s) [304.801467] [068/154] (723s left) kms_fb_coherency (memset-crc) [304.905687] Starting subtest: memset-crc [304.907730] Starting dynamic subtest: mmap-offset-wc [305.304409] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s) [305.601700] Starting dynamic subtest: mmap-offset-uc [311.778909] Dynamic subtest mmap-offset-uc: SUCCESS (6.185s) [312.069052] Subtest memset-crc: SUCCESS (7.165s) [312.940894] [069/154] (715s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt) [313.044620] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt [313.048846] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [313.137402] [070/154] (715s left) vgem_basic (setversion) [313.182864] Starting subtest: setversion [313.187233] Subtest setversion: SUCCESS (0.000s) [313.239490] [071/154] (715s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt) [313.328007] Starting subtest: psrhdr-rgb565-draw-blt [313.332594] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s) [313.445569] [072/154] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [313.550477] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [320.714737] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.169s) [320.864735] [073/154] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [320.982636] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [320.986825] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [321.084595] [074/154] (707s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [321.182084] Starting subtest: async-flip-with-page-flip-events-tiled [321.560897] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [324.364461] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.744s) [324.375705] Starting dynamic subtest: pipe-A-eDP-1-4 [326.529832] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s) [326.544710] Starting dynamic subtest: pipe-A-eDP-1-4 [328.500364] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [328.509514] Starting dynamic subtest: pipe-A-eDP-1-x [330.729734] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s) [331.045110] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [333.880752] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.791s) [333.895799] Starting dynamic subtest: pipe-B-eDP-1-4 [336.054752] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s) [336.067463] Starting dynamic subtest: pipe-B-eDP-1-4 [338.014205] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [338.026754] Starting dynamic subtest: pipe-B-eDP-1-x [340.266568] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [340.582781] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [343.407247] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s) [343.419536] Starting dynamic subtest: pipe-C-eDP-1-4 [345.581168] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [345.591084] Starting dynamic subtest: pipe-C-eDP-1-4 [347.541108] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [347.552514] Starting dynamic subtest: pipe-C-eDP-1-x [349.770352] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [350.082212] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [352.888812] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s) [352.900706] Starting dynamic subtest: pipe-D-eDP-1-4 [355.117106] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [355.130218] Starting dynamic subtest: pipe-D-eDP-1-4 [357.074598] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [357.084403] Starting dynamic subtest: pipe-D-eDP-1-x [359.304714] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [359.307174] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.071s) [360.488557] [075/154] (668s left) kms_vblank (ts-continuation-dpms-rpm) [360.575551] Starting subtest: ts-continuation-dpms-rpm [360.577845] Starting dynamic subtest: pipe-A-eDP-1 [363.169067] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.594s) [363.184800] Starting dynamic subtest: pipe-D-eDP-1 [365.404561] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.230s) [365.406870] Subtest ts-continuation-dpms-rpm: SUCCESS (4.828s) [366.310841] [076/154] (662s left) kms_selftest (drm_dp_mst_helper) [366.347741] Starting subtest: drm_dp_mst_helper [366.368456] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [366.451825] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.083s) [366.463584] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [366.549879] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s) [366.559182] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [366.660610] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.111s) [366.662827] Subtest drm_dp_mst_helper: SUCCESS (0.314s) [366.815728] [077/154] (662s left) syncobj_wait (single-wait-submitted) [366.873029] Starting subtest: single-wait-submitted [366.979438] Subtest single-wait-submitted: SUCCESS (0.105s) [367.056912] [078/154] (662s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [367.102855] Starting subtest: multi-wait-available-unsubmitted-submitted [367.105243] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [367.209221] [079/154] (662s left) gem_exec_schedule (smoketest) [367.387083] Starting subtest: smoketest [367.389652] Starting dynamic subtest: rcs0 [372.981784] Dynamic subtest rcs0: SUCCESS (5.490s) [372.994653] Starting dynamic subtest: bcs0 [378.484387] Dynamic subtest bcs0: SUCCESS (5.501s) [378.495701] Starting dynamic subtest: vcs0 [383.980117] Dynamic subtest vcs0: SUCCESS (5.496s) [383.993272] Starting dynamic subtest: vcs1 [389.487024] Dynamic subtest vcs1: SUCCESS (5.502s) [389.498408] Starting dynamic subtest: vecs0 [394.974913] Dynamic subtest vecs0: SUCCESS (5.492s) [394.986591] Starting dynamic subtest: ccs0 [400.464523] Dynamic subtest ccs0: SUCCESS (5.485s) [400.466915] Subtest smoketest: SUCCESS (32.975s) [400.613229] [080/154] (628s left) kms_psr (fbc-pr-sprite-mmap-gtt) [400.702992] Starting subtest: fbc-pr-sprite-mmap-gtt [400.707449] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [400.778370] [081/154] (628s left) gem_exec_fence (submit-chain) [400.949052] Starting subtest: submit-chain [400.969436] Subtest submit-chain: SUCCESS (0.021s) [402.413827] [082/154] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [402.515628] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [402.519949] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [402.607434] [083/154] (626s left) kms_chamelium_edid (hdmi-edid-read) [402.986929] Subtest hdmi-edid-read: SKIP (0.000s) [403.804413] [084/154] (625s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [403.911888] Starting subtest: fbcpsr-tiling-4 [411.021665] Subtest fbcpsr-tiling-4: SUCCESS (7.115s) [411.159454] [085/154] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [411.260722] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [418.018388] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.763s) [418.147280] [086/154] (611s left) kms_pm_backlight (fade-with-dpms) [418.246806] Starting subtest: fade-with-dpms [420.437783] Starting dynamic subtest: eDP-1 [423.468410] Dynamic subtest eDP-1: SUCCESS (3.032s) [423.471708] Subtest fade-with-dpms: SUCCESS (5.223s) [424.340903] [087/154] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [424.435731] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [424.439728] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [424.526352] [088/154] (605s left) kms_joiner (basic-force-big-joiner) [424.623191] Starting subtest: basic-force-big-joiner [424.627107] Subtest basic-force-big-joiner: SKIP (0.000s) [424.693428] [089/154] (604s left) i915_drm_fdinfo (memory-info-shared) [424.734786] Starting subtest: memory-info-shared [424.737046] Starting dynamic subtest: smem0 [424.789339] Dynamic subtest smem0: SUCCESS (0.056s) [424.792058] Subtest memory-info-shared: SUCCESS (0.056s) [424.881862] [090/154] (604s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [424.981999] Starting subtest: yf-tiled-32bpp-rotate-270 [424.986311] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [425.079091] [091/154] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [425.180388] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [425.184720] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [425.274457] [092/154] (604s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [425.668430] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [426.464032] [093/154] (603s left) i915_pm_rc6_residency (media-rc6-accuracy) [426.519576] Starting subtest: media-rc6-accuracy [426.523994] Subtest media-rc6-accuracy: SKIP (0.000s) [426.628714] [094/154] (603s left) gem_huc_copy (huc-copy) [426.693802] Starting subtest: huc-copy [426.698959] Subtest huc-copy: SUCCESS (0.003s) [426.828094] [095/154] (603s left) syncobj_timeline (invalid-signal-zero-handles) [426.885488] Starting subtest: invalid-signal-zero-handles [426.888079] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [426.979181] [096/154] (602s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [427.073971] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [427.078327] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [427.147198] [097/154] (602s left) prime_mmap (test_forked_cpu_write) [427.196983] Starting subtest: test_forked_cpu_write [427.199465] Starting dynamic subtest: test_forked_cpu_write-smem [427.205940] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s) [427.208534] Subtest test_forked_cpu_write: SUCCESS (0.012s) [427.314593] [098/154] (602s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render) [427.404095] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render [427.407443] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [427.503252] [099/154] (602s left) api_intel_bb (object-noreloc-purge-cache-simple) [427.551150] Starting subtest: object-noreloc-purge-cache-simple [427.556242] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [427.674455] [100/154] (602s left) gem_exec_balancer (sequential) [427.733509] Starting subtest: sequential [430.846171] Subtest sequential: SUCCESS (3.114s) [431.179059] [101/154] (599s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [431.284638] Starting subtest: fbc-indfb-scaledprimary [434.149075] Subtest fbc-indfb-scaledprimary: SUCCESS (2.869s) [435.300626] [102/154] (594s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [435.408393] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [435.410726] Starting dynamic subtest: pipe-A-eDP-1 [435.436412] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [435.446763] Starting dynamic subtest: pipe-B-eDP-1 [435.471279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [435.480599] Starting dynamic subtest: pipe-C-eDP-1 [435.504286] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [435.513733] Starting dynamic subtest: pipe-D-eDP-1 [435.537590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [435.541974] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [437.751986] [103/154] (592s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [437.852493] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [437.856732] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [437.948747] [104/154] (592s left) gem_exec_whisper (basic-normal) [438.013612] Starting subtest: basic-normal [441.504705] Subtest basic-normal: SUCCESS (3.490s) [441.693849] [105/154] (588s left) kms_flip (2x-plain-flip-fb-recreate) [441.797153] Starting subtest: 2x-plain-flip-fb-recreate [441.807284] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s) [441.890216] [106/154] (588s left) gem_tiled_wb [442.004912] [107/154] (588s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render) [442.100730] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render [442.105068] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [442.195101] [108/154] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [442.301621] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [442.305965] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [442.403679] [109/154] (588s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [442.512223] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [442.514625] Starting dynamic subtest: pipe-A [442.623296] Dynamic subtest pipe-A: SKIP (0.107s) [442.633369] Starting dynamic subtest: pipe-B [443.816873] Dynamic subtest pipe-B: SKIP (1.192s) [443.827716] Starting dynamic subtest: pipe-C [445.048192] Dynamic subtest pipe-C: SUCCESS (1.238s) [445.058448] Starting dynamic subtest: pipe-D [446.275222] Dynamic subtest pipe-D: SUCCESS (1.226s) [446.277544] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.766s) [447.482172] [110/154] (583s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [447.540243] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [447.642665] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [447.723320] [111/154] (582s left) syncobj_wait (signal) [447.771876] Starting subtest: signal [447.774149] Subtest signal: SUCCESS (0.000s) [447.880534] [112/154] (582s left) gem_exec_params (invalid-bsd-ring) [447.930164] Starting subtest: invalid-bsd-ring [447.931995] Subtest invalid-bsd-ring: SUCCESS (0.000s) [448.027332] [113/154] (582s left) syncobj_wait (multi-wait-all-for-submit-submitted) [448.079770] Starting subtest: multi-wait-all-for-submit-submitted [448.190228] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [448.277293] [114/154] (582s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [448.372455] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [448.374944] Starting dynamic subtest: pipe-A-eDP-1 [448.398198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [448.413180] Starting dynamic subtest: pipe-B-eDP-1 [448.441485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [448.451647] Starting dynamic subtest: pipe-C-eDP-1 [448.473582] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [448.485459] Starting dynamic subtest: pipe-D-eDP-1 [448.507401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [448.511629] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [450.649425] [115/154] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [450.755563] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [457.544411] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.795s) [457.669806] [116/154] (573s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [457.776391] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [457.780277] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [457.879294] [117/154] (572s left) gem_linear_blits (basic) [458.345271] Starting subtest: basic [458.357304] Subtest basic: SUCCESS (0.013s) [458.491241] [118/154] (572s left) kms_psr (psr-no-drrs) [458.642209] Starting subtest: psr-no-drrs [458.644483] Starting dynamic subtest: eDP-1 [460.255037] Dynamic subtest eDP-1: SUCCESS (1.611s) [460.257207] Subtest psr-no-drrs: SUCCESS (1.612s) [461.136406] [119/154] (569s left) gem_busy (busy) [461.192974] Starting subtest: busy [461.195226] Starting dynamic subtest: all-engines [461.260683] Dynamic subtest all-engines: SUCCESS (0.067s) [461.272101] Starting dynamic subtest: rcs0 [463.386773] Dynamic subtest rcs0: SUCCESS (2.073s) [463.404365] Starting dynamic subtest: bcs0 [463.406906] Dynamic subtest bcs0: SUCCESS (0.059s) [463.418789] Starting dynamic subtest: vcs0 [463.436283] Dynamic subtest vcs0: SUCCESS (0.037s) [463.449711] Starting dynamic subtest: vcs1 [465.319581] Dynamic subtest vcs1: SUCCESS (1.882s) [465.329951] Starting dynamic subtest: vecs0 [467.352785] Dynamic subtest vecs0: SUCCESS (1.977s) [467.366675] Starting dynamic subtest: ccs0 [469.399285] Dynamic subtest ccs0: SUCCESS (2.047s) [469.401547] Subtest busy: SUCCESS (8.152s) [469.718523] [120/154] (561s left) i915_hangman (engine-engine-hang) [469.780697] Starting subtest: engine-engine-hang [469.782803] Starting dynamic subtest: rcs0 [471.295048] Dynamic subtest rcs0: SUCCESS (1.511s) [471.307380] Starting dynamic subtest: bcs0 [473.276949] Dynamic subtest bcs0: SUCCESS (1.979s) [473.292649] Starting dynamic subtest: vcs0 [475.260599] Dynamic subtest vcs0: SUCCESS (1.980s) [475.273076] Starting dynamic subtest: vcs1 [477.310080] Dynamic subtest vcs1: SUCCESS (2.045s) [477.323039] Starting dynamic subtest: vecs0 [479.293276] Dynamic subtest vecs0: SUCCESS (1.980s) [479.304381] Starting dynamic subtest: ccs0 [481.277420] Dynamic subtest ccs0: SUCCESS (1.981s) [481.280773] Subtest engine-engine-hang: SUCCESS (11.496s) [481.374827] [121/154] (549s left) kms_prop_blob (blob-prop-core) [481.426356] Starting subtest: blob-prop-core [481.428557] Subtest blob-prop-core: SUCCESS (0.000s) [481.533444] [122/154] (549s left) kms_atomic_transition (modeset-transition-nonblocking) [481.632896] Starting subtest: modeset-transition-nonblocking [481.634892] Starting dynamic subtest: 1x-outputs [492.766931] Dynamic subtest 1x-outputs: SUCCESS (11.133s) [492.769876] Subtest modeset-transition-nonblocking: SUCCESS (11.135s) [493.644351] [123/154] (537s left) kms_atomic_transition (plane-all-modeset-transition) [493.734131] Starting subtest: plane-all-modeset-transition [493.738644] Subtest plane-all-modeset-transition: SKIP (0.000s) [493.810621] [124/154] (537s left) gem_wait (wait) [493.876529] Starting subtest: wait [493.878976] Starting dynamic subtest: all-engines [495.326648] Dynamic subtest all-engines: SUCCESS (1.448s) [495.338343] Starting dynamic subtest: rcs0 [496.373726] Dynamic subtest rcs0: SUCCESS (1.046s) [496.386092] Starting dynamic subtest: bcs0 [497.420783] Dynamic subtest bcs0: SUCCESS (1.045s) [497.433157] Starting dynamic subtest: vcs0 [498.466204] Dynamic subtest vcs0: SUCCESS (1.043s) [498.478924] Starting dynamic subtest: vcs1 [499.512080] Dynamic subtest vcs1: SUCCESS (1.044s) [499.524643] Starting dynamic subtest: vecs0 [500.557863] Dynamic subtest vecs0: SUCCESS (1.044s) [500.571403] Starting dynamic subtest: ccs0 [501.606754] Dynamic subtest ccs0: SUCCESS (1.046s) [501.609746] Subtest wait: SUCCESS (7.731s) [501.820044] [125/154] (529s left) kms_big_fb (x-tiled-8bpp-rotate-270) [501.934361] Starting subtest: x-tiled-8bpp-rotate-270 [501.959065] Subtest x-tiled-8bpp-rotate-270: SKIP (0.024s) [502.073749] [126/154] (529s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [502.174070] Starting subtest: psr-rgb565-draw-mmap-cpu [508.984341] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.816s) [509.110792] [127/154] (522s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [509.219177] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [509.223093] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [509.309223] [128/154] (522s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [509.409605] Starting subtest: primary-yf-tiled-reflect-x-0 [509.479134] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s) [509.597730] [129/154] (521s left) kms_big_fb (y-tiled-32bpp-rotate-270) [509.705109] Starting subtest: y-tiled-32bpp-rotate-270 [509.709609] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [509.811231] [130/154] (521s left) kms_psr (fbc-psr2-cursor-render) [509.906947] Starting subtest: fbc-psr2-cursor-render [509.909476] Starting dynamic subtest: eDP-1 [509.913828] Dynamic subtest eDP-1: SKIP (0.000s) [509.918092] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [509.992185] [131/154] (521s left) kms_hdmi_inject (inject-audio) [510.353337] Starting subtest: inject-audio [510.648067] Subtest inject-audio: SUCCESS (0.297s) [511.232227] [132/154] (520s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [511.327776] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [511.331728] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [511.418011] [133/154] (520s left) prime_mmap_kms (buffer-sharing) [511.510471] Starting subtest: buffer-sharing [511.955510] Subtest buffer-sharing: SUCCESS (0.446s) [512.793836] [134/154] (518s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt) [512.893607] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt [512.897682] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [513.005690] [135/154] (518s left) kms_psr (pr-no-drrs) [513.095164] Starting subtest: pr-no-drrs [513.099614] Subtest pr-no-drrs: SKIP (0.000s) [513.168018] [136/154] (518s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc) [513.275928] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc [513.280383] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [513.379366] [137/154] (518s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [513.484013] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [517.617975] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.140s) [518.803654] [138/154] (512s left) kms_flip (flip-vs-panning) [518.891644] Starting subtest: flip-vs-panning [518.894061] Starting dynamic subtest: A-eDP1 [527.592348] Dynamic subtest A-eDP1: SUCCESS (8.699s) [527.602927] Starting dynamic subtest: B-eDP1 [536.280286] Dynamic subtest B-eDP1: SUCCESS (8.685s) [536.291154] Starting dynamic subtest: C-eDP1 [544.968625] Dynamic subtest C-eDP1: SUCCESS (8.688s) [544.983272] Starting dynamic subtest: D-eDP1 [553.661433] Dynamic subtest D-eDP1: SUCCESS (8.690s) [553.666579] Subtest flip-vs-panning: SUCCESS (34.774s) [554.907957] [139/154] (476s left) kms_hdr (bpc-switch-suspend) [555.000848] Starting subtest: bpc-switch-suspend [555.003333] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [575.622734] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.086s) [575.635771] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [596.622652] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.997s) [596.624958] Subtest bpc-switch-suspend: SUCCESS (12.086s) [602.750409] [140/154] (435s left) gem_ctx_create (basic) [602.839111] Starting subtest: basic [602.841340] Subtest basic: SUCCESS (0.000s) [603.022306] [141/154] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [603.121554] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [603.125843] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [603.221009] [142/154] (434s left) gem_exec_reloc (basic-cpu-wc-noreloc) [603.287834] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [603.345904] [143/154] (434s left) gem_softpin (evict-single-offset) [603.399115] Starting subtest: evict-single-offset [628.145106] Subtest evict-single-offset: SUCCESS (24.728s) [628.239763] [144/154] (409s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [628.394953] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [628.399277] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [628.504071] [145/154] (409s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite) [628.600831] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite [628.605273] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [628.698040] [146/154] (409s left) kms_lease (simple-lease) [628.790833] Starting subtest: simple-lease [628.792958] Starting dynamic subtest: pipe-A-eDP-1 [629.332163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [629.348621] Starting dynamic subtest: pipe-B-eDP-1 [630.812139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s) [630.822751] Starting dynamic subtest: pipe-C-eDP-1 [632.299187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.484s) [632.309861] Starting dynamic subtest: pipe-D-eDP-1 [633.711196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s) [633.713565] Subtest simple-lease: SUCCESS (4.921s) [634.604631] [147/154] (403s left) gem_ctx_persistence (saturated-hostile) [634.668503] Starting subtest: saturated-hostile [634.670854] Starting dynamic subtest: rcs0 [635.485743] Dynamic subtest rcs0: SUCCESS (0.819s) [635.501219] Starting dynamic subtest: bcs0 [636.271183] Dynamic subtest bcs0: SUCCESS (0.783s) [636.283243] Starting dynamic subtest: vcs0 [637.060104] Dynamic subtest vcs0: SUCCESS (0.786s) [637.073136] Starting dynamic subtest: vcs1 [637.851528] Dynamic subtest vcs1: SUCCESS (0.788s) [637.865241] Starting dynamic subtest: vecs0 [638.651110] Dynamic subtest vecs0: SUCCESS (0.797s) [638.666380] Starting dynamic subtest: ccs0 [639.487582] Dynamic subtest ccs0: SUCCESS (0.835s) [639.490170] Subtest saturated-hostile: SUCCESS (4.822s) [639.576439] [148/154] (398s left) kms_psr (fbc-psr-sprite-plane-onoff) [639.684946] Starting subtest: fbc-psr-sprite-plane-onoff [639.687248] Starting dynamic subtest: eDP-1 [639.691290] Dynamic subtest eDP-1: SKIP (0.000s) [639.695455] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [639.772787] [149/154] (398s left) prime_self_import (reimport-vs-gem_close-race) [639.807348] Starting subtest: reimport-vs-gem_close-race [644.889592] Subtest reimport-vs-gem_close-race: SUCCESS (5.081s) [644.965766] [150/154] (393s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [645.079056] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [645.083501] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [645.176440] [151/154] (393s left) gem_ctx_param (invalid-ctx-set) [645.234192] Starting subtest: invalid-ctx-set [645.236553] Subtest invalid-ctx-set: SUCCESS (0.001s) [645.347516] [152/154] (393s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [645.455184] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [645.459485] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [645.567452] [153/154] (392s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen) [645.662585] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen [645.667017] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [645.765308] [154/154] (392s left) kms_content_protection (atomic-dpms-hdcp14) [645.903845] Starting subtest: atomic-dpms-hdcp14 [645.907721] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [646.038796] Closing watchdogs results: parsing output: 0/ for test: kms_plane_cursor results: parsing output: 1/ for test: i915_power results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: kms_chamelium_color results: parsing output: 5/ for test: prime_vgem results: parsing output: 6/ for test: gem_mmap_offset results: parsing output: 7/ for test: gem_mmap_wc results: parsing output: 8/ for test: kms_setmode results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_pxp results: parsing output: 11/ for test: kms_flip_scaled_crc results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: perf results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_flip_scaled_crc results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: perf results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: gem_eio results: parsing output: 24/ for test: kms_concurrent results: parsing output: 25/ for test: gem_ctx_persistence results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_exec_suspend results: parsing output: 29/ for test: kms_universal_plane results: parsing output: 30/ for test: prime_busy results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_plane results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_exec_params results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: syncobj_wait results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: kms_cursor_crc results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: device_reset results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: gem_exec_schedule results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gen9_exec_parse results: parsing output: 48/ for test: gem_ctx_engines results: parsing output: 49/ for test: sysfs_defaults results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_cursor_legacy results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: prime_vgem results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: kms_cursor_legacy results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_cursor_edge_walk results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: perf results: parsing output: 65/ for test: gem_exec_balancer results: parsing output: 66/ for test: prime_mmap results: parsing output: 67/ for test: kms_fb_coherency results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: vgem_basic 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_frontbuffer_tracking results: parsing output: 73/ for test: kms_async_flips results: parsing output: 74/ for test: kms_vblank results: parsing output: 75/ for test: kms_selftest results: parsing output: 76/ for test: syncobj_wait results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: gem_exec_fence results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_edid results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_pm_backlight results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_joiner results: parsing output: 88/ for test: i915_drm_fdinfo results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_chamelium_hpd results: parsing output: 92/ for test: i915_pm_rc6_residency results: parsing output: 93/ for test: gem_huc_copy results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: prime_mmap results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: api_intel_bb results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_whisper results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: gem_tiled_wb results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_plane_scaling results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: gem_exec_params results: parsing output: 112/ for test: syncobj_wait results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_linear_blits results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: gem_busy results: parsing output: 119/ for test: i915_hangman results: parsing output: 120/ for test: kms_prop_blob results: parsing output: 121/ for test: kms_atomic_transition results: parsing output: 122/ for test: kms_atomic_transition results: parsing output: 123/ for test: gem_wait results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_rotation_crc results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_hdmi_inject results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: prime_mmap_kms results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_psr results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_flip results: parsing output: 138/ for test: kms_hdr results: parsing output: 139/ for test: gem_ctx_create results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: gem_exec_reloc results: parsing output: 142/ for test: gem_softpin results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_lease results: parsing output: 146/ for test: gem_ctx_persistence results: parsing output: 147/ for test: kms_psr results: parsing output: 148/ for test: prime_self_import results: parsing output: 149/ for test: kms_big_fb results: parsing output: 150/ for test: gem_ctx_param results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_content_protection Done.