[59.165738] Initializing watchdogs [59.165786] /dev/watchdog0 [59.180287] [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] [59.184914] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.187610] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.191201] [001/156] (960s left) kms_cursor_crc (cursor-onscreen-32x10) [59.379821] Starting subtest: cursor-onscreen-32x10 [59.431938] Subtest cursor-onscreen-32x10: SKIP (0.049s) [59.687009] [002/156] (960s left) gem_fenced_exec_thrash (2-spare-fences) [59.757113] Subtest 2-spare-fences: SKIP (0.000s) [59.822613] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move) [59.933863] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move [59.938199] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [60.024166] [004/156] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [60.128490] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [67.782120] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.622s) [67.914150] [005/156] (951s left) kms_plane (pixel-format-linear-modifier) [68.008426] Starting subtest: pixel-format-linear-modifier [68.033764] Starting dynamic subtest: pipe-A-plane-0 [68.579483] Dynamic subtest pipe-A-plane-0: SUCCESS (0.544s) [68.588221] Starting dynamic subtest: pipe-A-plane-3 [69.002644] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s) [69.011860] Starting dynamic subtest: pipe-A-plane-5 [69.214246] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s) [70.291567] Starting dynamic subtest: pipe-B-plane-0 [70.885118] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s) [70.894075] Starting dynamic subtest: pipe-B-plane-3 [71.318970] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s) [71.326482] Starting dynamic subtest: pipe-B-plane-5 [71.530224] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s) [71.856784] Subtest pixel-format-linear-modifier: SUCCESS (3.842s) [72.703354] [006/156] (947s left) kms_legacy_colorkey (invalid-plane) [72.936121] Starting subtest: invalid-plane [72.938546] Starting dynamic subtest: zero-id [72.940598] Dynamic subtest zero-id: SUCCESS (0.000s) [72.949711] Starting dynamic subtest: outrange-id [72.951743] Dynamic subtest outrange-id: SUCCESS (0.000s) [72.953843] Subtest invalid-plane: SUCCESS (0.001s) [73.070357] [007/156] (946s left) kms_psr (fbc-psr-primary-blt) [73.237853] Starting subtest: fbc-psr-primary-blt [73.240217] Starting dynamic subtest: eDP-1 [73.244811] Dynamic subtest eDP-1: SKIP (0.000s) [73.249300] Subtest fbc-psr-primary-blt: SKIP (0.001s) [73.327611] [008/156] (946s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [73.439448] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [73.441787] Starting dynamic subtest: pipe-A-eDP-1 [73.500036] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [73.507407] Starting dynamic subtest: pipe-B-eDP-1 [73.565642] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [73.574810] Starting dynamic subtest: pipe-C-eDP-1 [73.632049] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [73.641371] Starting dynamic subtest: pipe-D-eDP-1 [73.698615] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [73.702722] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s) [75.745362] [009/156] (944s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [75.859472] Starting subtest: cursorB-vs-flipB-varying-size [75.864302] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [76.016588] [010/156] (944s left) kms_plane_multiple (tiling-none) [76.104557] Starting subtest: tiling-none [76.106999] Starting dynamic subtest: pipe-A-eDP-1 [79.818520] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.713s) [79.828381] Starting dynamic subtest: pipe-B-eDP-1 [84.391422] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.568s) [84.399554] Starting dynamic subtest: pipe-C-eDP-1 [88.835501] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.443s) [88.845498] Starting dynamic subtest: pipe-D-eDP-1 [93.265204] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.427s) [93.267518] Subtest tiling-none: SUCCESS (17.155s) [94.068085] [011/156] (926s left) kms_vblank (query-idle-hang) [94.168289] Starting subtest: query-idle-hang [94.170423] Starting dynamic subtest: pipe-A-eDP-1 [121.029573] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.856s) [121.043292] Starting dynamic subtest: pipe-D-eDP-1 [146.059504] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s) [146.061417] Subtest query-idle-hang: SUCCESS (51.884s) [146.940554] [012/156] (873s left) api_intel_allocator (reopen-fork) [146.992890] Starting subtest: reopen-fork [150.274213] Subtest reopen-fork: SUCCESS (3.281s) [150.346302] [013/156] (869s left) perf_pmu (busy-idle-check-all) [150.382813] Starting subtest: busy-idle-check-all [150.385189] Starting dynamic subtest: rcs0 [151.037202] Dynamic subtest rcs0: SUCCESS (0.655s) [151.048262] Starting dynamic subtest: bcs0 [151.693746] Dynamic subtest bcs0: SUCCESS (0.655s) [151.705308] Starting dynamic subtest: vcs0 [153.283976] Dynamic subtest vcs0: SUCCESS (1.587s) [153.294576] Starting dynamic subtest: vcs1 [155.331800] Dynamic subtest vcs1: SUCCESS (2.046s) [155.342275] Starting dynamic subtest: vecs0 [157.316497] Dynamic subtest vecs0: SUCCESS (1.983s) [157.326685] Starting dynamic subtest: ccs0 [157.971259] Dynamic subtest ccs0: SUCCESS (0.655s) [157.973705] Subtest busy-idle-check-all: SUCCESS (7.590s) [158.075053] [014/156] (862s left) kms_addfb_basic (master-rmfb) [158.125465] Starting subtest: master-rmfb [158.127789] Subtest master-rmfb: SUCCESS (0.001s) [158.270505] [015/156] (862s left) i915_pm_rpm (debugfs-forcewake-user) [160.428290] Starting subtest: debugfs-forcewake-user [171.815096] Subtest debugfs-forcewake-user: SUCCESS (11.389s) [172.229810] [016/156] (848s left) core_setmaster (master-drop-set-root) [172.292221] Starting subtest: master-drop-set-root [172.311946] Subtest master-drop-set-root: SUCCESS (0.020s) [172.360379] [017/156] (847s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [172.465274] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [172.469609] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [172.581615] [018/156] (847s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [172.672346] Starting subtest: primary-4-tiled-reflect-x-0 [179.607563] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.934s) [180.775348] [019/156] (839s left) kms_pm_rpm (basic-pci-d3-state) [182.408446] Starting subtest: basic-pci-d3-state [183.886962] Subtest basic-pci-d3-state: SUCCESS (1.478s) [183.994666] [020/156] (836s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [184.103901] Starting subtest: yf-tiled-64bpp-rotate-90 [184.108427] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [184.207174] [021/156] (836s left) kms_getfb (getfb-handle-valid) [184.309139] Starting subtest: getfb-handle-valid [184.311440] Subtest getfb-handle-valid: SUCCESS (0.000s) [184.505031] [022/156] (836s left) gem_ctx_shared (single-timeline) [184.568044] Starting subtest: single-timeline [184.586691] Subtest single-timeline: SUCCESS (0.012s) [184.796839] [023/156] (835s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [184.891087] Starting subtest: pr-overlay-primary-update-sf-dmg-area [184.895260] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [184.956842] [024/156] (835s left) kms_hdr (invalid-metadata-sizes) [185.051796] Starting subtest: invalid-metadata-sizes [185.054134] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [185.058481] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [185.067392] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [185.071750] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [185.075924] Subtest invalid-metadata-sizes: SKIP (0.005s) [185.125014] [025/156] (835s left) gem_exec_schedule (preempt) [185.192888] Starting subtest: preempt [185.195265] Starting dynamic subtest: rcs0 [185.208296] Dynamic subtest rcs0: SUCCESS (0.023s) [185.220402] Starting dynamic subtest: bcs0 [185.226417] Dynamic subtest bcs0: SUCCESS (0.018s) [185.235474] Starting dynamic subtest: vcs0 [185.245154] Dynamic subtest vcs0: SUCCESS (0.018s) [185.256810] Starting dynamic subtest: vcs1 [185.265434] Dynamic subtest vcs1: SUCCESS (0.020s) [185.274376] Starting dynamic subtest: vecs0 [185.285353] Dynamic subtest vecs0: SUCCESS (0.019s) [185.293536] Starting dynamic subtest: ccs0 [185.307031] Dynamic subtest ccs0: SUCCESS (0.021s) [185.309483] Subtest preempt: SUCCESS (0.122s) [187.340768] [026/156] (833s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [187.445937] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [187.450198] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [187.558298] [027/156] (833s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt) [187.651743] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt [187.656197] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [187.734786] [028/156] (833s left) gem_ctx_param (invalid-ctx-get) [187.787735] Starting subtest: invalid-ctx-get [187.790059] Subtest invalid-ctx-get: SUCCESS (0.000s) [187.870371] [029/156] (833s left) gem_mmap_gtt (zero-extend) [187.931511] Subtest zero-extend: SKIP (0.000s) [187.996809] [030/156] (832s left) gem_softpin (evict-prime) [188.059300] Starting subtest: evict-prime [188.061184] Starting dynamic subtest: rcs0 [189.247718] Dynamic subtest rcs0: SUCCESS (1.190s) [189.261361] Starting dynamic subtest: bcs0 [190.377563] Dynamic subtest bcs0: SUCCESS (1.128s) [190.388507] Starting dynamic subtest: vcs0 [192.264777] Dynamic subtest vcs0: SUCCESS (1.884s) [192.274384] Starting dynamic subtest: vcs1 [194.307775] Dynamic subtest vcs1: SUCCESS (2.042s) [194.319541] Starting dynamic subtest: vecs0 [196.294603] Dynamic subtest vecs0: SUCCESS (1.985s) [196.307807] Starting dynamic subtest: ccs0 [197.438904] Dynamic subtest ccs0: SUCCESS (1.144s) [197.450360] Starting dynamic subtest: all [199.235751] Dynamic subtest all: SUCCESS (1.793s) [199.238439] Subtest evict-prime: SUCCESS (11.178s) [199.312612] [031/156] (821s left) gem_exec_balancer (bonded-dual) [199.366664] Starting subtest: bonded-dual [199.371174] Subtest bonded-dual: SKIP (0.000s) [199.671906] [032/156] (821s left) gen9_exec_parse (cmd-crossing-page) [199.725481] Subtest cmd-crossing-page: SKIP (0.000s) [199.793876] [033/156] (821s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [199.881035] Starting subtest: 2x-flip-vs-blocking-wf-vblank [199.892743] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s) [199.968511] [034/156] (821s left) gem_busy (busy) [200.024066] Starting subtest: busy [200.026493] Starting dynamic subtest: all-engines [200.080222] Dynamic subtest all-engines: SUCCESS (0.056s) [200.089368] Starting dynamic subtest: rcs0 [201.290790] Dynamic subtest rcs0: SUCCESS (1.209s) [201.300138] Starting dynamic subtest: bcs0 [201.343231] Dynamic subtest bcs0: SUCCESS (0.050s) [201.357224] Starting dynamic subtest: vcs0 [201.382104] Dynamic subtest vcs0: SUCCESS (0.038s) [201.394959] Starting dynamic subtest: vcs1 [203.336702] Dynamic subtest vcs1: SUCCESS (1.951s) [203.346776] Starting dynamic subtest: vecs0 [205.320510] Dynamic subtest vecs0: SUCCESS (1.983s) [205.330068] Starting dynamic subtest: ccs0 [207.304596] Dynamic subtest ccs0: SUCCESS (1.983s) [207.306673] Subtest busy: SUCCESS (7.279s) [207.637162] [035/156] (813s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [207.739068] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [207.741379] Starting dynamic subtest: pipe-A [208.786143] Dynamic subtest pipe-A: SUCCESS (1.049s) [208.795270] Starting dynamic subtest: pipe-B [210.940556] Dynamic subtest pipe-B: SUCCESS (2.154s) [210.950281] Starting dynamic subtest: pipe-C [212.142296] Dynamic subtest pipe-C: SUCCESS (1.201s) [212.152466] Starting dynamic subtest: pipe-D [213.371553] Dynamic subtest pipe-D: SUCCESS (1.228s) [213.373996] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.635s) [214.564860] [036/156] (806s left) gem_tiled_partial_pwrite_pread (writes) [214.621620] Subtest writes: SKIP (0.000s) [214.688582] [037/156] (806s left) gem_ctx_persistence (heartbeat-hostile) [214.751663] Starting subtest: heartbeat-hostile [214.755752] Subtest heartbeat-hostile: SKIP (0.000s) [214.860632] [038/156] (806s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [214.910035] Starting subtest: etime-multi-wait-all-for-submit-submitted [215.015825] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s) [215.089645] [039/156] (806s left) kms_pm_rpm (pm-caching) [216.613993] Starting subtest: pm-caching [216.619219] Subtest pm-caching: SKIP (0.000s) [217.404542] [040/156] (803s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [217.516549] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [217.520768] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [217.597221] [041/156] (803s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [217.701654] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [217.703942] Starting dynamic subtest: pipe-A-eDP-1 [217.712770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [217.722914] Starting dynamic subtest: pipe-B-eDP-1 [217.731287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [217.739985] Starting dynamic subtest: pipe-C-eDP-1 [217.748096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [217.756341] Starting dynamic subtest: pipe-D-eDP-1 [217.764704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [217.768862] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [220.183606] [042/156] (801s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [220.288173] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [220.292158] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [220.367386] [043/156] (801s left) kms_properties (plane-properties-legacy) [220.468884] Starting subtest: plane-properties-legacy [220.471091] Starting dynamic subtest: pipe-A-eDP-1 [221.009851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s) [221.021203] Starting dynamic subtest: pipe-B-eDP-1 [222.237876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s) [222.247194] Starting dynamic subtest: pipe-C-eDP-1 [223.471903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s) [223.481925] Starting dynamic subtest: pipe-D-eDP-1 [224.707672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [224.709921] Subtest plane-properties-legacy: SUCCESS (4.238s) [225.525462] [044/156] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [225.625373] Starting subtest: fbc-1p-primscrn-spr-indfb-move [229.741939] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.124s) [230.920037] [045/156] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [231.023623] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [231.027840] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [231.116867] [046/156] (790s left) kms_vblank (query-forked-busy) [231.217637] Starting subtest: query-forked-busy [231.219534] Starting dynamic subtest: pipe-A-eDP-1 [233.855382] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.634s) [233.871862] Starting dynamic subtest: pipe-D-eDP-1 [235.932464] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.075s) [235.934802] Subtest query-forked-busy: SUCCESS (4.716s) [236.743942] [047/156] (784s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [236.796765] Starting subtest: multi-wait-all-for-submit-signaled [236.799020] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [236.891185] [048/156] (784s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt) [236.994024] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt [236.998401] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [237.091946] [049/156] (784s left) gem_exec_fence (nb-await) [237.262818] Starting subtest: nb-await [237.265300] Starting dynamic subtest: rcs0 [237.329506] Dynamic subtest rcs0: SUCCESS (0.066s) [237.342053] Starting dynamic subtest: bcs0 [237.388332] Dynamic subtest bcs0: SUCCESS (0.056s) [237.400768] Starting dynamic subtest: vcs0 [237.447165] Dynamic subtest vcs0: SUCCESS (0.057s) [237.458035] Starting dynamic subtest: vcs1 [237.507162] Dynamic subtest vcs1: SUCCESS (0.057s) [237.518520] Starting dynamic subtest: vecs0 [237.566890] Dynamic subtest vecs0: SUCCESS (0.057s) [237.578153] Starting dynamic subtest: ccs0 [237.626099] Dynamic subtest ccs0: SUCCESS (0.057s) [237.628960] Subtest nb-await: SUCCESS (0.365s) [239.375854] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true [239.379215] [050/156] (782s left) kms_cursor_crc (cursor-random-32x32) [239.526790] Starting subtest: cursor-random-32x32 [239.572380] Subtest cursor-random-32x32: SKIP (0.041s) [239.848997] [051/156] (781s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [239.915407] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [239.968336] [052/156] (781s left) api_intel_bb (offset-control) [240.023044] Starting subtest: offset-control [240.029809] Subtest offset-control: SUCCESS (0.009s) [240.152807] [053/156] (781s left) gem_flink_race (flink_close) [240.187823] Starting subtest: flink_close [245.295897] Subtest flink_close: SUCCESS (5.105s) [245.370441] [054/156] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [245.478776] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [249.929713] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.457s) [251.065386] [055/156] (770s left) kms_big_fb (linear-32bpp-rotate-270) [251.166908] Starting subtest: linear-32bpp-rotate-270 [251.186220] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [251.293211] [056/156] (770s left) gem_workarounds (reset-fd) [251.350637] Starting subtest: reset-fd [251.527640] Subtest reset-fd: SUCCESS (0.177s) [251.647440] [057/156] (770s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [251.754615] Starting subtest: hdr-rgb101010-draw-pwrite [251.759058] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [251.838343] [058/156] (770s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [251.929410] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [251.931670] Starting dynamic subtest: pipe-A-eDP-1 [251.953660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [251.963566] Starting dynamic subtest: pipe-B-eDP-1 [251.983432] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [251.991522] Starting dynamic subtest: pipe-C-eDP-1 [252.009785] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [252.018519] Starting dynamic subtest: pipe-D-eDP-1 [252.036169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [252.039545] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [254.207161] [059/156] (767s left) kms_psr (fbc-pr-dpms) [254.299184] Starting subtest: fbc-pr-dpms [254.303655] Subtest fbc-pr-dpms: SKIP (0.000s) [254.374801] [060/156] (767s left) gem_set_tiling_vs_gtt [254.492294] [061/156] (767s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [254.581028] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [254.585268] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [255.734259] [062/156] (766s left) gem_exec_balancer (waits) [255.792404] Starting subtest: waits [262.389180] Subtest waits: SUCCESS (6.543s) [262.633065] [063/156] (759s left) i915_suspend (sysfs-reader) [262.686924] Starting subtest: sysfs-reader [280.725937] Subtest sysfs-reader: SUCCESS (3.985s) [280.769175] [064/156] (741s left) kms_big_fb (4-tiled-8bpp-rotate-90) [280.888815] Starting subtest: 4-tiled-8bpp-rotate-90 [280.910543] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [281.029771] [065/156] (741s left) kms_cursor_crc (cursor-sliding-32x10) [281.182536] Starting subtest: cursor-sliding-32x10 [281.229533] Subtest cursor-sliding-32x10: SKIP (0.041s) [281.494263] [066/156] (740s left) perf_pmu (init-sema) [281.533446] Starting subtest: init-sema [281.535387] Starting dynamic subtest: rcs0 [281.537345] Dynamic subtest rcs0: SUCCESS (0.002s) [281.547792] Starting dynamic subtest: bcs0 [281.549784] Dynamic subtest bcs0: SUCCESS (0.000s) [281.559133] Starting dynamic subtest: vcs0 [281.560810] Dynamic subtest vcs0: SUCCESS (0.001s) [281.569984] Starting dynamic subtest: vcs1 [281.571655] Dynamic subtest vcs1: SUCCESS (0.001s) [281.581179] Starting dynamic subtest: vecs0 [281.583095] Dynamic subtest vecs0: SUCCESS (0.001s) [281.592523] Starting dynamic subtest: ccs0 [281.594149] Dynamic subtest ccs0: SUCCESS (0.001s) [281.595820] Subtest init-sema: SUCCESS (0.008s) [281.639699] [067/156] (740s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [281.757497] Starting subtest: basic-flip-before-cursor-atomic [282.707923] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.932s) [283.623566] [068/156] (738s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [283.726875] Starting subtest: psr-rgb101010-draw-pwrite [291.487141] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.691s) [291.591987] [069/156] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [291.689083] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite [291.693074] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [291.809451] [070/156] (730s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [291.911102] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [291.915046] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [292.015302] [071/156] (730s left) gem_pwrite (basic-self) [292.065724] Subtest basic-self: SKIP (0.000s) [292.124331] [072/156] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt) [292.221011] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt [292.224989] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [292.311737] [073/156] (730s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [292.357140] Starting subtest: multi-wait-for-submit-available-submitted [292.359308] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [292.457239] [074/156] (730s left) vgem_basic (create) [292.496931] Starting subtest: create [292.498933] Subtest create: SUCCESS (0.000s) [292.556702] [075/156] (730s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render) [292.652532] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render [292.656743] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [292.740029] [076/156] (730s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [292.804646] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [292.808559] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [293.013992] [077/156] (729s left) perf (i915-ref-count) [293.084994] Starting subtest: i915-ref-count [293.153317] Subtest i915-ref-count: SUCCESS (0.065s) [293.209096] [078/156] (729s left) kms_invalid_mode (bad-vsync-end) [293.296381] Starting subtest: bad-vsync-end [293.298593] Starting dynamic subtest: pipe-A-eDP-1 [293.590880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [293.601537] Starting dynamic subtest: pipe-B-eDP-1 [293.603618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [293.613333] Starting dynamic subtest: pipe-C-eDP-1 [293.615461] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [293.625544] Starting dynamic subtest: pipe-D-eDP-1 [293.627798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [293.630116] Subtest bad-vsync-end: SUCCESS (0.299s) [294.397743] [079/156] (728s left) sw_sync (sync_expired_merge) [294.438011] Starting subtest: sync_expired_merge [295.516752] Subtest sync_expired_merge: SUCCESS (1.074s) [295.582486] [080/156] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [295.680808] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [295.685251] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [295.777033] [081/156] (727s left) gem_exec_flush (basic-uc-set-default) [295.841027] Starting subtest: basic-uc-set-default [301.341071] Subtest basic-uc-set-default: SUCCESS (5.452s) [301.496557] [082/156] (721s left) kms_force_connector_basic (force-connector-state) [301.567906] Starting subtest: force-connector-state [302.185652] Subtest force-connector-state: SUCCESS (0.618s) [303.172904] [083/156] (719s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [303.274522] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [303.276805] Starting dynamic subtest: pipe-A-eDP-1 [304.659691] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.382s) [304.943161] Starting dynamic subtest: pipe-B-eDP-1 [305.965324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.031s) [306.236140] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.959s) [307.049143] [084/156] (716s left) gem_workarounds (suspend-resume-fd) [307.125402] Starting subtest: suspend-resume-fd [322.707557] Subtest suspend-resume-fd: SUCCESS (1.194s) [322.840743] [085/156] (700s left) gem_readwrite (write-bad-handle) [322.903086] Subtest write-bad-handle: SKIP (0.000s) [322.985212] [086/156] (700s left) gem_create (create-ext-cpu-access-big) [323.153470] Starting subtest: create-ext-cpu-access-big [323.158928] Subtest create-ext-cpu-access-big: SKIP (0.000s) [323.233094] [087/156] (700s left) gem_media_fill (media-fill) [323.282661] Subtest media-fill: SKIP (0.000s) [323.406853] [088/156] (699s left) sw_sync (alloc_fence_invalid_timeline) [323.448475] Starting subtest: alloc_fence_invalid_timeline [323.450955] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [323.509163] [089/156] (699s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [323.605114] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [323.607457] Starting dynamic subtest: A-eDP1 [327.203291] Dynamic subtest A-eDP1: SUCCESS (3.589s) [327.214162] Starting dynamic subtest: B-eDP1 [330.492018] Dynamic subtest B-eDP1: SUCCESS (3.288s) [330.504469] Starting dynamic subtest: C-eDP1 [333.806424] Dynamic subtest C-eDP1: SUCCESS (3.309s) [333.816592] Starting dynamic subtest: D-eDP1 [337.110151] Dynamic subtest D-eDP1: SUCCESS (3.300s) [337.112453] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.496s) [337.976315] [090/156] (685s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [338.076527] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [338.080615] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [338.170818] [091/156] (685s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [338.252327] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [338.254637] Starting dynamic subtest: pipe-A-eDP-1 [338.278432] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [338.289936] Starting dynamic subtest: pipe-B-eDP-1 [338.312805] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [338.322664] Starting dynamic subtest: pipe-C-eDP-1 [338.345438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [338.355085] Starting dynamic subtest: pipe-D-eDP-1 [338.378121] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [338.382016] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [340.486520] [092/156] (683s left) kms_dp_link_training (non-uhbr-sst) [340.573316] Starting subtest: non-uhbr-sst [340.582121] Subtest non-uhbr-sst: SKIP (0.000s) [340.644600] [093/156] (682s left) kms_flip (2x-flip-vs-rmfb-interruptible) [340.737632] Starting subtest: 2x-flip-vs-rmfb-interruptible [340.749096] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [340.853077] [094/156] (682s left) kms_content_protection (legacy) [340.990792] Starting subtest: legacy [340.995468] Subtest legacy: SKIP (0.000s) [341.115443] [095/156] (682s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [341.209449] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [341.213982] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [341.306886] [096/156] (682s left) kms_chamelium_hpd (vga-hpd-fast) [341.694316] Subtest vga-hpd-fast: SKIP (0.000s) [342.548870] [097/156] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [342.645420] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [350.285057] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.641s) [350.409663] [098/156] (673s left) kms_flip (2x-blocking-absolute-wf_vblank) [350.519824] Starting subtest: 2x-blocking-absolute-wf_vblank [350.528933] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [350.644319] [099/156] (673s left) prime_busy (before) [350.700848] Starting subtest: before [350.705914] Starting dynamic subtest: rcs0 [350.734964] Dynamic subtest rcs0: SUCCESS (0.031s) [350.745349] Starting dynamic subtest: bcs0 [350.782630] Dynamic subtest bcs0: SUCCESS (0.047s) [350.792998] Starting dynamic subtest: vcs0 [350.821945] Dynamic subtest vcs0: SUCCESS (0.037s) [350.833525] Starting dynamic subtest: vcs1 [350.862217] Dynamic subtest vcs1: SUCCESS (0.040s) [350.879048] Starting dynamic subtest: vecs0 [350.903143] Dynamic subtest vecs0: SUCCESS (0.039s) [350.914909] Starting dynamic subtest: ccs0 [350.943588] Dynamic subtest ccs0: SUCCESS (0.040s) [351.051610] Subtest before: SUCCESS (0.349s) [351.126129] [100/156] (672s left) gem_exec_fence (basic-busy-all) [351.186584] Starting subtest: basic-busy-all [351.264463] Subtest basic-busy-all: SUCCESS (0.078s) [352.826677] [101/156] (671s left) gem_exercise_blt (fast-copy) [352.883903] Starting subtest: fast-copy [352.886377] Starting dynamic subtest: linear-smem-smem [352.909317] Dynamic subtest linear-smem-smem: SUCCESS (0.025s) [352.922140] Starting dynamic subtest: xmajor-smem-smem [352.929415] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s) [352.940295] Starting dynamic subtest: tile4-smem-smem [352.949311] Dynamic subtest tile4-smem-smem: SUCCESS (0.019s) [352.959140] Starting dynamic subtest: tile64-smem-smem [352.967656] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s) [352.969982] Subtest fast-copy: SUCCESS (0.084s) [353.079879] [102/156] (670s left) kms_addfb_basic (bad-pitch-999) [353.134999] Starting subtest: bad-pitch-999 [353.136873] Subtest bad-pitch-999: SUCCESS (0.000s) [353.275879] [103/156] (670s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render) [353.374491] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render [353.378626] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [353.494015] [104/156] (670s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [353.592187] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [353.596117] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [353.691600] [105/156] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [353.786655] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [353.790215] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [353.891243] [106/156] (670s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [353.984365] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [353.986400] Starting dynamic subtest: pipe-A-eDP-1 [354.081832] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [354.091982] Starting dynamic subtest: pipe-B-eDP-1 [355.252009] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s) [355.256762] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.248s) [356.527020] [107/156] (667s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move) [356.631152] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move [356.635590] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [356.742166] [108/156] (667s left) gem_exec_reloc (basic-cpu-wc-active) [356.804558] Subtest basic-cpu-wc-active: SKIP (0.000s) [356.892847] [109/156] (667s left) kms_draw_crc (draw-method-mmap-gtt) [356.991486] Starting subtest: draw-method-mmap-gtt [356.996050] Subtest draw-method-mmap-gtt: SKIP (0.000s) [357.087106] [110/156] (667s left) syncobj_timeline (wait-all-for-submit-snapshot) [357.150101] Starting subtest: wait-all-for-submit-snapshot [357.231895] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [357.323326] [111/156] (666s left) kms_psr (pr-no-drrs) [357.418480] Starting subtest: pr-no-drrs [357.422563] Subtest pr-no-drrs: SKIP (0.000s) [357.492792] [112/156] (666s left) gem_exec_schedule (submit-early-slice) [357.562232] Starting subtest: submit-early-slice [357.564098] Starting dynamic subtest: rcs0 [357.603392] Dynamic subtest rcs0: SUCCESS (0.045s) [357.614068] Starting dynamic subtest: bcs0 [357.643702] Dynamic subtest bcs0: SUCCESS (0.039s) [357.655222] Starting dynamic subtest: vcs0 [357.686440] Dynamic subtest vcs0: SUCCESS (0.041s) [357.696592] Starting dynamic subtest: vcs1 [357.725621] Dynamic subtest vcs1: SUCCESS (0.038s) [357.736038] Starting dynamic subtest: vecs0 [357.762605] Dynamic subtest vecs0: SUCCESS (0.036s) [357.773214] Starting dynamic subtest: ccs0 [357.802537] Dynamic subtest ccs0: SUCCESS (0.038s) [357.804487] Subtest submit-early-slice: SUCCESS (0.242s) [358.810004] [113/156] (665s left) i915_drm_fdinfo (all-busy-check-all) [358.848847] Starting subtest: all-busy-check-all [358.856074] Subtest all-busy-check-all: SKIP (0.004s) [358.919938] [114/156] (665s left) gem_softpin (evict-active) [359.002959] Starting subtest: evict-active [359.008331] Subtest evict-active: SUCCESS (0.005s) [359.128172] [115/156] (665s left) kms_atomic (crtc-invalid-params-fence) [359.218532] Starting subtest: crtc-invalid-params-fence [359.220874] Starting dynamic subtest: pipe-A-eDP-1 [359.631216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s) [359.633799] Subtest crtc-invalid-params-fence: SUCCESS (0.408s) [360.472926] [116/156] (664s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [360.591492] Starting subtest: flip-vs-cursor-crc-atomic [361.245766] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.648s) [362.095496] [117/156] (662s left) syncobj_wait (wait-delayed-signal) [362.145475] Starting subtest: wait-delayed-signal [362.247063] Subtest wait-delayed-signal: SUCCESS (0.102s) [362.336280] [118/156] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [362.427320] Starting subtest: fbcpsr-1p-rte [369.543372] Subtest fbcpsr-1p-rte: SUCCESS (7.085s) [369.668726] [119/156] (654s left) gem_pxp (reject-modify-context-protection-off-3) [369.789428] Starting subtest: reject-modify-context-protection-off-3 [369.792208] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [369.893524] [120/156] (654s left) kms_flip (flip-vs-modeset-vs-hang) [369.985740] Starting subtest: flip-vs-modeset-vs-hang [369.987956] Starting dynamic subtest: A-eDP1 [421.173098] Dynamic subtest A-eDP1: SUCCESS (51.154s) [421.187780] Starting dynamic subtest: D-eDP1 [471.216881] Dynamic subtest D-eDP1: SUCCESS (50.032s) [471.219954] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.194s) [471.634665] [121/156] (553s left) gem_ctx_isolation (preservation) [471.696152] Starting subtest: preservation [471.698455] Starting dynamic subtest: rcs0 [471.824907] Dynamic subtest rcs0: SUCCESS (0.128s) [471.839931] Starting dynamic subtest: bcs0 [471.975603] Dynamic subtest bcs0: SUCCESS (0.149s) [471.988406] Starting dynamic subtest: vcs0 [472.145786] Dynamic subtest vcs0: SUCCESS (0.170s) [472.157334] Starting dynamic subtest: vcs1 [473.848739] Dynamic subtest vcs1: SUCCESS (1.702s) [473.859684] Starting dynamic subtest: vecs0 [475.849552] Dynamic subtest vecs0: SUCCESS (1.999s) [475.860717] Starting dynamic subtest: ccs0 [477.846093] Dynamic subtest ccs0: SUCCESS (1.996s) [477.849970] Subtest preservation: SUCCESS (6.150s) [478.081063] [122/156] (546s left) tools_test (tools_test) [478.131112] Starting subtest: tools_test [478.179883] Subtest tools_test: SUCCESS (0.065s) [478.243457] [123/156] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [478.339480] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [478.343582] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [478.440615] [124/156] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [478.528042] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [478.532519] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [478.622734] [125/156] (546s left) kms_psr (fbc-psr2-dpms) [478.718487] Starting subtest: fbc-psr2-dpms [478.720835] Starting dynamic subtest: eDP-1 [478.725213] Dynamic subtest eDP-1: SKIP (0.000s) [478.729637] Subtest fbc-psr2-dpms: SKIP (0.001s) [478.793551] [126/156] (546s left) kms_color_pipeline (plane-lut1d) [478.886204] Starting subtest: plane-lut1d [479.056553] Starting dynamic subtest: pipe-A-plane-0 [479.210557] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [479.223264] Starting dynamic subtest: pipe-A-plane-1 [479.388457] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s) [479.399169] Starting dynamic subtest: pipe-A-plane-2 [479.521884] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [480.731501] Starting dynamic subtest: pipe-B-plane-0 [480.888957] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s) [480.899986] Starting dynamic subtest: pipe-B-plane-1 [481.033353] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [481.044463] Starting dynamic subtest: pipe-B-plane-2 [481.233466] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s) [482.405190] Starting dynamic subtest: pipe-C-plane-0 [482.528774] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [482.539561] Starting dynamic subtest: pipe-C-plane-1 [482.695518] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s) [482.707101] Starting dynamic subtest: pipe-C-plane-2 [482.863072] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [484.160803] Starting dynamic subtest: pipe-D-plane-0 [484.308463] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [484.319284] Starting dynamic subtest: pipe-D-plane-1 [484.438539] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [484.453584] Starting dynamic subtest: pipe-D-plane-2 [484.605158] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s) [484.892648] Subtest plane-lut1d: SUCCESS (6.007s) [485.752056] [127/156] (539s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [485.847881] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [486.847537] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.002s) [486.981672] [128/156] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [487.083375] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [487.086855] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [487.187041] [129/156] (537s left) kms_big_fb (x-tiled-32bpp-rotate-0) [487.289914] Starting subtest: x-tiled-32bpp-rotate-0 [488.724597] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.435s) [488.859640] [130/156] (536s left) sysfs_preempt_timeout (idempotent) [488.908706] Starting subtest: idempotent [488.910591] Starting dynamic subtest: vecs0 [488.912545] Dynamic subtest vecs0: SUCCESS (0.000s) [488.923943] Starting dynamic subtest: ccs0 [488.925480] Dynamic subtest ccs0: SUCCESS (0.000s) [488.935227] Starting dynamic subtest: vcs0 [488.936951] Dynamic subtest vcs0: SUCCESS (0.000s) [488.946260] Starting dynamic subtest: bcs0 [488.947858] Dynamic subtest bcs0: SUCCESS (0.001s) [488.957016] Starting dynamic subtest: rcs0 [488.958522] Dynamic subtest rcs0: SUCCESS (0.000s) [488.967795] Starting dynamic subtest: vcs1 [488.969414] Dynamic subtest vcs1: SUCCESS (0.000s) [488.970949] Subtest idempotent: SUCCESS (0.007s) [489.007833] [131/156] (536s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [489.109074] Starting subtest: fbcpsrhdr-rgb101010-draw-render [489.112720] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [489.222892] [132/156] (535s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [489.324449] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [489.327851] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [489.414488] [133/156] (535s left) gem_mmap_wc (write-gtt-read-wc) [489.462969] Subtest write-gtt-read-wc: SKIP (0.000s) [489.522366] [134/156] (535s left) kms_flip_event_leak (basic) [489.607847] Starting subtest: basic [489.609691] Starting dynamic subtest: pipe-A-eDP-1 [490.046881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [490.059680] Starting dynamic subtest: pipe-B-eDP-1 [491.155450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.106s) [491.166060] Starting dynamic subtest: pipe-C-eDP-1 [492.234274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.079s) [492.247103] Starting dynamic subtest: pipe-D-eDP-1 [493.324984] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s) [493.327272] Subtest basic: SUCCESS (3.717s) [494.150377] [135/156] (531s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [494.245661] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [494.249965] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [494.359870] [136/156] (530s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [494.453105] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu [494.457429] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [494.556338] [137/156] (530s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [494.940680] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [495.736157] [138/156] (529s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc) [495.834040] Starting subtest: psrhdr-rgb565-draw-mmap-wc [495.838608] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [495.943245] [139/156] (529s left) gem_exec_schedule (u-submit-late-slice) [496.007089] Starting subtest: u-submit-late-slice [496.009348] Starting dynamic subtest: rcs0 [496.038293] Dynamic subtest rcs0: SUCCESS (0.039s) [496.052206] Starting dynamic subtest: bcs0 [496.067843] Dynamic subtest bcs0: SUCCESS (0.028s) [496.079577] Starting dynamic subtest: vcs0 [496.104535] Dynamic subtest vcs0: SUCCESS (0.035s) [496.122532] Starting dynamic subtest: vcs1 [496.135335] Dynamic subtest vcs1: SUCCESS (0.030s) [496.146509] Starting dynamic subtest: vecs0 [496.168721] Dynamic subtest vecs0: SUCCESS (0.032s) [496.183122] Starting dynamic subtest: ccs0 [496.199692] Dynamic subtest ccs0: SUCCESS (0.030s) [496.202083] Subtest u-submit-late-slice: SUCCESS (0.202s) [497.819982] [140/156] (527s left) gem_exec_schedule (deep) [497.990849] Starting subtest: deep [497.993670] Starting dynamic subtest: rcs0 [504.083215] Dynamic subtest rcs0: SKIP (6.087s) [504.102714] Starting dynamic subtest: vcs0 [514.297989] Dynamic subtest vcs0: SUCCESS (10.215s) [514.316937] Starting dynamic subtest: vcs1 [525.035244] Dynamic subtest vcs1: SUCCESS (10.734s) [525.049231] Starting dynamic subtest: vecs0 [535.942076] Dynamic subtest vecs0: SUCCESS (10.901s) [535.957840] Starting dynamic subtest: ccs0 [548.086933] Dynamic subtest ccs0: SUCCESS (12.141s) [548.090246] Subtest deep: SUCCESS (50.085s) [550.183802] [141/156] (475s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [550.284703] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [550.289201] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [550.393194] [142/156] (475s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [550.478271] Starting subtest: planes-downscale-factor-0-5-unity-scaling [550.480540] Starting dynamic subtest: pipe-A [550.499505] Dynamic subtest pipe-A: SKIP (0.017s) [550.510748] Starting dynamic subtest: pipe-B [550.529929] Dynamic subtest pipe-B: SKIP (0.031s) [550.542400] Starting dynamic subtest: pipe-C [550.563949] Dynamic subtest pipe-C: SKIP (0.032s) [550.574472] Starting dynamic subtest: pipe-D [550.594192] Dynamic subtest pipe-D: SKIP (0.030s) [550.597834] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s) [550.697118] [143/156] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [550.795170] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [550.799614] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [550.904335] [144/156] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [551.005937] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [551.010282] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [551.098193] [145/156] (474s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [551.183617] Starting subtest: bad-aux-stride-yf-tiled-ccs [551.185516] Starting dynamic subtest: pipe-A-eDP-1 [551.206016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [551.218757] Starting dynamic subtest: pipe-B-eDP-1 [551.236162] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [551.246112] Starting dynamic subtest: pipe-C-eDP-1 [551.263788] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [551.276202] Starting dynamic subtest: pipe-D-eDP-1 [551.295040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [551.298914] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s) [553.459993] [146/156] (472s left) gem_wait (await) [553.516429] Starting subtest: await [553.518771] Starting dynamic subtest: all-engines [554.623648] Dynamic subtest all-engines: SUCCESS (1.106s) [554.637368] Starting dynamic subtest: rcs0 [555.694148] Dynamic subtest rcs0: SUCCESS (1.069s) [555.711761] Starting dynamic subtest: bcs0 [556.758636] Dynamic subtest bcs0: SUCCESS (1.062s) [556.776459] Starting dynamic subtest: vcs0 [557.816659] Dynamic subtest vcs0: SUCCESS (1.055s) [557.833228] Starting dynamic subtest: vcs1 [558.874713] Dynamic subtest vcs1: SUCCESS (1.055s) [558.892426] Starting dynamic subtest: vecs0 [559.928314] Dynamic subtest vecs0: SUCCESS (1.051s) [559.946793] Starting dynamic subtest: ccs0 [560.986538] Dynamic subtest ccs0: SUCCESS (1.056s) [560.989043] Subtest await: SUCCESS (7.469s) [561.195209] [147/156] (464s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [561.246989] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [561.347324] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s) [561.429053] [148/156] (464s left) gem_exec_reloc (basic-wc-gtt) [561.486009] Subtest basic-wc-gtt: SKIP (0.000s) [561.553075] [149/156] (464s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [561.661665] Starting subtest: fbcpsrhdr-tiling-linear [561.665875] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [561.772933] [150/156] (464s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [561.877629] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [566.563498] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.688s) [566.666336] [151/156] (459s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [566.764151] Starting subtest: coverage-vs-premult-vs-constant [567.052969] Starting dynamic subtest: pipe-A-eDP-1 [567.655294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s) [567.669402] Starting dynamic subtest: pipe-D-eDP-1 [568.947875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s) [568.950168] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.185s) [569.757061] [152/156] (456s left) kms_psr (psr2-sprite-mmap-cpu) [569.853689] Starting subtest: psr2-sprite-mmap-cpu [569.856113] Starting dynamic subtest: eDP-1 [571.610937] Dynamic subtest eDP-1: SUCCESS (1.757s) [571.612867] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.757s) [572.477854] [153/156] (453s left) gem_mmap (big-bo) [572.531021] Subtest big-bo: SKIP (0.000s) [572.593369] [154/156] (453s left) i915_pm_freq_api (freq-suspend) [572.657485] Starting subtest: freq-suspend [572.659801] Starting dynamic subtest: gt0 [588.708567] Dynamic subtest gt0: SUCCESS (1.248s) [588.726047] Starting dynamic subtest: gt1 [604.719662] Dynamic subtest gt1: SUCCESS (1.237s) [604.722735] Subtest freq-suspend: SUCCESS (2.488s) [605.801318] [155/156] (421s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [605.909394] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [605.914061] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [606.006146] [156/156] (421s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [606.095288] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [606.099846] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [606.167888] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_fenced_exec_thrash results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_plane results: parsing output: 5/ for test: kms_legacy_colorkey results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: kms_plane_multiple results: parsing output: 10/ for test: kms_vblank results: parsing output: 11/ for test: api_intel_allocator results: parsing output: 12/ for test: perf_pmu results: parsing output: 13/ for test: kms_addfb_basic results: parsing output: 14/ for test: i915_pm_rpm results: parsing output: 15/ for test: core_setmaster results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_rotation_crc results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_getfb results: parsing output: 21/ for test: gem_ctx_shared results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: kms_hdr results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_ctx_param results: parsing output: 28/ for test: gem_mmap_gtt results: parsing output: 29/ for test: gem_softpin results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: gen9_exec_parse results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: gem_busy results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 36/ for test: gem_ctx_persistence results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_properties results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_vblank results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_exec_fence results: parsing output: 49/ for test: kms_cursor_crc results: parsing output: 50/ for test: kms_pipe_b_c_ivb results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: gem_flink_race results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_workarounds results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: gem_set_tiling_vs_gtt results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: i915_suspend results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_pwrite results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: vgem_basic results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: kms_invalid_mode results: parsing output: 78/ for test: sw_sync results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_exec_flush results: parsing output: 81/ for test: kms_force_connector_basic results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: gem_workarounds results: parsing output: 84/ for test: gem_readwrite results: parsing output: 85/ for test: gem_create results: parsing output: 86/ for test: gem_media_fill results: parsing output: 87/ for test: sw_sync results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_dp_link_training results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_content_protection results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_chamelium_hpd results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: prime_busy results: parsing output: 99/ for test: gem_exec_fence results: parsing output: 100/ for test: gem_exercise_blt results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_reloc results: parsing output: 108/ for test: kms_draw_crc results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_atomic results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_pxp results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_ctx_isolation results: parsing output: 121/ for test: tools_test results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_color_pipeline results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: sysfs_preempt_timeout results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_mmap_wc results: parsing output: 133/ for test: kms_flip_event_leak results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_chamelium_edid results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_exec_schedule results: parsing output: 139/ for test: gem_exec_schedule results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_plane_scaling results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_ccs results: parsing output: 145/ for test: gem_wait results: parsing output: 146/ for test: syncobj_timeline results: parsing output: 147/ for test: gem_exec_reloc results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_plane_alpha_blend results: parsing output: 151/ for test: kms_psr results: parsing output: 152/ for test: gem_mmap results: parsing output: 153/ for test: i915_pm_freq_api results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_flip_scaled_crc Done.