[58.469439] Initializing watchdogs [58.469482] /dev/watchdog0 [58.482589] [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] [58.487326] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.489469] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.492801] [001/133] (960s left) syncobj_basic (create-signaled) [58.575115] Starting subtest: create-signaled [58.577352] Subtest create-signaled: SUCCESS (0.000s) [58.715487] [002/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [58.813321] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [58.815523] Starting dynamic subtest: pipe-A-eDP-1 [58.837576] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [58.845500] Starting dynamic subtest: pipe-B-eDP-1 [58.867346] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [58.873965] Starting dynamic subtest: pipe-C-eDP-1 [58.895513] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [58.901960] Starting dynamic subtest: pipe-D-eDP-1 [58.923450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [58.927500] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s) [61.044885] [003/133] (958s left) api_intel_bb (simple-bb-ctx) [61.097147] Starting subtest: simple-bb-ctx [61.105485] Subtest simple-bb-ctx: SUCCESS (0.010s) [61.270037] [004/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [61.373707] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [61.378401] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [61.479532] [005/133] (957s left) gem_exec_suspend (basic-s3) [61.551806] Starting subtest: basic-S3 [61.553793] Starting dynamic subtest: smem [81.830167] Dynamic subtest smem: SUCCESS (6.337s) [81.832926] Subtest basic-S3: SUCCESS (6.339s) [82.024944] [006/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [82.176336] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [87.675819] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.553s) [88.806136] [007/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [88.902841] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [88.907072] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [89.036487] [008/133] (930s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [89.138670] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [93.215804] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.098s) [94.364397] [009/133] (924s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [94.426130] Starting subtest: etime-multi-wait-available-unsubmitted [94.530664] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [94.635729] [010/133] (924s left) kms_getfb (getfb-handle-closed) [94.737111] Starting subtest: getfb-handle-closed [94.739387] Subtest getfb-handle-closed: SUCCESS (0.000s) [94.854120] [011/133] (924s left) gem_softpin (full) [94.930651] Starting subtest: full [94.937841] Subtest full: SUCCESS (0.007s) [95.083867] [012/133] (924s left) kms_lease (lease-unleased-crtc) [95.171168] Starting subtest: lease-unleased-crtc [95.173489] Starting dynamic subtest: pipe-A-eDP-1 [95.458457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [95.468762] Starting dynamic subtest: pipe-B-eDP-1 [96.201811] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.743s) [96.211591] Starting dynamic subtest: pipe-C-eDP-1 [96.213874] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [96.221519] Starting dynamic subtest: pipe-D-eDP-1 [96.223728] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s) [96.225934] Subtest lease-unleased-crtc: SUCCESS (1.047s) [96.592172] [013/133] (922s left) gem_exec_fence (syncobj-repeat) [97.061972] Starting subtest: syncobj-repeat [97.236132] Subtest syncobj-repeat: SUCCESS (0.173s) [98.928272] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [98.931418] [014/133] (920s left) kms_cursor_crc (cursor-rapid-movement-32x10) [99.099049] Starting subtest: cursor-rapid-movement-32x10 [99.159809] Subtest cursor-rapid-movement-32x10: SKIP (0.053s) [99.462863] [015/133] (920s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [99.588324] Starting subtest: flip-vs-cursor-busy-crc-atomic [100.408417] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.820s) [101.229722] [016/133] (918s left) kms_psr (pr-sprite-mmap-cpu) [101.323376] Starting subtest: pr-sprite-mmap-cpu [101.327684] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [101.402608] [017/133] (918s left) kms_vblank (ts-continuation-modeset-rpm) [101.501200] Starting subtest: ts-continuation-modeset-rpm [101.503255] Starting dynamic subtest: pipe-A-eDP-1 [103.997813] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s) [104.012769] Starting dynamic subtest: pipe-D-eDP-1 [106.241539] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.242s) [106.243455] Subtest ts-continuation-modeset-rpm: SUCCESS (4.745s) [107.050162] [018/133] (912s left) kms_cursor_crc (cursor-onscreen-64x64) [107.235170] Starting subtest: cursor-onscreen-64x64 [107.241855] Starting dynamic subtest: pipe-A-eDP-1 [109.362894] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s) [109.390663] Starting dynamic subtest: pipe-D-eDP-1 [112.121576] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.738s) [112.124050] Subtest cursor-onscreen-64x64: SUCCESS (4.888s) [112.927586] [019/133] (906s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [113.022997] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [113.027505] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [113.129856] [020/133] (906s left) api_intel_allocator (simple-allocator) [113.190076] Starting subtest: simple-allocator [113.192419] Starting dynamic subtest: basic [113.194347] Dynamic subtest basic: SUCCESS (0.003s) [113.204473] Starting dynamic subtest: parallel-one [113.390017] Dynamic subtest parallel-one: SUCCESS (0.197s) [113.398546] Starting dynamic subtest: print [113.400453] Dynamic subtest print: SUCCESS (0.000s) [113.408949] Starting dynamic subtest: reuse [113.411266] Dynamic subtest reuse: SUCCESS (0.000s) [113.418689] Starting dynamic subtest: reserve [113.420878] Dynamic subtest reserve: SUCCESS (0.000s) [113.428411] Starting dynamic subtest: fork-reopen-allocator [113.430617] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [113.432817] Subtest simple-allocator: SUCCESS (0.218s) [113.545566] [021/133] (906s left) gem_exec_schedule (lateslice) [113.619007] Starting subtest: lateslice [113.621306] Starting dynamic subtest: rcs0 [113.631017] Dynamic subtest rcs0: SUCCESS (0.022s) [113.639016] Starting dynamic subtest: bcs0 [113.648749] Dynamic subtest bcs0: SUCCESS (0.018s) [113.656388] Starting dynamic subtest: vcs0 [113.666569] Dynamic subtest vcs0: SUCCESS (0.017s) [113.673992] Starting dynamic subtest: vcs1 [113.684565] Dynamic subtest vcs1: SUCCESS (0.018s) [113.692438] Starting dynamic subtest: vecs0 [113.702673] Dynamic subtest vecs0: SUCCESS (0.018s) [113.710286] Starting dynamic subtest: ccs0 [113.719964] Dynamic subtest ccs0: SUCCESS (0.017s) [113.722275] Subtest lateslice: SUCCESS (0.112s) [114.965285] [022/133] (904s left) gem_exec_reloc (basic-gtt-cpu) [115.033625] Subtest basic-gtt-cpu: SKIP (0.000s) [115.103452] [023/133] (904s left) gem_userptr_blits (forbidden-operations) [115.176462] Starting subtest: forbidden-operations [115.180881] Subtest forbidden-operations: SKIP (0.000s) [115.304437] [024/133] (904s left) kms_flip (dpms-vs-vblank-race) [115.402674] Starting subtest: dpms-vs-vblank-race [115.405069] Starting dynamic subtest: A-eDP1 [119.381299] Dynamic subtest A-eDP1: SUCCESS (3.977s) [119.391963] Starting dynamic subtest: B-eDP1 [122.973781] Dynamic subtest B-eDP1: SUCCESS (3.593s) [122.984180] Starting dynamic subtest: C-eDP1 [126.483999] Dynamic subtest C-eDP1: SUCCESS (3.509s) [126.497733] Starting dynamic subtest: D-eDP1 [131.110681] Dynamic subtest D-eDP1: SUCCESS (4.625s) [131.112597] Subtest dpms-vs-vblank-race: SUCCESS (15.710s) [132.001021] [025/133] (887s left) gem_exec_params (secure-non-master) [132.061329] Starting subtest: secure-non-master [132.065805] Subtest secure-non-master: SKIP (0.000s) [132.167132] [026/133] (887s left) kms_big_fb (4-tiled-64bpp-rotate-270) [132.274550] Starting subtest: 4-tiled-64bpp-rotate-270 [132.295117] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s) [132.453499] [027/133] (887s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [132.558334] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [132.560590] Starting dynamic subtest: pipe-A-default-mode [132.845003] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [132.849633] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.286s) [133.728247] [028/133] (886s left) gem_exec_schedule (u-fairslice) [133.798651] Starting subtest: u-fairslice [133.800850] Starting dynamic subtest: rcs0 [135.813535] Dynamic subtest rcs0: SUCCESS (2.020s) [135.823591] Starting dynamic subtest: bcs0 [137.834346] Dynamic subtest bcs0: SUCCESS (2.021s) [137.853356] Starting dynamic subtest: vcs0 [139.867093] Dynamic subtest vcs0: SUCCESS (2.033s) [139.875819] Starting dynamic subtest: vcs1 [141.897208] Dynamic subtest vcs1: SUCCESS (2.029s) [141.906913] Starting dynamic subtest: vecs0 [143.927212] Dynamic subtest vecs0: SUCCESS (2.031s) [143.937381] Starting dynamic subtest: ccs0 [145.957293] Dynamic subtest ccs0: SUCCESS (2.030s) [145.959552] Subtest u-fairslice: SUCCESS (12.169s) [146.284395] [029/133] (873s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [146.380031] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [146.406072] Starting dynamic subtest: pipe-A-plane-0 [146.410423] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [146.420898] Starting dynamic subtest: pipe-A-plane-3 [146.425919] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [146.435247] Starting dynamic subtest: pipe-A-plane-5 [146.439842] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [147.492656] Starting dynamic subtest: pipe-B-plane-0 [147.496713] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [147.504267] Starting dynamic subtest: pipe-B-plane-3 [147.508907] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [147.516434] Starting dynamic subtest: pipe-B-plane-5 [147.521200] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [147.803696] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (1.422s) [148.693091] [030/133] (871s left) kms_flip (flip-vs-blocking-wf-vblank) [148.797971] Starting subtest: flip-vs-blocking-wf-vblank [148.800370] Starting dynamic subtest: A-eDP1 [157.701317] Dynamic subtest A-eDP1: SUCCESS (8.906s) [157.710941] Starting dynamic subtest: B-eDP1 [166.637307] Dynamic subtest B-eDP1: SUCCESS (8.937s) [166.647068] Starting dynamic subtest: C-eDP1 [175.553135] Dynamic subtest C-eDP1: SUCCESS (8.918s) [175.563256] Starting dynamic subtest: D-eDP1 [184.501991] Dynamic subtest D-eDP1: SUCCESS (8.941s) [184.504264] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.712s) [185.755983] [031/133] (834s left) syncobj_timeline (wait-any-snapshot) [185.814908] Starting subtest: wait-any-snapshot [185.894958] Subtest wait-any-snapshot: SUCCESS (0.081s) [185.993197] [032/133] (834s left) gem_exec_reloc (basic-write-gtt-active) [186.051004] Subtest basic-write-gtt-active: SKIP (0.000s) [186.139371] [033/133] (834s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [191.215609] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [191.217927] Starting dynamic subtest: pipe-A-eDP-1 [192.017124] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s) [192.026287] Starting dynamic subtest: pipe-B-eDP-1 [193.153971] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s) [193.158401] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.937s) [194.360700] [034/133] (825s left) gem_exec_reloc (basic-wc-active) [194.434100] Subtest basic-wc-active: SKIP (0.000s) [194.504547] [035/133] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [194.596529] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [202.991692] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.396s) [203.127330] [036/133] (817s left) gem_mmap_wc (close) [203.187839] Subtest close: SKIP (0.000s) [203.246423] [037/133] (817s left) kms_pm_rpm (legacy-planes-dpms) [205.069294] Starting subtest: legacy-planes-dpms [205.071948] Starting dynamic subtest: plane-64 [213.370334] Dynamic subtest plane-64: SUCCESS (8.305s) [213.381041] Starting dynamic subtest: plane-94 [222.120475] Dynamic subtest plane-94: SUCCESS (8.748s) [222.131552] Starting dynamic subtest: plane-124 [230.506603] Dynamic subtest plane-124: SUCCESS (8.385s) [230.517543] Starting dynamic subtest: plane-134 [239.107900] Dynamic subtest plane-134: SUCCESS (8.600s) [239.110474] Subtest legacy-planes-dpms: SUCCESS (34.047s) [239.503038] [038/133] (780s left) i915_query (query-regions-garbage-items) [239.556877] Starting subtest: query-regions-garbage-items [239.558898] Subtest query-regions-garbage-items: SUCCESS (0.000s) [239.674546] [039/133] (780s left) dmabuf_sync_file (export-before-signal) [239.716558] Starting subtest: export-before-signal [239.718543] Subtest export-before-signal: SUCCESS (0.001s) [239.786652] [040/133] (780s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [239.885982] Starting subtest: fbcpsr-indfb-scaledprimary [245.664751] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.783s) [245.813443] [041/133] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [245.912529] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [245.916802] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [246.032082] [042/133] (774s left) kms_invalid_mode (zero-clock) [246.117628] Starting subtest: zero-clock [246.119780] Starting dynamic subtest: pipe-A-eDP-1 [246.402018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [246.411144] Starting dynamic subtest: pipe-B-eDP-1 [246.413047] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [246.420791] Starting dynamic subtest: pipe-C-eDP-1 [246.422714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [246.430694] Starting dynamic subtest: pipe-D-eDP-1 [246.432861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [246.434984] Subtest zero-clock: SUCCESS (0.289s) [247.241481] [043/133] (773s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [247.629062] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [248.426565] [044/133] (772s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [248.545563] Starting subtest: cursorB-vs-flipB-toggle [248.549981] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [248.714656] [045/133] (772s left) syncobj_basic (bad-handle-to-fd) [248.770808] Starting subtest: bad-handle-to-fd [248.772757] Subtest bad-handle-to-fd: SUCCESS (0.000s) [248.912312] [046/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [249.016988] Starting subtest: psr-2p-scndscrn-spr-indfb-move [249.021321] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [249.145290] [047/133] (771s left) kms_plane_cursor (overlay) [249.250594] Starting subtest: overlay [249.255041] Starting dynamic subtest: pipe-A-eDP-1-size-64 [251.756311] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.507s) [251.814997] Starting dynamic subtest: pipe-A-eDP-1-size-128 [254.312015] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.504s) [254.371297] Starting dynamic subtest: pipe-A-eDP-1-size-256 [256.833975] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s) [257.185017] Starting dynamic subtest: pipe-B-eDP-1-size-64 [260.341262] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.168s) [260.399202] Starting dynamic subtest: pipe-B-eDP-1-size-128 [262.887288] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.494s) [262.945910] Starting dynamic subtest: pipe-B-eDP-1-size-256 [265.430806] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s) [265.779730] Starting dynamic subtest: pipe-C-eDP-1-size-64 [268.618126] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.850s) [268.655358] Starting dynamic subtest: pipe-C-eDP-1-size-128 [270.751341] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.102s) [270.788602] Starting dynamic subtest: pipe-C-eDP-1-size-256 [272.906919] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s) [273.234413] Starting dynamic subtest: pipe-D-eDP-1-size-64 [276.062072] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.840s) [276.100200] Starting dynamic subtest: pipe-D-eDP-1-size-128 [278.195541] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s) [278.233053] Starting dynamic subtest: pipe-D-eDP-1-size-256 [280.373067] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s) [280.693008] Subtest overlay: SUCCESS (31.451s) [281.576793] [048/133] (739s left) kms_3d (basic) [281.635746] Starting subtest: basic [283.595813] Subtest basic: SUCCESS (1.963s) [284.127971] [049/133] (736s left) gem_mmap_wc (bad-object) [284.179994] Subtest bad-object: SKIP (0.000s) [284.236201] [050/133] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [284.334858] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [284.339290] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [284.438307] [051/133] (736s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [284.529398] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [284.531633] Starting dynamic subtest: pipe-A-eDP-1 [301.210886] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.414s) [301.220414] Starting dynamic subtest: pipe-B-eDP-1 [318.226517] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.431s) [318.234903] Starting dynamic subtest: pipe-C-eDP-1 [335.142423] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s) [335.152262] Starting dynamic subtest: pipe-D-eDP-1 [352.171709] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s) [352.173865] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.680s) [353.345593] [052/133] (667s left) kms_addfb_basic (too-high) [353.448495] Starting subtest: too-high [353.450925] Subtest too-high: SUCCESS (0.000s) [353.570824] [053/133] (667s left) perf_pmu (busy-idle) [353.612753] Starting subtest: busy-idle [353.615340] Starting dynamic subtest: rcs0 [354.322780] Dynamic subtest rcs0: SUCCESS (0.720s) [354.334802] Starting dynamic subtest: bcs0 [355.045253] Dynamic subtest bcs0: FAIL (0.668s) [355.053767] Starting dynamic subtest: vcs0 [355.717956] Dynamic subtest vcs0: FAIL (0.661s) [355.727472] Starting dynamic subtest: vcs1 [357.641387] Dynamic subtest vcs1: FAIL (1.936s) [357.650653] Starting dynamic subtest: vecs0 [359.628404] Dynamic subtest vecs0: FAIL (1.997s) [359.637779] Starting dynamic subtest: ccs0 [361.613729] Dynamic subtest ccs0: FAIL (1.995s) [361.616063] Subtest busy-idle: FAIL (7.983s) [361.657317] [054/133] (659s left) i915_drm_fdinfo (memory-info-resident) [361.707040] Starting subtest: memory-info-resident [361.709755] Starting dynamic subtest: smem0 [364.472485] Dynamic subtest smem0: SUCCESS (2.778s) [364.475538] Subtest memory-info-resident: SUCCESS (2.779s) [364.559507] [055/133] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [364.677785] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [364.681920] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [364.799622] [056/133] (656s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [364.920807] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [366.047994] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.130s) [366.208026] [057/133] (655s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [366.306694] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [366.309100] Starting dynamic subtest: pipe-A-eDP-1 [366.333765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [366.342367] Starting dynamic subtest: pipe-B-eDP-1 [366.363959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [366.372169] Starting dynamic subtest: pipe-C-eDP-1 [366.393118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [366.401067] Starting dynamic subtest: pipe-D-eDP-1 [366.423177] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [366.427516] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [368.530575] [058/133] (652s left) kms_psr (fbc-psr-sprite-blt) [368.627356] Starting subtest: fbc-psr-sprite-blt [368.629986] Starting dynamic subtest: eDP-1 [368.634769] Dynamic subtest eDP-1: SKIP (0.000s) [368.639232] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [368.741782] [059/133] (652s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [368.837562] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [368.863408] Starting dynamic subtest: pipe-A-plane-0 [369.284799] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [369.295555] Starting dynamic subtest: pipe-A-plane-3 [369.539307] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [369.547668] Starting dynamic subtest: pipe-A-plane-5 [369.551427] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [370.676323] Starting dynamic subtest: pipe-B-plane-0 [371.113112] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s) [371.121481] Starting dynamic subtest: pipe-B-plane-3 [371.389940] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s) [371.398424] Starting dynamic subtest: pipe-B-plane-5 [371.402839] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [371.712950] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.880s) [372.525873] [060/133] (648s left) gem_exec_schedule (deep) [372.707034] Starting subtest: deep [372.709673] Starting dynamic subtest: rcs0 [377.815500] Dynamic subtest rcs0: SKIP (5.110s) [377.827579] Starting dynamic subtest: vcs0 [388.311269] Dynamic subtest vcs0: SUCCESS (10.497s) [388.325560] Starting dynamic subtest: vcs1 [399.319935] Dynamic subtest vcs1: SUCCESS (11.002s) [399.333816] Starting dynamic subtest: vecs0 [410.485050] Dynamic subtest vecs0: SUCCESS (11.165s) [410.495304] Starting dynamic subtest: ccs0 [422.796849] Dynamic subtest ccs0: SUCCESS (12.313s) [422.799731] Subtest deep: SUCCESS (50.093s) [423.752068] [061/133] (597s left) kms_addfb_basic (invalid-set-prop) [423.809890] Starting subtest: invalid-set-prop [423.812614] Subtest invalid-set-prop: SUCCESS (0.000s) [423.982405] [062/133] (597s left) kms_cursor_crc (cursor-sliding-max-size) [424.286208] Starting subtest: cursor-sliding-max-size [424.293995] Subtest cursor-sliding-max-size: SKIP (0.000s) [424.417620] [063/133] (597s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [424.512900] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [424.515455] Starting dynamic subtest: pipe-A-eDP-1 [424.995792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s) [425.004545] Starting dynamic subtest: pipe-B-eDP-1 [426.427415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s) [426.438353] Starting dynamic subtest: pipe-C-eDP-1 [427.751906] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s) [427.762179] Starting dynamic subtest: pipe-D-eDP-1 [429.183922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s) [429.186596] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.641s) [430.417131] [064/133] (591s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [430.512228] Starting subtest: primary-yf-tiled-reflect-x-90 [430.518025] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [430.644913] [065/133] (590s left) kms_big_fb (y-tiled-16bpp-rotate-0) [430.753960] Starting subtest: y-tiled-16bpp-rotate-0 [430.759781] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [430.878383] [066/133] (590s left) gem_lmem_swapping (heavy-verify-random-ccs) [430.921211] Subtest heavy-verify-random-ccs: SKIP (0.000s) [430.965534] [067/133] (590s left) kms_async_flips (test-cursor) [431.070461] Starting subtest: test-cursor [431.075794] Subtest test-cursor: SKIP (0.000s) [432.326765] [068/133] (589s left) gem_eio (create) [432.548187] Starting subtest: create [432.874747] Subtest create: SUCCESS (0.328s) [433.031780] [069/133] (588s left) gem_watchdog (default-virtual) [433.103531] Starting subtest: default-virtual [439.378094] Subtest default-virtual: SUCCESS (6.286s) [439.491337] [070/133] (582s left) gem_ccs (block-copy-uncompressed) [439.541947] Starting subtest: block-copy-uncompressed [439.544916] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [439.574139] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.031s) [439.584413] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [439.596008] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s) [439.605187] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [439.614972] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [439.624211] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [439.633577] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [439.635929] Subtest block-copy-uncompressed: SUCCESS (0.093s) [439.846415] [071/133] (582s left) gem_exec_balancer (full) [439.927898] Starting subtest: full [444.728818] Subtest full: SUCCESS (4.803s) [445.073545] [072/133] (576s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [445.186063] Starting subtest: fbc-psr2-cursor-mmap-cpu [445.188489] Starting dynamic subtest: eDP-1 [445.193204] Dynamic subtest eDP-1: SKIP (0.000s) [445.198085] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [445.272180] [073/133] (576s left) gem_mmap_gtt (basic-small-copy-odd) [445.336001] Subtest basic-small-copy-odd: SKIP (0.000s) [445.426538] [074/133] (576s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite) [445.524096] Starting subtest: fbc-abgr161616f-draw-pwrite [445.528784] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s) [445.626916] [075/133] (576s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [445.734434] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [445.744857] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s) [445.854770] [076/133] (576s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [445.919568] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [445.924461] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [446.114259] [077/133] (576s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x) [446.216229] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x [446.219049] Starting dynamic subtest: pipe-A-default-mode [447.335594] Dynamic subtest pipe-A-default-mode: SKIP (1.116s) [447.340506] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (1.117s) [447.526578] [078/133] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [447.635001] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [451.338206] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.706s) [452.529286] [079/133] (569s left) gem_partial_pwrite_pread (write-snoop) [452.603002] Subtest write-snoop: SKIP (0.000s) [452.705815] [080/133] (569s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [452.800933] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [452.803359] Starting dynamic subtest: pipe-A-eDP-1 [453.526904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s) [453.536722] Starting dynamic subtest: pipe-B-eDP-1 [455.277180] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.748s) [455.287636] Starting dynamic subtest: pipe-C-eDP-1 [457.088205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.809s) [457.098761] Starting dynamic subtest: pipe-D-eDP-1 [458.872348] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.783s) [458.875029] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.063s) [460.113325] [081/133] (562s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [465.096911] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [465.099203] Starting dynamic subtest: pipe-A-eDP-1 [465.843477] Dynamic subtest pipe-A-eDP-1: SKIP (0.744s) [465.853300] Starting dynamic subtest: pipe-B-eDP-1 [467.045670] Dynamic subtest pipe-B-eDP-1: SKIP (1.201s) [467.050373] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.950s) [468.307376] [082/133] (554s left) prime_vgem (basic-read) [468.395377] Starting subtest: basic-read [468.442317] Subtest basic-read: SKIP (0.043s) [468.592549] [083/133] (553s left) gem_exec_parallel (basic) [468.652806] Starting subtest: basic [468.655358] Starting dynamic subtest: rcs0 [470.337813] Dynamic subtest rcs0: SUCCESS (1.687s) [470.347238] Starting dynamic subtest: bcs0 [472.052229] Dynamic subtest bcs0: SUCCESS (1.714s) [472.064025] Starting dynamic subtest: vcs0 [473.944870] Dynamic subtest vcs0: SUCCESS (1.890s) [473.957211] Starting dynamic subtest: vcs1 [475.916917] Dynamic subtest vcs1: SUCCESS (1.970s) [475.927362] Starting dynamic subtest: vecs0 [477.919948] Dynamic subtest vecs0: SUCCESS (1.999s) [477.932233] Starting dynamic subtest: ccs0 [479.742963] Dynamic subtest ccs0: SUCCESS (1.822s) [479.746049] Subtest basic: SUCCESS (11.093s) [479.955631] [084/133] (542s left) syncobj_timeline (multi-wait-available-submitted-signaled) [480.028907] Starting subtest: multi-wait-available-submitted-signaled [480.031653] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [480.160369] [085/133] (542s left) kms_dp_linktrain_fallback (dp-fallback) [480.262571] Starting subtest: dp-fallback [480.270039] Subtest dp-fallback: SKIP (0.000s) [480.346299] [086/133] (542s left) kms_atomic_interruptible (universal-setplane-cursor) [480.443583] Starting subtest: universal-setplane-cursor [480.445982] Starting dynamic subtest: pipe-A-eDP-1 [487.886109] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.441s) [487.888992] Subtest universal-setplane-cursor: SUCCESS (7.442s) [488.705699] [087/133] (533s left) kms_feature_discovery (display-2x) [488.797872] Starting subtest: display-2x [488.802788] Subtest display-2x: SKIP (0.000s) [488.882819] [088/133] (533s left) vgem_basic (dmabuf-mmap) [488.934016] Starting subtest: dmabuf-mmap [488.981585] Subtest dmabuf-mmap: SUCCESS (0.048s) [489.067032] [089/133] (533s left) gem_exec_create (legacy) [489.115364] Starting subtest: legacy [489.118030] Starting dynamic subtest: smem [491.201895] Dynamic subtest smem: SUCCESS (2.086s) [491.204953] Subtest legacy: SUCCESS (2.087s) [491.398684] [090/133] (531s left) kms_pm_rpm (modeset-stress-extra-wait) [493.135519] Starting subtest: modeset-stress-extra-wait [547.418210] Subtest modeset-stress-extra-wait: SUCCESS (54.295s) [547.524841] [091/133] (475s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [547.626682] Starting subtest: yf-tiled-16bpp-rotate-270 [547.632049] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [547.737532] [092/133] (475s left) kms_psr (psr2-primary-mmap-gtt) [547.839321] Starting subtest: psr2-primary-mmap-gtt [547.841589] Starting dynamic subtest: eDP-1 [549.239850] Dynamic subtest eDP-1: SKIP (1.395s) [549.245436] Subtest psr2-primary-mmap-gtt: SKIP (1.397s) [549.391556] [093/133] (473s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render) [549.490869] Starting subtest: fbcpsr-abgr161616f-draw-render [549.496036] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s) [549.604392] [094/133] (473s left) syncobj_timeline (invalid-transfer-non-existent-point) [549.659226] Starting subtest: invalid-transfer-non-existent-point [549.662023] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [549.777761] [095/133] (473s left) gen9_exec_parse (bb-start-out) [549.829113] Subtest bb-start-out: SKIP (0.000s) [549.916073] [096/133] (473s left) kms_sequence (queue-idle) [550.006953] Starting subtest: queue-idle [550.009541] Starting dynamic subtest: pipe-A-eDP-1 [551.810228] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [551.820881] Starting dynamic subtest: pipe-B-eDP-1 [554.312123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.502s) [554.321796] Starting dynamic subtest: pipe-C-eDP-1 [556.783371] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.471s) [556.794591] Starting dynamic subtest: pipe-D-eDP-1 [559.221357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s) [559.224245] Subtest queue-idle: SUCCESS (9.218s) [560.086973] [097/133] (462s left) gem_mmap_offset (open-flood) [560.148122] Starting subtest: open-flood [581.638582] Subtest open-flood: SUCCESS (21.494s) [581.769332] [098/133] (441s left) gem_flink_basic (double-flink) [581.828036] Starting subtest: double-flink [581.830187] Subtest double-flink: SUCCESS (0.000s) [581.955923] [099/133] (441s left) kms_cursor_legacy (cursor-vs-flip-atomic) [582.069919] Starting subtest: cursor-vs-flip-atomic [611.411006] Subtest cursor-vs-flip-atomic: SUCCESS (29.333s) [612.284481] [100/133] (410s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [612.384978] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [612.390126] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [612.498045] [101/133] (410s left) gem_mmap_wc (write-read) [612.561327] Subtest write-read: SKIP (0.000s) [612.632365] [102/133] (410s left) perf_pmu (rc6-all-gts) [612.674005] Starting subtest: rc6-all-gts [619.056378] Subtest rc6-all-gts: SUCCESS (6.383s) [620.076952] [103/133] (403s left) i915_pm_rps (min-max-config-loaded) [620.127965] Starting subtest: min-max-config-loaded [620.132524] Subtest min-max-config-loaded: SKIP (0.001s) [620.268525] [104/133] (403s left) gem_ctx_persistence (process) [620.330098] Starting subtest: process [620.588093] Subtest process: SUCCESS (0.258s) [620.679858] [105/133] (402s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [620.742628] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [620.744718] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [620.869593] [106/133] (402s left) gem_create (create-ext-cpu-access-big) [621.048268] Starting subtest: create-ext-cpu-access-big [621.053353] Subtest create-ext-cpu-access-big: SKIP (0.001s) [621.154372] [107/133] (402s left) kms_content_protection (uevent) [621.306067] Starting subtest: uevent [621.311964] Subtest uevent: SKIP (0.000s) [621.461467] [108/133] (402s left) kms_hdr (static-swap) [621.559938] Starting subtest: static-swap [621.567891] Subtest static-swap: SKIP (0.000s) [621.648792] [109/133] (401s left) gem_exec_flush (basic-batch-kernel-default-wb) [621.726227] Starting subtest: basic-batch-kernel-default-wb [629.323963] Subtest basic-batch-kernel-default-wb: SUCCESS (7.599s) [629.530598] [110/133] (394s left) syncobj_wait (invalid-reset-one-illegal-handle) [629.592440] Starting subtest: invalid-reset-one-illegal-handle [629.595454] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [629.730121] [111/133] (393s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [629.836853] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [629.841817] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [629.961761] [112/133] (393s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [630.068368] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [630.073342] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [630.187603] [113/133] (393s left) syncobj_wait (multi-wait-submitted-signaled) [630.248747] Starting subtest: multi-wait-submitted-signaled [630.251477] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [630.384405] [114/133] (393s left) kms_big_fb (linear-32bpp-rotate-0) [630.485934] Starting subtest: linear-32bpp-rotate-0 [631.966018] Subtest linear-32bpp-rotate-0: SUCCESS (1.481s) [632.128961] [115/133] (391s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [632.217554] Starting subtest: plane-scaler-unity-scaling-with-rotation [632.219558] Starting dynamic subtest: pipe-A [632.443073] Dynamic subtest pipe-A: SUCCESS (0.228s) [632.451631] Starting dynamic subtest: pipe-B [633.733964] Dynamic subtest pipe-B: SUCCESS (1.290s) [633.743975] Starting dynamic subtest: pipe-C [635.027213] Dynamic subtest pipe-C: SUCCESS (1.292s) [635.036420] Starting dynamic subtest: pipe-D [636.319081] Dynamic subtest pipe-D: SUCCESS (1.291s) [636.321991] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.104s) [637.482395] [116/133] (386s left) syncobj_eventfd (binary-wait-signaled) [637.533716] Starting subtest: binary-wait-signaled [637.536781] Subtest binary-wait-signaled: SUCCESS (0.000s) [637.651790] [117/133] (386s left) gem_mmap_gtt (cpuset-basic-small-copy) [637.719980] Subtest cpuset-basic-small-copy: SKIP (0.000s) [637.784103] [118/133] (386s left) kms_color (ctm-green-to-red) [637.881930] Starting subtest: ctm-green-to-red [637.884581] Starting dynamic subtest: pipe-A-eDP-1 [638.585002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [638.594990] Starting dynamic subtest: pipe-B-eDP-1 [639.955900] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s) [639.964826] Starting dynamic subtest: pipe-C-eDP-1 [641.273860] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s) [641.283828] Starting dynamic subtest: pipe-D-eDP-1 [642.573043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [642.576022] Subtest ctm-green-to-red: SUCCESS (4.692s) [643.410567] [119/133] (380s left) kms_flip (flip-vs-rmfb) [643.511342] Starting subtest: flip-vs-rmfb [643.514053] Starting dynamic subtest: A-eDP1 [652.226364] Dynamic subtest A-eDP1: SUCCESS (8.714s) [652.236845] Starting dynamic subtest: B-eDP1 [660.928659] Dynamic subtest B-eDP1: SUCCESS (8.702s) [660.938566] Starting dynamic subtest: C-eDP1 [669.645034] Dynamic subtest C-eDP1: SUCCESS (8.716s) [669.656587] Starting dynamic subtest: D-eDP1 [678.340197] Dynamic subtest D-eDP1: SUCCESS (8.694s) [678.342819] Subtest flip-vs-rmfb: SUCCESS (34.834s) [679.613033] [120/133] (344s left) kms_draw_crc (fill-fb) [679.715241] Starting subtest: fill-fb [680.132654] Subtest fill-fb: SUCCESS (0.419s) [680.256704] [121/133] (343s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [680.378049] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [687.499946] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.126s) [687.634206] [122/133] (336s left) gem_exec_whisper (basic-contexts) [687.692954] Starting subtest: basic-contexts [694.399849] Subtest basic-contexts: SUCCESS (6.704s) [694.592534] [123/133] (329s left) gem_render_copy (yf-tiled) [694.680180] Starting subtest: yf-tiled [694.686048] Subtest yf-tiled: SKIP (0.000s) [694.895758] [124/133] (329s left) kms_psr (fbc-pr-primary-blt) [695.009031] Starting subtest: fbc-pr-primary-blt [695.014355] Subtest fbc-pr-primary-blt: SKIP (0.000s) [695.107390] [125/133] (329s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [695.209253] Starting subtest: plane-upscale-20x20-with-pixel-format [695.211972] Starting dynamic subtest: pipe-A [696.255805] Dynamic subtest pipe-A: SUCCESS (1.050s) [696.266089] Starting dynamic subtest: pipe-B [698.340822] Dynamic subtest pipe-B: SUCCESS (2.084s) [698.352341] Starting dynamic subtest: pipe-C [699.496107] Dynamic subtest pipe-C: SUCCESS (1.154s) [699.508236] Starting dynamic subtest: pipe-D [700.696208] Dynamic subtest pipe-D: SUCCESS (1.199s) [700.699184] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.491s) [701.873499] [126/133] (322s left) syncobj_basic (bad-flags-handle-to-fd) [701.938130] Starting subtest: bad-flags-handle-to-fd [701.940897] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [702.051511] [127/133] (322s left) kms_chamelium_frames (dp-frame-dump) [702.434416] Subtest dp-frame-dump: SKIP (0.000s) [703.291317] [128/133] (321s left) perf_pmu (interrupts) [703.342462] Starting subtest: interrupts [704.453000] Subtest interrupts: SUCCESS (1.113s) [704.588911] [129/133] (319s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [704.688832] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [704.691208] Starting dynamic subtest: pipe-A-eDP-1 [704.715018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [704.726477] Starting dynamic subtest: pipe-B-eDP-1 [704.750059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [704.758872] Starting dynamic subtest: pipe-C-eDP-1 [704.782216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [704.793191] Starting dynamic subtest: pipe-D-eDP-1 [704.816212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [704.818629] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [706.966567] [130/133] (317s left) gem_ctx_param (invalid-get-engines) [707.019598] Starting subtest: invalid-get-engines [707.022114] Subtest invalid-get-engines: SUCCESS (0.001s) [707.140810] [131/133] (317s left) i915_module_load (reload) [707.173806] Starting subtest: reload [712.789625] Subtest reload: SUCCESS (5.616s) [712.836358] [132/133] (311s left) kms_psr (psr-sprite-mmap-gtt) [713.946673] Starting subtest: psr-sprite-mmap-gtt [713.948928] Starting dynamic subtest: eDP-1 [715.376014] Dynamic subtest eDP-1: SKIP (1.427s) [715.381813] Subtest psr-sprite-mmap-gtt: SKIP (1.429s) [715.576858] [133/133] (309s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [715.689664] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [715.694579] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [715.811305] Closing watchdogs results: parsing output: 0/ for test: syncobj_basic results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: api_intel_bb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_suspend results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: gem_softpin results: parsing output: 11/ for test: kms_lease results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: api_intel_allocator results: parsing output: 20/ for test: gem_exec_schedule results: parsing output: 21/ for test: gem_exec_reloc results: parsing output: 22/ for test: gem_userptr_blits results: parsing output: 23/ for test: kms_flip results: parsing output: 24/ for test: gem_exec_params results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_flip_scaled_crc results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_mmap_wc results: parsing output: 36/ for test: kms_pm_rpm results: parsing output: 37/ for test: i915_query results: parsing output: 38/ for test: dmabuf_sync_file results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_invalid_mode results: parsing output: 42/ for test: kms_chamelium_hpd results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: syncobj_basic results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_plane_cursor results: parsing output: 47/ for test: kms_3d results: parsing output: 48/ for test: gem_mmap_wc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: kms_addfb_basic results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: i915_drm_fdinfo results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_plane results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_rotation_crc results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: gem_lmem_swapping results: parsing output: 66/ for test: kms_async_flips results: parsing output: 67/ for test: gem_eio results: parsing output: 68/ for test: gem_watchdog results: parsing output: 69/ for test: gem_ccs results: parsing output: 70/ for test: gem_exec_balancer results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: kms_flip_scaled_crc results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_partial_pwrite_pread results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_psr2_sf results: parsing output: 81/ for test: prime_vgem results: parsing output: 82/ for test: gem_exec_parallel results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_dp_linktrain_fallback results: parsing output: 85/ for test: kms_atomic_interruptible results: parsing output: 86/ for test: kms_feature_discovery results: parsing output: 87/ for test: vgem_basic results: parsing output: 88/ for test: gem_exec_create results: parsing output: 89/ for test: kms_pm_rpm results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: gen9_exec_parse results: parsing output: 95/ for test: kms_sequence results: parsing output: 96/ for test: gem_mmap_offset results: parsing output: 97/ for test: gem_flink_basic results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_mmap_wc results: parsing output: 101/ for test: perf_pmu results: parsing output: 102/ for test: i915_pm_rps results: parsing output: 103/ for test: gem_ctx_persistence results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: gem_create results: parsing output: 106/ for test: kms_content_protection results: parsing output: 107/ for test: kms_hdr results: parsing output: 108/ for test: gem_exec_flush results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: syncobj_wait results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_plane_scaling results: parsing output: 115/ for test: syncobj_eventfd results: parsing output: 116/ for test: gem_mmap_gtt results: parsing output: 117/ for test: kms_color results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_draw_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_exec_whisper results: parsing output: 122/ for test: gem_render_copy results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_plane_scaling results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: kms_chamelium_frames results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: gem_ctx_param results: parsing output: 130/ for test: i915_module_load results: parsing output: 131/ for test: kms_psr results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.