[57.920887] Initializing watchdogs [57.920934] /dev/watchdog0 [57.935576] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.939550] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.941535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.944790] [001/133] (960s left) sw_sync (alloc_fence_invalid_timeline) [58.006521] Starting subtest: alloc_fence_invalid_timeline [58.008976] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [58.077618] [002/133] (960s left) syncobj_timeline (transfer-timeline-point) [58.139688] Starting subtest: transfer-timeline-point [58.141937] Subtest transfer-timeline-point: SUCCESS (0.001s) [58.249606] [003/133] (960s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [58.332093] Starting subtest: crc-primary-suspend-yf-tiled-ccs [58.334649] Starting dynamic subtest: pipe-A-eDP-1 [58.344236] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [58.357276] Starting dynamic subtest: pipe-B-eDP-1 [58.366242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [58.373830] Starting dynamic subtest: pipe-C-eDP-1 [58.382232] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [58.389126] Starting dynamic subtest: pipe-D-eDP-1 [58.397591] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [58.401659] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s) [60.673884] [004/133] (957s left) kms_invalid_mode (bad-hsync-start) [60.754122] Starting subtest: bad-hsync-start [60.756448] Starting dynamic subtest: pipe-A-eDP-1 [61.047082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [61.055938] Starting dynamic subtest: pipe-B-eDP-1 [61.057888] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [61.064791] Starting dynamic subtest: pipe-C-eDP-1 [61.066740] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [61.073720] Starting dynamic subtest: pipe-D-eDP-1 [61.075867] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [61.078084] Subtest bad-hsync-start: SUCCESS (0.295s) [61.909269] [005/133] (956s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [61.970109] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [62.075168] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [62.146227] [006/133] (956s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [62.253127] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [62.257682] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [62.352875] [007/133] (956s left) gem_exec_parallel (userptr) [62.411074] Starting subtest: userptr [62.413387] Starting dynamic subtest: rcs0 [63.836891] Dynamic subtest rcs0: SUCCESS (1.416s) [63.845457] Starting dynamic subtest: bcs0 [65.311728] Dynamic subtest bcs0: SUCCESS (1.466s) [65.320110] Starting dynamic subtest: vcs0 [67.199068] Dynamic subtest vcs0: SUCCESS (1.876s) [67.209685] Starting dynamic subtest: vcs1 [69.183331] Dynamic subtest vcs1: SUCCESS (1.976s) [69.193248] Starting dynamic subtest: vecs0 [71.230284] Dynamic subtest vecs0: SUCCESS (2.040s) [71.240842] Starting dynamic subtest: ccs0 [72.923234] Dynamic subtest ccs0: SUCCESS (1.688s) [72.926024] Subtest userptr: SUCCESS (10.468s) [73.149705] [008/133] (945s left) kms_flip (dpms-vs-vblank-race) [73.390450] Starting subtest: dpms-vs-vblank-race [73.393022] Starting dynamic subtest: A-eDP1 [78.359728] Dynamic subtest A-eDP1: SUCCESS (4.961s) [78.367768] Starting dynamic subtest: B-eDP1 [81.872114] Dynamic subtest B-eDP1: SUCCESS (3.511s) [81.881453] Starting dynamic subtest: C-eDP1 [86.502217] Dynamic subtest C-eDP1: SUCCESS (4.626s) [86.511347] Starting dynamic subtest: D-eDP1 [91.121195] Dynamic subtest D-eDP1: SUCCESS (4.616s) [91.123724] Subtest dpms-vs-vblank-race: SUCCESS (17.720s) [91.994719] [009/133] (926s left) gem_mmap_gtt (hang-user) [92.062374] Subtest hang-user: SKIP (0.000s) [92.118777] [010/133] (926s left) kms_pipe_stress (stress-xrgb8888-4tiled) [92.198691] Starting subtest: stress-xrgb8888-4tiled [98.004349] Subtest stress-xrgb8888-4tiled: SUCCESS (5.808s) [98.053131] [011/133] (920s left) gem_ctx_exec (basic) [98.111244] Starting subtest: basic [98.115499] Subtest basic: SUCCESS (0.006s) [98.229650] [012/133] (920s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [98.302279] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [98.304297] Starting dynamic subtest: pipe-A-eDP-1 [98.324064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [98.333129] Starting dynamic subtest: pipe-B-eDP-1 [98.351359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [98.358490] Starting dynamic subtest: pipe-C-eDP-1 [98.376898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [98.386608] Starting dynamic subtest: pipe-D-eDP-1 [98.405264] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [98.408855] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s) [100.558955] [013/133] (918s left) gen9_exec_parse (secure-batches) [100.620564] Subtest secure-batches: SKIP (0.000s) [100.677567] [014/133] (918s left) kms_flip (flip-vs-absolute-wf_vblank) [100.746092] Starting subtest: flip-vs-absolute-wf_vblank [100.748398] Starting dynamic subtest: A-eDP1 [109.701045] Dynamic subtest A-eDP1: SUCCESS (8.955s) [109.709890] Starting dynamic subtest: B-eDP1 [118.629224] Dynamic subtest B-eDP1: SUCCESS (8.925s) [118.636457] Starting dynamic subtest: C-eDP1 [127.551492] Dynamic subtest C-eDP1: SUCCESS (8.919s) [127.560337] Starting dynamic subtest: D-eDP1 [136.491074] Dynamic subtest D-eDP1: SUCCESS (8.938s) [136.493476] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.746s) [137.730708] [015/133] (881s left) gem_exec_reloc (basic-wc-cpu-active) [137.795320] Subtest basic-wc-cpu-active: SKIP (0.000s) [137.872667] [016/133] (881s left) kms_pm_backlight (brightness-with-dpms) [137.939996] Starting subtest: brightness-with-dpms [137.988288] Starting dynamic subtest: eDP-1 [140.388060] Dynamic subtest eDP-1: SUCCESS (2.398s) [140.390781] Subtest brightness-with-dpms: SUCCESS (2.448s) [141.178862] [017/133] (877s left) kms_flip (2x-flip-vs-rmfb-interruptible) [141.263259] Starting subtest: 2x-flip-vs-rmfb-interruptible [141.273428] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.008s) [141.348114] [018/133] (877s left) kms_big_fb (linear-8bpp-rotate-90) [141.441964] Starting subtest: linear-8bpp-rotate-90 [141.463966] Subtest linear-8bpp-rotate-90: SKIP (0.021s) [141.559957] [019/133] (877s left) gem_mmap (big-bo) [141.615171] Subtest big-bo: SKIP (0.000s) [141.664733] [020/133] (877s left) gem_mmap_wc (write-read) [141.716292] Subtest write-read: SKIP (0.000s) [141.781948] [021/133] (877s left) kms_big_fb (y-tiled-32bpp-rotate-0) [141.855970] Starting subtest: y-tiled-32bpp-rotate-0 [141.860242] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [141.966217] [022/133] (877s left) gem_mmap_wc (read-write) [142.023633] Subtest read-write: SKIP (0.000s) [142.075666] [023/133] (877s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [142.148902] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [142.150866] Starting dynamic subtest: pipe-A [142.210613] Dynamic subtest pipe-A: SUCCESS (0.065s) [142.218765] Starting dynamic subtest: pipe-B [143.319539] Dynamic subtest pipe-B: SUCCESS (1.108s) [143.328996] Starting dynamic subtest: pipe-C [144.423648] Dynamic subtest pipe-C: SUCCESS (1.102s) [144.436322] Starting dynamic subtest: pipe-D [145.553266] Dynamic subtest pipe-D: SUCCESS (1.129s) [145.555706] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.407s) [146.710016] [024/133] (872s left) gem_exec_params (invalid-ring2) [146.776510] Starting subtest: invalid-ring2 [146.778905] Subtest invalid-ring2: SUCCESS (0.000s) [146.896726] [025/133] (872s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [146.975058] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [146.977360] Starting dynamic subtest: pipe-A-default-mode [149.764628] Dynamic subtest pipe-A-default-mode: SUCCESS (2.788s) [149.766917] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.789s) [150.595210] [026/133] (868s left) kms_psr (fbc-pr-sprite-mmap-cpu) [150.681063] Starting subtest: fbc-pr-sprite-mmap-cpu [150.685833] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [150.764891] [027/133] (868s left) kms_plane (plane-position-hole) [150.831454] Starting subtest: plane-position-hole [151.337070] Starting dynamic subtest: pipe-A-plane-1 [152.569643] Dynamic subtest pipe-A-plane-1: SUCCESS (1.233s) [152.578292] Starting dynamic subtest: pipe-A-plane-2 [153.871737] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s) [153.880891] Starting dynamic subtest: pipe-A-plane-3 [155.109364] Dynamic subtest pipe-A-plane-3: SUCCESS (1.237s) [155.117602] Starting dynamic subtest: pipe-A-plane-4 [156.330116] Dynamic subtest pipe-A-plane-4: SUCCESS (1.219s) [156.338367] Starting dynamic subtest: pipe-A-plane-5 [156.354659] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [157.495055] Starting dynamic subtest: pipe-B-plane-1 [158.734812] Dynamic subtest pipe-B-plane-1: SUCCESS (1.246s) [158.743777] Starting dynamic subtest: pipe-B-plane-2 [160.061304] Dynamic subtest pipe-B-plane-2: SUCCESS (1.325s) [160.069956] Starting dynamic subtest: pipe-B-plane-3 [161.295789] Dynamic subtest pipe-B-plane-3: SUCCESS (1.235s) [161.304691] Starting dynamic subtest: pipe-B-plane-4 [162.522180] Dynamic subtest pipe-B-plane-4: SUCCESS (1.225s) [162.530802] Starting dynamic subtest: pipe-B-plane-5 [162.547585] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [162.549773] Subtest plane-position-hole: SUCCESS (11.714s) [163.328718] [028/133] (856s left) kms_cursor_crc (cursor-rapid-movement-512x512) [163.596441] Starting subtest: cursor-rapid-movement-512x512 [163.600847] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [163.771586] [029/133] (855s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [163.840283] Starting subtest: legacy-engines-hostile-preempt [163.842218] Starting dynamic subtest: render [163.907719] Dynamic subtest render: SUCCESS (0.069s) [163.918290] Starting dynamic subtest: bsd1 [165.238715] Dynamic subtest bsd1: SUCCESS (1.326s) [165.249597] Starting dynamic subtest: bsd2 [167.204341] Dynamic subtest bsd2: SUCCESS (1.963s) [167.215485] Starting dynamic subtest: blt [167.295958] Dynamic subtest blt: SUCCESS (0.089s) [167.306190] Starting dynamic subtest: vebox [169.218304] Dynamic subtest vebox: SUCCESS (1.918s) [169.220893] Subtest legacy-engines-hostile-preempt: SUCCESS (5.380s) [169.296218] [030/133] (850s left) prime_mmap (test_refcounting) [169.353363] Starting subtest: test_refcounting [169.355523] Starting dynamic subtest: test_refcounting-smem [169.387121] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s) [169.389447] Subtest test_refcounting: SUCCESS (0.036s) [169.485748] [031/133] (850s left) kms_dp_link_training (uhbr-mst) [169.556932] Starting subtest: uhbr-mst [169.565535] Subtest uhbr-mst: SKIP (0.000s) [169.623977] [032/133] (850s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [169.685187] Starting subtest: etime-multi-wait-available-unsubmitted [169.795225] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s) [169.867376] [033/133] (849s left) kms_psr (psr2-sprite-mmap-cpu) [169.950042] Starting subtest: psr2-sprite-mmap-cpu [169.952320] Starting dynamic subtest: eDP-1 [171.640466] Dynamic subtest eDP-1: SUCCESS (1.688s) [171.642427] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.689s) [172.500261] [034/133] (847s left) gem_ctx_shared (detached-shared-gtt) [172.561404] Starting subtest: detached-shared-gtt [174.715194] Subtest detached-shared-gtt: SUCCESS (2.151s) [175.042500] [035/133] (844s left) kms_big_fb (4-tiled-addfb) [175.124309] Starting subtest: 4-tiled-addfb [175.126195] Subtest 4-tiled-addfb: SUCCESS (0.000s) [175.228540] [036/133] (844s left) i915_drm_fdinfo (virtual-busy-hang-all) [175.270819] Starting subtest: virtual-busy-hang-all [175.275179] Subtest virtual-busy-hang-all: SKIP (0.000s) [175.337482] [037/133] (844s left) kms_psr (psr2-cursor-blt) [175.403307] Starting subtest: psr2-cursor-blt [175.405592] Starting dynamic subtest: eDP-1 [177.080953] Dynamic subtest eDP-1: SUCCESS (1.677s) [177.083360] Subtest psr2-cursor-blt: SUCCESS (1.679s) [177.875185] [038/133] (842s left) prime_busy (before) [177.936434] Starting subtest: before [177.941315] Starting dynamic subtest: rcs0 [177.963987] Dynamic subtest rcs0: SUCCESS (0.024s) [177.972906] Starting dynamic subtest: bcs0 [178.016391] Dynamic subtest bcs0: SUCCESS (0.052s) [178.025131] Starting dynamic subtest: vcs0 [178.055862] Dynamic subtest vcs0: SUCCESS (0.038s) [178.063827] Starting dynamic subtest: vcs1 [178.095839] Dynamic subtest vcs1: SUCCESS (0.039s) [178.104049] Starting dynamic subtest: vecs0 [178.136860] Dynamic subtest vecs0: SUCCESS (0.040s) [178.154365] Starting dynamic subtest: ccs0 [178.177089] Dynamic subtest ccs0: SUCCESS (0.040s) [178.286384] Subtest before: SUCCESS (0.348s) [178.361336] [039/133] (841s left) gem_exec_fence (basic-await) [178.538834] Starting subtest: basic-await [178.541613] Starting dynamic subtest: rcs0 [178.616944] Dynamic subtest rcs0: SUCCESS (0.078s) [178.630682] Starting dynamic subtest: bcs0 [178.696873] Dynamic subtest bcs0: SUCCESS (0.077s) [178.707716] Starting dynamic subtest: vcs0 [178.771020] Dynamic subtest vcs0: SUCCESS (0.071s) [178.780177] Starting dynamic subtest: vcs1 [178.844282] Dynamic subtest vcs1: SUCCESS (0.071s) [178.853617] Starting dynamic subtest: vecs0 [178.920812] Dynamic subtest vecs0: SUCCESS (0.074s) [178.931351] Starting dynamic subtest: ccs0 [178.992443] Dynamic subtest ccs0: SUCCESS (0.070s) [178.994812] Subtest basic-await: SUCCESS (0.455s) [181.273778] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true [181.277621] [040/133] (838s left) syncobj_wait (invalid-reset-one-illegal-handle) [181.338132] Starting subtest: invalid-reset-one-illegal-handle [181.340461] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [181.457559] [041/133] (838s left) gem_exec_whisper (basic-forked-all) [181.520575] Starting subtest: basic-forked-all [194.932941] Subtest basic-forked-all: SUCCESS (13.408s) [195.125720] [042/133] (824s left) gem_basic (bad-close) [195.184745] Starting subtest: bad-close [195.189137] Subtest bad-close: SUCCESS (0.000s) [195.297207] [043/133] (824s left) kms_cursor_edge_walk (256x256-top-edge) [195.379665] Starting subtest: 256x256-top-edge [195.381777] Starting dynamic subtest: pipe-A-eDP-1 [198.859386] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [198.868151] Starting dynamic subtest: pipe-D-eDP-1 [201.974960] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s) [201.977264] Subtest 256x256-top-edge: SUCCESS (6.594s) [202.784531] [044/133] (817s left) vgem_basic (dmabuf-mmap) [202.829235] Starting subtest: dmabuf-mmap [202.837630] Subtest dmabuf-mmap: SUCCESS (0.011s) [202.896753] [045/133] (817s left) gem_lmem_swapping (verify) [202.941667] Subtest verify: SKIP (0.000s) [202.982330] [046/133] (817s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [203.053753] Starting subtest: psr-rgb101010-draw-mmap-gtt [203.057777] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [203.161065] [047/133] (817s left) kms_rotation_crc (primary-rotation-90) [203.232944] Starting subtest: primary-rotation-90 [203.237422] Subtest primary-rotation-90: SKIP (0.001s) [203.309694] [048/133] (816s left) sysfs_timeslice_duration (timeout) [203.359086] Starting subtest: timeout [203.361396] Starting dynamic subtest: vecs0 [213.242550] Dynamic subtest vecs0: SUCCESS (9.879s) [213.253373] Starting dynamic subtest: ccs0 [214.526069] Dynamic subtest ccs0: SUCCESS (1.282s) [214.534612] Starting dynamic subtest: vcs0 [224.252539] Dynamic subtest vcs0: SUCCESS (9.724s) [224.261983] Starting dynamic subtest: bcs0 [224.847870] Dynamic subtest bcs0: SUCCESS (0.594s) [224.858146] Starting dynamic subtest: rcs0 [226.092566] Dynamic subtest rcs0: SUCCESS (1.246s) [226.102634] Starting dynamic subtest: vcs1 [235.194062] Dynamic subtest vcs1: SUCCESS (9.095s) [235.196509] Subtest timeout: SUCCESS (31.830s) [235.269946] [049/133] (785s left) perf_pmu (idle) [235.316106] Starting subtest: idle [235.318511] Starting dynamic subtest: rcs0 [235.859900] Dynamic subtest rcs0: SUCCESS (0.543s) [235.871582] Starting dynamic subtest: bcs0 [236.381578] Dynamic subtest bcs0: SUCCESS (0.516s) [236.392046] Starting dynamic subtest: vcs0 [236.896722] Dynamic subtest vcs0: SUCCESS (0.516s) [236.906856] Starting dynamic subtest: vcs1 [237.415479] Dynamic subtest vcs1: SUCCESS (0.515s) [237.428781] Starting dynamic subtest: vecs0 [237.936968] Dynamic subtest vecs0: SUCCESS (0.519s) [237.949532] Starting dynamic subtest: ccs0 [238.465051] Dynamic subtest ccs0: SUCCESS (0.522s) [238.467513] Subtest idle: SUCCESS (3.146s) [238.562414] [050/133] (781s left) kms_joiner (invalid-modeset-ultra-joiner) [238.653275] Starting subtest: invalid-modeset-ultra-joiner [238.657354] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [238.732875] [051/133] (781s left) gem_spin_batch (legacy) [238.786723] Starting subtest: legacy [238.788952] Starting dynamic subtest: default [242.025715] Dynamic subtest default: SUCCESS (3.234s) [242.036942] Starting dynamic subtest: render [245.260515] Dynamic subtest render: SUCCESS (3.230s) [245.276259] Starting dynamic subtest: bsd [248.493066] Dynamic subtest bsd: SUCCESS (3.231s) [248.506105] Starting dynamic subtest: bsd1 [251.730539] Dynamic subtest bsd1: SUCCESS (3.234s) [251.739814] Starting dynamic subtest: bsd2 [254.963394] Dynamic subtest bsd2: SUCCESS (3.230s) [254.974562] Starting dynamic subtest: blt [258.201903] Dynamic subtest blt: SUCCESS (3.235s) [258.210993] Starting dynamic subtest: vebox [261.438770] Dynamic subtest vebox: SUCCESS (3.234s) [261.441436] Subtest legacy: SUCCESS (22.648s) [262.289092] [052/133] (758s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [262.366966] Starting subtest: psr2-plane-move-sf-dmg-area [262.369341] Starting dynamic subtest: pipe-A-eDP-1 [266.932906] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.569s) [266.942246] Starting dynamic subtest: pipe-B-eDP-1 [272.280718] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.345s) [272.283048] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.917s) [273.145787] [053/133] (747s left) gem_mmap_gtt (basic-small-copy-odd) [273.212035] Subtest basic-small-copy-odd: SKIP (0.000s) [273.273439] [054/133] (747s left) gem_ctx_engines (invalid-engines) [273.341091] Starting subtest: invalid-engines [273.346984] Subtest invalid-engines: SUCCESS (0.006s) [273.575049] [055/133] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [273.647958] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [273.652256] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [273.767766] [056/133] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [273.851502] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [273.855874] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [273.955822] [057/133] (746s left) gem_exec_whisper (basic-queues-forked-all) [274.021941] Starting subtest: basic-queues-forked-all [293.514065] Subtest basic-queues-forked-all: SUCCESS (19.490s) [293.702821] [058/133] (726s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [293.807105] Starting subtest: cursorB-vs-flipA-toggle [293.811464] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [293.956679] [059/133] (726s left) kms_atomic_interruptible (legacy-dpms) [294.031582] Starting subtest: legacy-dpms [294.033920] Starting dynamic subtest: pipe-A-eDP-1 [301.509730] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.480s) [301.511928] Subtest legacy-dpms: SUCCESS (7.481s) [302.344068] [060/133] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [302.424570] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [309.880161] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.460s) [310.006101] [061/133] (710s left) kms_busy (extended-pageflip-hang-oldfb) [310.087086] Starting subtest: extended-pageflip-hang-oldfb [310.089377] Starting dynamic subtest: pipe-A [310.480560] Dynamic subtest pipe-A: SUCCESS (0.393s) [310.490340] Starting dynamic subtest: pipe-D [311.601211] Dynamic subtest pipe-D: SUCCESS (1.117s) [311.603472] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.515s) [312.453493] [062/133] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [312.534347] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [319.065689] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.536s) [319.215398] [063/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [319.306236] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [319.310162] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [319.400987] [064/133] (701s left) perf (rc6-disable) [319.519284] Starting subtest: rc6-disable [319.699944] Subtest rc6-disable: SUCCESS (0.180s) [319.747312] [065/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [319.834335] Starting subtest: fbc-1p-primscrn-spr-indfb-move [324.091066] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.261s) [325.243747] [066/133] (695s left) gem_exec_reloc (basic-wc-read) [325.296852] Subtest basic-wc-read: SKIP (0.000s) [325.374899] [067/133] (695s left) syncobj_wait (single-wait-signaled) [325.431402] Starting subtest: single-wait-signaled [325.433690] Subtest single-wait-signaled: SUCCESS (0.000s) [325.531873] [068/133] (695s left) gem_exec_balancer (bonded-dual) [325.594033] Starting subtest: bonded-dual [325.598623] Subtest bonded-dual: SKIP (0.000s) [325.886728] [069/133] (695s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [325.961100] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [325.963324] Starting dynamic subtest: pipe-A-eDP-1 [325.985692] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [325.995796] Starting dynamic subtest: pipe-B-eDP-1 [326.017515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [326.026247] Starting dynamic subtest: pipe-C-eDP-1 [326.048191] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [326.056330] Starting dynamic subtest: pipe-D-eDP-1 [326.079130] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [326.083171] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [328.196440] [070/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [328.296246] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [328.300739] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [328.398474] [071/133] (692s left) kms_color_pipeline (plane-ctm3x4) [328.473265] Starting subtest: plane-ctm3x4 [328.596863] Starting dynamic subtest: pipe-A-plane-0 [328.720584] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s) [328.730207] Starting dynamic subtest: pipe-A-plane-1 [328.852221] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s) [328.861430] Starting dynamic subtest: pipe-A-plane-2 [329.018820] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [330.211062] Starting dynamic subtest: pipe-B-plane-0 [330.368160] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [330.377573] Starting dynamic subtest: pipe-B-plane-1 [330.479624] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s) [330.488914] Starting dynamic subtest: pipe-B-plane-2 [330.638554] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [331.825063] Starting dynamic subtest: pipe-C-plane-0 [331.928740] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [331.938220] Starting dynamic subtest: pipe-C-plane-1 [332.062725] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [332.072323] Starting dynamic subtest: pipe-C-plane-2 [332.184376] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s) [333.360290] Starting dynamic subtest: pipe-D-plane-0 [333.462152] Dynamic subtest pipe-D-plane-0: SUCCESS (0.110s) [333.479723] Starting dynamic subtest: pipe-D-plane-1 [333.572979] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s) [333.582489] Starting dynamic subtest: pipe-D-plane-2 [333.685063] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s) [333.983535] Subtest plane-ctm3x4: SUCCESS (5.510s) [334.862416] [072/133] (686s left) kms_psr (psr-primary-page-flip) [334.931924] Starting subtest: psr-primary-page-flip [334.934077] Starting dynamic subtest: eDP-1 [336.640848] Dynamic subtest eDP-1: SUCCESS (1.708s) [336.643101] Subtest psr-primary-page-flip: SUCCESS (1.708s) [337.493621] [073/133] (683s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [337.569065] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [337.571334] Starting dynamic subtest: pipe-A-eDP-1 [337.595774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [337.606801] Starting dynamic subtest: pipe-B-eDP-1 [337.629896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [337.638818] Starting dynamic subtest: pipe-C-eDP-1 [337.661985] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [337.670143] Starting dynamic subtest: pipe-D-eDP-1 [337.694735] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [337.698804] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [339.871829] [074/133] (681s left) kms_pm_rpm (system-suspend-idle) [341.361433] Starting subtest: system-suspend-idle [360.639448] Subtest system-suspend-idle: SUCCESS (4.417s) [361.007948] [075/133] (660s left) kms_getfb (getfb-reject-nv12) [361.102680] Starting subtest: getfb-reject-nv12 [361.104956] Subtest getfb-reject-nv12: SUCCESS (0.001s) [361.201411] [076/133] (660s left) kms_vrr (flipline) [361.273879] Starting subtest: flipline [361.280650] Subtest flipline: SKIP (0.000s) [361.354059] [077/133] (660s left) kms_chamelium_frames (hdmi-crc-multiple) [361.725798] Subtest hdmi-crc-multiple: SKIP (0.000s) [362.544513] [078/133] (658s left) gem_exec_reloc (basic-cpu-read-active) [362.607637] Subtest basic-cpu-read-active: SKIP (0.000s) [362.662732] [079/133] (658s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [362.741511] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [362.745636] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [362.842102] [080/133] (658s left) kms_universal_plane (universal-plane-sanity) [362.917553] Starting subtest: universal-plane-sanity [362.920098] Starting dynamic subtest: pipe-A-eDP-1 [363.527519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s) [363.542149] Starting dynamic subtest: pipe-B-eDP-1 [364.721038] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s) [364.731606] Starting dynamic subtest: pipe-C-eDP-1 [365.940942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s) [365.951618] Starting dynamic subtest: pipe-D-eDP-1 [367.186333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [367.188669] Subtest universal-plane-sanity: SUCCESS (4.225s) [368.053807] [081/133] (653s left) syncobj_timeline (multi-wait-all-available-signaled) [368.108778] Starting subtest: multi-wait-all-available-signaled [368.111043] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [368.199078] [082/133] (653s left) api_intel_allocator (simple-allocator) [368.248561] Starting subtest: simple-allocator [368.251304] Starting dynamic subtest: basic [368.253688] Dynamic subtest basic: SUCCESS (0.003s) [368.264979] Starting dynamic subtest: parallel-one [368.433427] Dynamic subtest parallel-one: SUCCESS (0.180s) [368.443436] Starting dynamic subtest: print [368.446328] Dynamic subtest print: SUCCESS (0.000s) [368.459685] Starting dynamic subtest: reuse [368.461582] Dynamic subtest reuse: SUCCESS (0.000s) [368.470427] Starting dynamic subtest: reserve [368.472362] Dynamic subtest reserve: SUCCESS (0.000s) [368.481090] Starting dynamic subtest: fork-reopen-allocator [368.483062] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [368.485023] Subtest simple-allocator: SUCCESS (0.201s) [368.580545] [083/133] (653s left) gen7_exec_parse (basic-allowed) [368.630434] Subtest basic-allowed: SKIP (0.000s) [368.703429] [084/133] (653s left) gem_mmap_wc (write-wc-read-gtt) [368.765648] Subtest write-wc-read-gtt: SKIP (0.000s) [368.828600] [085/133] (652s left) syncobj_wait (multi-wait-all-submitted) [368.882840] Starting subtest: multi-wait-all-submitted [368.992005] Subtest multi-wait-all-submitted: SUCCESS (0.107s) [369.088635] [086/133] (652s left) dumb_buffer (map-invalid-size) [369.150173] Starting subtest: map-invalid-size [369.152480] Subtest map-invalid-size: SUCCESS (0.000s) [369.255952] [087/133] (652s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [369.338666] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [369.342954] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [369.441024] [088/133] (652s left) gem_ctx_isolation (dirty-create) [369.504715] Starting subtest: dirty-create [369.507128] Starting dynamic subtest: rcs0 [369.691079] Dynamic subtest rcs0: SUCCESS (0.185s) [369.700691] Starting dynamic subtest: bcs0 [369.879509] Dynamic subtest bcs0: SUCCESS (0.186s) [369.889473] Starting dynamic subtest: vcs0 [370.077012] Dynamic subtest vcs0: SUCCESS (0.196s) [370.088055] Starting dynamic subtest: vcs1 [371.205158] Dynamic subtest vcs1: SUCCESS (1.121s) [371.215768] Starting dynamic subtest: vecs0 [373.211371] Dynamic subtest vecs0: SUCCESS (1.995s) [373.222160] Starting dynamic subtest: ccs0 [375.300184] Dynamic subtest ccs0: SUCCESS (2.080s) [375.302597] Subtest dirty-create: SUCCESS (5.770s) [375.542187] [089/133] (646s left) gem_exec_schedule (semaphore-noskip) [375.623191] Starting subtest: semaphore-noskip [376.097828] Subtest semaphore-noskip: SUCCESS (0.480s) [376.450881] [090/133] (645s left) kms_draw_crc (draw-method-pwrite) [376.528511] Starting subtest: draw-method-pwrite [376.530828] Starting dynamic subtest: xrgb8888-untiled [377.080225] Dynamic subtest xrgb8888-untiled: SUCCESS (0.550s) [377.090611] Starting dynamic subtest: rgb565-untiled [377.525916] Dynamic subtest rgb565-untiled: SUCCESS (0.442s) [377.536167] Starting dynamic subtest: xrgb2101010-untiled [378.049026] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.521s) [378.059142] Starting dynamic subtest: xbgr16161616f-untiled [378.784539] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.732s) [378.794749] Starting dynamic subtest: xrgb8888-xtiled [380.509693] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.720s) [380.522369] Starting dynamic subtest: rgb565-xtiled [381.568405] Dynamic subtest rgb565-xtiled: SUCCESS (1.053s) [381.581854] Starting dynamic subtest: xrgb2101010-xtiled [383.281159] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.710s) [383.290995] Starting dynamic subtest: xbgr16161616f-xtiled [386.529561] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.242s) [386.539575] Starting dynamic subtest: xrgb8888-4tiled [387.575110] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.044s) [387.585247] Starting dynamic subtest: rgb565-4tiled [388.120245] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s) [388.130627] Starting dynamic subtest: xrgb2101010-4tiled [389.177170] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.053s) [389.189443] Starting dynamic subtest: xbgr16161616f-4tiled [392.110786] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.931s) [392.113129] Subtest draw-method-pwrite: SUCCESS (15.562s) [392.193001] [091/133] (629s left) kms_cursor_crc (cursor-onscreen-256x85) [392.408038] Starting subtest: cursor-onscreen-256x85 [392.451708] Subtest cursor-onscreen-256x85: SKIP (0.041s) [392.611390] [092/133] (629s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [392.676508] Starting subtest: mixed-tiled-to-y-tiled-ccs [392.680901] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [392.858587] [093/133] (629s left) gem_flink_basic (flink-lifetime) [392.914407] Starting subtest: flink-lifetime [392.916750] Subtest flink-lifetime: SUCCESS (0.003s) [393.016770] [094/133] (629s left) kms_chamelium_hpd (dp-hpd-after-suspend) [393.395610] Subtest dp-hpd-after-suspend: SKIP (0.000s) [394.217804] [095/133] (628s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [394.296061] Starting subtest: plane-all-modeset-transition-fencing [394.300991] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [394.363812] [096/133] (627s left) perf_pmu (interrupts-sync) [394.403819] Starting subtest: interrupts-sync [395.490733] Subtest interrupts-sync: SUCCESS (1.086s) [395.599290] [097/133] (626s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [395.681886] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [396.295342] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.615s) [396.468420] [098/133] (625s left) gem_render_copy_redux (flink) [396.517015] Starting subtest: flink [397.330066] Subtest flink: SUCCESS (0.813s) [397.448223] [099/133] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [397.530851] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [404.442339] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.912s) [404.580571] [100/133] (617s left) kms_atomic (test-only) [404.647741] Starting subtest: test-only [404.695620] Starting dynamic subtest: pipe-A-eDP-1 [407.201359] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s) [407.203756] Subtest test-only: SUCCESS (2.553s) [408.072959] [101/133] (614s left) i915_drm_fdinfo (busy) [408.116447] Starting subtest: busy [408.118573] Starting dynamic subtest: rcs0 [408.143141] Dynamic subtest rcs0: SKIP (0.026s) [408.155611] Starting dynamic subtest: bcs0 [408.160144] Dynamic subtest bcs0: SKIP (0.000s) [408.170057] Starting dynamic subtest: vcs0 [408.174505] Dynamic subtest vcs0: SKIP (0.000s) [408.185066] Starting dynamic subtest: vcs1 [408.189370] Dynamic subtest vcs1: SKIP (0.000s) [408.198621] Starting dynamic subtest: vecs0 [408.202911] Dynamic subtest vecs0: SKIP (0.000s) [408.212142] Starting dynamic subtest: ccs0 [408.216491] Dynamic subtest ccs0: SKIP (0.000s) [408.220671] Subtest busy: SKIP (0.031s) [408.258030] [102/133] (614s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [408.327309] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [408.353855] Starting dynamic subtest: pipe-A-plane-0 [408.642754] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [408.654493] Starting dynamic subtest: pipe-A-plane-3 [408.875712] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [409.955711] Starting dynamic subtest: pipe-B-plane-0 [410.245459] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [410.255927] Starting dynamic subtest: pipe-B-plane-3 [410.479062] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [410.793291] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.465s) [411.627012] [103/133] (610s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [411.720693] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [411.724832] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [411.835144] [104/133] (610s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [411.919457] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [411.923909] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s) [411.997471] [105/133] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [412.077347] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [412.081806] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [412.176327] [106/133] (610s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [412.262508] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [412.264810] Starting dynamic subtest: pipe-A-eDP-1 [412.289244] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [412.303457] Starting dynamic subtest: pipe-B-eDP-1 [412.328830] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [412.338450] Starting dynamic subtest: pipe-C-eDP-1 [412.359158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [412.369337] Starting dynamic subtest: pipe-D-eDP-1 [412.391025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [412.395303] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [414.580535] [107/133] (608s left) kms_big_fb (x-tiled-64bpp-rotate-270) [414.678273] Starting subtest: x-tiled-64bpp-rotate-270 [414.697443] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s) [414.799724] [108/133] (607s left) gem_render_copy (y-tiled-to-vebox-linear) [414.865159] Starting subtest: y-tiled-to-vebox-linear [414.869824] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [415.045873] [109/133] (607s left) gem_exec_reloc (basic-gtt-cpu-active) [415.103160] Subtest basic-gtt-cpu-active: SKIP (0.000s) [415.173272] [110/133] (607s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [415.264241] Starting subtest: nonblocking-modeset-vs-cursor-atomic [416.669011] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.404s) [417.548844] [111/133] (605s left) syncobj_basic (create-signaled) [417.612069] Starting subtest: create-signaled [417.614734] Subtest create-signaled: SUCCESS (0.000s) [417.723098] [112/133] (605s left) gem_pread (snoop) [417.781186] Subtest snoop: SKIP (0.000s) [417.844829] [113/133] (605s left) kms_plane_cursor (primary) [417.912742] Starting subtest: primary [417.917119] Starting dynamic subtest: pipe-A-eDP-1-size-64 [420.462713] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.550s) [420.487792] Starting dynamic subtest: pipe-A-eDP-1-size-128 [423.032052] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s) [423.057427] Starting dynamic subtest: pipe-A-eDP-1-size-256 [425.576871] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s) [425.893472] Starting dynamic subtest: pipe-B-eDP-1-size-64 [429.107283] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.224s) [429.132339] Starting dynamic subtest: pipe-B-eDP-1-size-128 [431.664823] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.539s) [431.690180] Starting dynamic subtest: pipe-B-eDP-1-size-256 [434.233508] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.550s) [434.557939] Starting dynamic subtest: pipe-C-eDP-1-size-64 [437.541203] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.995s) [437.569537] Starting dynamic subtest: pipe-C-eDP-1-size-128 [439.753454] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s) [439.781152] Starting dynamic subtest: pipe-C-eDP-1-size-256 [441.954306] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s) [442.272686] Starting dynamic subtest: pipe-D-eDP-1-size-64 [445.128554] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.867s) [445.156352] Starting dynamic subtest: pipe-D-eDP-1-size-128 [447.318302] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s) [447.346894] Starting dynamic subtest: pipe-D-eDP-1-size-256 [449.519843] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s) [449.833035] Subtest primary: SUCCESS (31.909s) [450.706954] [114/133] (572s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [450.779457] Starting subtest: primary-y-tiled-reflect-x-180 [450.840416] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [450.946767] [115/133] (572s left) i915_pm_rpm (gem-idle) [453.150208] Starting subtest: gem-idle [459.336952] Subtest gem-idle: SUCCESS (6.192s) [459.669116] [116/133] (563s left) vgem_basic (unload) [459.710992] Starting subtest: unload [488.786499] Subtest unload: SUCCESS (29.080s) [488.884470] [117/133] (534s left) syncobj_timeline (multi-wait-available-submitted) [488.938597] Starting subtest: multi-wait-available-submitted [488.940971] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [489.029158] [118/133] (534s left) kms_content_protection (suspend-resume) [489.163163] Starting subtest: suspend-resume [489.167901] Subtest suspend-resume: SKIP (0.000s) [489.285973] [119/133] (533s left) gem_readwrite (write-bad-handle) [489.344238] Subtest write-bad-handle: SKIP (0.000s) [489.439429] [120/133] (533s left) gem_exec_schedule (noreorder) [489.622738] Starting subtest: noreorder [489.625337] Starting dynamic subtest: rcs0 [489.670490] Dynamic subtest rcs0: SUCCESS (0.049s) [489.684082] Starting dynamic subtest: vcs0 [491.040054] Dynamic subtest vcs0: SUCCESS (1.366s) [491.053023] Starting dynamic subtest: vcs1 [493.031025] Dynamic subtest vcs1: SUCCESS (1.988s) [493.044338] Starting dynamic subtest: vecs0 [494.987448] Dynamic subtest vecs0: SUCCESS (1.953s) [495.000079] Starting dynamic subtest: ccs0 [495.070588] Dynamic subtest ccs0: SUCCESS (0.082s) [495.073655] Subtest noreorder: SUCCESS (5.450s) [495.263322] [121/133] (528s left) api_intel_bb (misplaced-blitter) [495.323668] Starting subtest: misplaced-blitter [495.332134] Subtest misplaced-blitter: SUCCESS (0.011s) [495.460991] [122/133] (527s left) gem_busy (close-race) [495.529684] Starting subtest: close-race [521.059932] Subtest close-race: SUCCESS (25.527s) [521.443991] [123/133] (502s left) fbdev (info) [521.521973] Starting subtest: info [521.524282] Subtest info: SUCCESS (0.000s) [521.598903] [124/133] (501s left) i915_query (engine-info-invalid) [521.662084] Starting subtest: engine-info-invalid [521.664096] Subtest engine-info-invalid: SUCCESS (0.000s) [521.764963] [125/133] (501s left) kms_prop_blob (invalid-get-prop) [521.826893] Starting subtest: invalid-get-prop [521.829225] Subtest invalid-get-prop: SUCCESS (0.000s) [521.930203] [126/133] (501s left) gem_exec_fence (submit-chain) [522.109398] Starting subtest: submit-chain [522.145329] Subtest submit-chain: SUCCESS (0.036s) [524.148073] [127/133] (499s left) kms_addfb_basic (addfb25-y-tiled-legacy) [524.250422] Starting subtest: addfb25-y-tiled-legacy [524.252306] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [524.339747] [128/133] (499s left) kms_vblank (query-forked-busy) [524.410457] Starting subtest: query-forked-busy [524.412782] Starting dynamic subtest: pipe-A-eDP-1 [526.301231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s) [526.317829] Starting dynamic subtest: pipe-D-eDP-1 [528.820619] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s) [528.823118] Subtest query-forked-busy: SUCCESS (4.410s) [529.624210] [129/133] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [529.713133] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [534.140457] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.429s) [535.313502] [130/133] (488s left) kms_flip (2x-blocking-absolute-wf_vblank) [535.391265] Starting subtest: 2x-blocking-absolute-wf_vblank [535.399213] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.007s) [535.534014] [131/133] (488s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [535.610676] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [535.614538] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [535.682350] [132/133] (488s left) kms_psr (fbc-psr-primary-page-flip) [535.765566] Starting subtest: fbc-psr-primary-page-flip [535.767879] Starting dynamic subtest: eDP-1 [535.772321] Dynamic subtest eDP-1: SKIP (0.000s) [535.776740] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [535.840212] [133/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [535.925073] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [542.518817] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.595s) [542.675962] Closing watchdogs results: parsing output: 0/ for test: sw_sync results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: kms_invalid_mode results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_parallel results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: kms_pipe_stress results: parsing output: 10/ for test: gem_ctx_exec results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: gen9_exec_parse results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: kms_pm_backlight results: parsing output: 16/ for test: kms_flip results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_mmap results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: gem_mmap_wc results: parsing output: 22/ for test: kms_plane_scaling results: parsing output: 23/ for test: gem_exec_params results: parsing output: 24/ for test: kms_flip_scaled_crc results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: kms_plane results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: gem_ctx_persistence results: parsing output: 29/ for test: prime_mmap results: parsing output: 30/ for test: kms_dp_link_training results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: gem_ctx_shared results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: prime_busy results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: gem_exec_whisper results: parsing output: 41/ for test: gem_basic results: parsing output: 42/ for test: kms_cursor_edge_walk results: parsing output: 43/ for test: vgem_basic results: parsing output: 44/ for test: gem_lmem_swapping results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: sysfs_timeslice_duration results: parsing output: 48/ for test: perf_pmu results: parsing output: 49/ for test: kms_joiner results: parsing output: 50/ for test: gem_spin_batch results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: gem_ctx_engines results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_exec_whisper results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_atomic_interruptible results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_busy results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: perf results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_exec_balancer results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_color_pipeline results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_pm_rpm results: parsing output: 74/ for test: kms_getfb results: parsing output: 75/ for test: kms_vrr results: parsing output: 76/ for test: kms_chamelium_frames results: parsing output: 77/ for test: gem_exec_reloc results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_universal_plane results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: api_intel_allocator results: parsing output: 82/ for test: gen7_exec_parse results: parsing output: 83/ for test: gem_mmap_wc results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: dumb_buffer results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_ctx_isolation results: parsing output: 88/ for test: gem_exec_schedule results: parsing output: 89/ for test: kms_draw_crc results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: gem_render_copy results: parsing output: 92/ for test: gem_flink_basic results: parsing output: 93/ for test: kms_chamelium_hpd results: parsing output: 94/ for test: kms_atomic_transition results: parsing output: 95/ for test: perf_pmu results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: gem_render_copy_redux results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_atomic results: parsing output: 100/ for test: i915_drm_fdinfo results: parsing output: 101/ for test: kms_plane results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_copy results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: syncobj_basic results: parsing output: 111/ for test: gem_pread results: parsing output: 112/ for test: kms_plane_cursor results: parsing output: 113/ for test: kms_rotation_crc results: parsing output: 114/ for test: i915_pm_rpm results: parsing output: 115/ for test: vgem_basic results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_content_protection results: parsing output: 118/ for test: gem_readwrite results: parsing output: 119/ for test: gem_exec_schedule results: parsing output: 120/ for test: api_intel_bb results: parsing output: 121/ for test: gem_busy results: parsing output: 122/ for test: fbdev results: parsing output: 123/ for test: i915_query results: parsing output: 124/ for test: kms_prop_blob results: parsing output: 125/ for test: gem_exec_fence results: parsing output: 126/ for test: kms_addfb_basic results: parsing output: 127/ for test: kms_vblank results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: kms_psr results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.