[60.705892] Initializing watchdogs [60.705939] /dev/watchdog0 [60.721397] [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] [60.726041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.728539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.731986] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [60.853704] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [60.857764] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [60.970589] [002/155] (960s left) kms_rotation_crc (sprite-rotation-90) [61.066223] Starting subtest: sprite-rotation-90 [61.070363] Subtest sprite-rotation-90: SKIP (0.001s) [61.149702] [003/155] (960s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [61.537229] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [62.387201] [004/155] (958s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen) [62.486205] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen [62.490320] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [62.587021] [005/155] (958s left) kms_mmap_write_crc (main) [62.686746] Starting subtest: main [62.689152] Starting dynamic subtest: pipe-A-eDP-1 [66.272561] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.594s) [66.274515] Subtest main: SUCCESS (3.595s) [67.131547] [006/155] (954s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [67.239059] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [74.026639] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.801s) [74.149143] [007/155] (947s left) kms_cursor_crc (cursor-random-512x170) [74.434381] Starting subtest: cursor-random-512x170 [74.438036] Subtest cursor-random-512x170: SKIP (0.001s) [74.575817] [008/155] (946s left) kms_plane_multiple (2x-tiling-x) [74.671404] Starting subtest: 2x-tiling-x [74.676193] Subtest 2x-tiling-x: SKIP (0.000s) [74.745823] [009/155] (946s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [74.838441] Starting subtest: hdr-rgb101010-draw-pwrite [74.842567] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [74.931866] [010/155] (946s left) gem_exec_balancer (busy) [74.994828] Starting subtest: busy [76.321065] Subtest busy: SUCCESS (1.325s) [76.635323] [011/155] (944s left) i915_drm_fdinfo (basics) [76.674615] Starting subtest: basics [76.676801] Subtest basics: SUCCESS (0.000s) [76.735822] [012/155] (944s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [76.789789] Starting subtest: multi-wait-for-submit-available-signaled [76.792149] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [76.903893] [013/155] (944s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt) [77.003855] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt [77.008137] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [77.122801] [014/155] (944s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [77.221268] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [77.246649] Starting dynamic subtest: pipe-A-plane-0 [77.612430] Dynamic subtest pipe-A-plane-0: SUCCESS (0.367s) [77.620224] Starting dynamic subtest: pipe-A-plane-3 [77.912174] Dynamic subtest pipe-A-plane-3: SUCCESS (0.299s) [79.029734] Starting dynamic subtest: pipe-B-plane-0 [79.423511] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [79.432772] Starting dynamic subtest: pipe-B-plane-3 [79.745220] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s) [80.065559] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.847s) [80.900930] [015/155] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff) [80.998300] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff [81.002838] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [81.114402] [016/155] (940s left) kms_flip (basic-flip-vs-dpms) [81.211620] Starting subtest: basic-flip-vs-dpms [81.214056] Starting dynamic subtest: A-eDP1 [83.797725] Dynamic subtest A-eDP1: SUCCESS (2.588s) [83.808210] Starting dynamic subtest: B-eDP1 [85.981462] Dynamic subtest B-eDP1: SUCCESS (2.182s) [85.990490] Starting dynamic subtest: C-eDP1 [88.147920] Dynamic subtest C-eDP1: SUCCESS (2.165s) [88.155995] Starting dynamic subtest: D-eDP1 [90.420579] Dynamic subtest D-eDP1: SUCCESS (2.273s) [90.425404] Subtest basic-flip-vs-dpms: SUCCESS (9.217s) [91.332819] [017/155] (930s left) gem_watchdog (default-virtual) [91.403851] Starting subtest: default-virtual [97.682779] Subtest default-virtual: SUCCESS (6.285s) [97.759222] [018/155] (924s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite) [97.865455] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite [97.869444] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [97.951209] [019/155] (923s left) kms_big_fb (y-tiled-16bpp-rotate-270) [98.046117] Starting subtest: y-tiled-16bpp-rotate-270 [98.050384] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [98.143292] [020/155] (923s left) gem_workarounds (reset-fd) [98.204216] Starting subtest: reset-fd [98.333394] Subtest reset-fd: SUCCESS (0.132s) [98.448439] [021/155] (923s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [98.575732] Starting subtest: modeset-atomic-cursor-hotspot [98.580106] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [98.717597] [022/155] (923s left) gem_eio (in-flight-1us) [98.905122] Starting subtest: in-flight-1us [106.685107] Subtest in-flight-1us: SUCCESS (7.780s) [106.861476] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true [106.864618] [023/155] (915s left) gem_exec_params (no-blt) [106.920587] Starting subtest: no-blt [106.922932] Subtest no-blt: SUCCESS (0.002s) [107.044990] [024/155] (915s left) kms_psr (fbc-psr-sprite-plane-onoff) [107.131177] Starting subtest: fbc-psr-sprite-plane-onoff [107.133469] Starting dynamic subtest: eDP-1 [107.137847] Dynamic subtest eDP-1: SKIP (0.000s) [107.142078] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [107.215497] [025/155] (914s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [107.331458] Starting subtest: cursorB-vs-flipB-varying-size [107.336156] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [107.483847] [026/155] (914s left) gem_userptr_blits (usage-restrictions) [107.551248] Starting subtest: usage-restrictions [107.552812] Subtest usage-restrictions: SUCCESS (0.000s) [107.682230] [027/155] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [107.768401] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [107.862197] [028/155] (914s left) gem_mmap_gtt (medium-copy) [107.912947] Subtest medium-copy: SKIP (0.000s) [107.971156] [029/155] (914s left) gem_softpin (noreloc-s3) [108.026268] Starting subtest: noreloc-S3 [128.691809] Subtest noreloc-S3: SUCCESS (5.435s) [131.852919] [030/155] (893s left) perf_pmu (multi-client) [131.910124] Starting subtest: multi-client [131.912412] Starting dynamic subtest: rcs0 [132.955794] Dynamic subtest rcs0: SUCCESS (1.057s) [132.968238] Starting dynamic subtest: bcs0 [134.006950] Dynamic subtest bcs0: SUCCESS (1.064s) [134.018723] Starting dynamic subtest: vcs0 [135.057821] Dynamic subtest vcs0: SUCCESS (1.063s) [135.068795] Starting dynamic subtest: vcs1 [136.601781] Dynamic subtest vcs1: SUCCESS (1.558s) [136.613415] Starting dynamic subtest: vecs0 [138.582283] Dynamic subtest vecs0: SUCCESS (1.996s) [138.594846] Starting dynamic subtest: ccs0 [140.568018] Dynamic subtest ccs0: SUCCESS (1.997s) [140.570755] Subtest multi-client: SUCCESS (8.743s) [140.698046] [031/155] (884s left) prime_busy (after-wait) [140.764947] Starting subtest: after-wait [140.770039] Starting dynamic subtest: rcs0 [140.808776] Dynamic subtest rcs0: SUCCESS (0.040s) [140.822338] Starting dynamic subtest: bcs0 [140.873159] Dynamic subtest bcs0: SUCCESS (0.063s) [140.882829] Starting dynamic subtest: vcs0 [140.914411] Dynamic subtest vcs0: SUCCESS (0.040s) [140.925715] Starting dynamic subtest: vcs1 [140.952494] Dynamic subtest vcs1: SUCCESS (0.039s) [140.962795] Starting dynamic subtest: vecs0 [140.994795] Dynamic subtest vecs0: SUCCESS (0.042s) [141.004281] Starting dynamic subtest: ccs0 [141.039260] Dynamic subtest ccs0: SUCCESS (0.044s) [141.147919] Subtest after-wait: SUCCESS (0.383s) [141.234512] [032/155] (884s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt) [141.341483] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt [141.345649] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [141.467480] [033/155] (884s left) gem_exec_whisper (basic-fds-forked-all) [141.523135] Starting subtest: basic-fds-forked-all [161.865809] Subtest basic-fds-forked-all: SUCCESS (20.376s) [162.052626] [034/155] (863s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [162.163072] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [162.167298] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [162.276298] [035/155] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [162.374939] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [162.379043] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [162.470113] [036/155] (863s left) gem_spin_batch (engines) [162.516729] Starting subtest: engines [162.519005] Starting dynamic subtest: rcs0 [165.756718] Dynamic subtest rcs0: SUCCESS (3.234s) [165.769869] Starting dynamic subtest: bcs0 [168.993017] Dynamic subtest bcs0: SUCCESS (3.234s) [169.005435] Starting dynamic subtest: vcs0 [172.230832] Dynamic subtest vcs0: SUCCESS (3.236s) [172.243249] Starting dynamic subtest: vcs1 [175.467128] Dynamic subtest vcs1: SUCCESS (3.234s) [175.478513] Starting dynamic subtest: vecs0 [178.701959] Dynamic subtest vecs0: SUCCESS (3.235s) [178.713748] Starting dynamic subtest: ccs0 [181.938956] Dynamic subtest ccs0: SUCCESS (3.236s) [181.941419] Subtest engines: SUCCESS (19.418s) [182.174444] [037/155] (843s left) gem_ringfill (legacy-basic) [187.555909] Starting subtest: legacy-basic [187.558612] Starting dynamic subtest: default [187.609919] Dynamic subtest default: SUCCESS (0.054s) [187.623257] Starting dynamic subtest: render [187.652986] Dynamic subtest render: SUCCESS (0.042s) [187.664111] Starting dynamic subtest: bsd [187.695126] Dynamic subtest bsd: SUCCESS (0.040s) [187.706737] Starting dynamic subtest: bsd1 [187.736740] Dynamic subtest bsd1: SUCCESS (0.039s) [187.747487] Starting dynamic subtest: bsd2 [187.783594] Dynamic subtest bsd2: SUCCESS (0.045s) [187.800841] Starting dynamic subtest: blt [187.828047] Dynamic subtest blt: SUCCESS (0.043s) [187.840320] Starting dynamic subtest: vebox [187.871288] Dynamic subtest vebox: SUCCESS (0.041s) [187.873597] Subtest legacy-basic: SUCCESS (0.318s) [187.952457] [038/155] (837s left) core_getversion (basic) [187.989916] Starting subtest: basic [187.994191] Subtest basic: SUCCESS (0.000s) [188.060643] [039/155] (837s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [188.158543] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [188.162866] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [188.266296] [040/155] (837s left) gem_flink_race (flink_close) [188.300753] Starting subtest: flink_close [193.395074] Subtest flink_close: SUCCESS (5.097s) [193.523213] [041/155] (832s left) kms_feature_discovery (display-4x) [193.634006] Starting subtest: display-4x [193.638396] Subtest display-4x: SKIP (0.000s) [193.710518] [042/155] (832s left) syncobj_timeline (invalid-transfer-bad-pad) [193.772572] Starting subtest: invalid-transfer-bad-pad [193.775031] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [193.882844] [043/155] (832s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [193.982841] Starting subtest: fbcpsrhdr-tiling-4 [193.987079] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [194.085255] [044/155] (831s left) syncobj_timeline (single-wait-available-submitted) [194.138588] Starting subtest: single-wait-available-submitted [194.140550] Subtest single-wait-available-submitted: SUCCESS (0.000s) [194.262654] [045/155] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [194.375526] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [201.902388] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.535s) [202.061984] [046/155] (824s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [202.160353] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [202.162232] Starting dynamic subtest: pipe-A-eDP-1 [204.399931] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.242s) [204.410583] Starting dynamic subtest: pipe-B-eDP-1 [206.757146] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.356s) [206.768382] Starting dynamic subtest: pipe-C-eDP-1 [208.834631] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.078s) [208.845496] Starting dynamic subtest: pipe-D-eDP-1 [210.995522] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s) [210.997549] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.839s) [212.167721] [047/155] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [212.280295] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [216.758592] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.487s) [217.975233] [048/155] (808s left) gem_exec_gttfill (engines) [218.036981] Starting subtest: engines [218.039356] Starting dynamic subtest: rcs0 [240.974963] Dynamic subtest rcs0: SUCCESS (22.931s) [240.989447] Starting dynamic subtest: bcs0 [264.238030] Dynamic subtest bcs0: SUCCESS (23.261s) [264.249826] Starting dynamic subtest: vcs0 [287.502274] Dynamic subtest vcs0: SUCCESS (23.265s) [287.513540] Starting dynamic subtest: vcs1 [310.819174] Dynamic subtest vcs1: SUCCESS (23.320s) [310.832878] Starting dynamic subtest: vecs0 [334.154174] Dynamic subtest vecs0: SUCCESS (23.340s) [334.165121] Starting dynamic subtest: ccs0 [357.444136] Dynamic subtest ccs0: SUCCESS (23.290s) [357.446836] Subtest engines: SUCCESS (139.415s) [357.634003] [049/155] (668s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [357.790186] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [357.792444] Starting dynamic subtest: pipe-A-eDP-1 [357.817126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [357.831071] Starting dynamic subtest: pipe-B-eDP-1 [357.854043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [357.865016] Starting dynamic subtest: pipe-C-eDP-1 [357.888350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [357.898092] Starting dynamic subtest: pipe-D-eDP-1 [357.921928] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [357.926370] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s) [360.117213] [050/155] (666s left) kms_chamelium_hpd (vga-hpd-after-suspend) [360.525144] Subtest vga-hpd-after-suspend: SKIP (0.000s) [361.335258] [051/155] (664s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [361.443819] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [361.448388] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.001s) [361.545524] [052/155] (664s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [361.639460] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [361.643327] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [361.723541] [053/155] (664s left) kms_invalid_mode (bad-hsync-start) [361.820274] Starting subtest: bad-hsync-start [361.822581] Starting dynamic subtest: pipe-A-eDP-1 [362.113064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [362.123936] Starting dynamic subtest: pipe-B-eDP-1 [362.125833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [362.136075] Starting dynamic subtest: pipe-C-eDP-1 [362.138274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [362.152033] Starting dynamic subtest: pipe-D-eDP-1 [362.154667] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [362.156856] Subtest bad-hsync-start: SUCCESS (0.297s) [362.982693] [054/155] (663s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt) [363.074923] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt [363.079078] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [363.178673] [055/155] (663s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [363.280923] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [363.284874] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [363.374741] [056/155] (663s left) kms_pipe_stress (stress-xrgb8888-ytiled) [363.463488] Starting subtest: stress-xrgb8888-ytiled [363.467931] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [363.540652] [057/155] (662s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [363.634875] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [363.636737] Starting dynamic subtest: pipe-A-eDP-1 [364.093827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s) [364.106876] Starting dynamic subtest: pipe-B-eDP-1 [364.124433] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [364.134751] Starting dynamic subtest: pipe-C-eDP-1 [364.151434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [364.161383] Starting dynamic subtest: pipe-D-eDP-1 [364.177425] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [364.179292] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.475s) [366.452959] [058/155] (660s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [366.560694] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [366.941496] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [369.732268] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.789s) [369.745458] Starting dynamic subtest: pipe-A-eDP-1-4 [371.918614] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [371.931409] Starting dynamic subtest: pipe-A-eDP-1-4 [373.929436] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [373.943192] Starting dynamic subtest: pipe-A-eDP-1-x [376.108857] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [376.486332] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [379.262582] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s) [379.275845] Starting dynamic subtest: pipe-B-eDP-1-4 [381.449488] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [381.460191] Starting dynamic subtest: pipe-B-eDP-1-4 [383.458995] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [383.472875] Starting dynamic subtest: pipe-B-eDP-1-x [385.649509] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [386.020678] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [388.800069] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.790s) [388.812922] Starting dynamic subtest: pipe-C-eDP-1-4 [390.974157] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [390.985049] Starting dynamic subtest: pipe-C-eDP-1-4 [392.997572] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [393.008819] Starting dynamic subtest: pipe-C-eDP-1-x [395.163932] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [395.530862] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [398.333655] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s) [398.345071] Starting dynamic subtest: pipe-D-eDP-1-4 [400.519020] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s) [400.529707] Starting dynamic subtest: pipe-D-eDP-1-4 [402.529213] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [402.542432] Starting dynamic subtest: pipe-D-eDP-1-x [404.708576] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [404.711388] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.142s) [405.942259] [059/155] (620s left) gem_media_fill (media-fill) [405.997397] Subtest media-fill: SKIP (0.000s) [406.100931] [060/155] (620s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [406.197075] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [406.201387] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [406.310913] [061/155] (620s left) gem_workarounds (reset-context) [406.367851] Starting subtest: reset-context [406.551530] Subtest reset-context: SUCCESS (0.182s) [406.692557] [062/155] (620s left) kms_vblank (wait-idle) [406.783667] Starting subtest: wait-idle [406.785608] Starting dynamic subtest: pipe-A-eDP-1 [408.555835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.774s) [408.571942] Starting dynamic subtest: pipe-D-eDP-1 [410.981260] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s) [410.983450] Subtest wait-idle: SUCCESS (4.198s) [411.797729] [063/155] (614s left) kms_pm_backlight (fade) [411.899229] Starting subtest: fade [411.952279] Starting dynamic subtest: eDP-1 [414.965077] Dynamic subtest eDP-1: SUCCESS (3.016s) [414.967594] Subtest fade: SUCCESS (3.068s) [415.837051] [064/155] (610s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [415.934790] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [416.914161] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.979s) [417.038896] [065/155] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [417.138182] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [423.697246] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.565s) [423.812504] [066/155] (603s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt) [423.914454] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt [423.919011] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [424.006884] [067/155] (602s left) gen9_exec_parse (secure-batches) [424.070416] Subtest secure-batches: SKIP (0.000s) [424.142457] [068/155] (602s left) gem_exec_flush (basic-wb-prw-default) [424.200937] Starting subtest: basic-wb-prw-default [429.664709] Subtest basic-wb-prw-default: SUCCESS (5.464s) [429.869755] [069/155] (597s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen) [429.979956] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen [429.984430] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [430.074663] [070/155] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [430.178909] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [430.183346] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [430.278666] [071/155] (596s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [430.373969] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu [430.377858] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [430.470837] [072/155] (596s left) kms_cursor_crc (cursor-alpha-opaque) [430.564145] Starting subtest: cursor-alpha-opaque [430.566411] Starting dynamic subtest: pipe-A-eDP-1 [431.197907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [431.208854] Starting dynamic subtest: pipe-D-eDP-1 [432.435888] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s) [432.438422] Subtest cursor-alpha-opaque: SUCCESS (1.873s) [433.332329] [073/155] (593s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [433.395621] Starting subtest: y-tiled-ccs-to-y-tiled [433.400132] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [433.591822] [074/155] (593s left) syncobj_basic (create-signaled) [433.646245] Starting subtest: create-signaled [433.648585] Subtest create-signaled: SUCCESS (0.000s) [433.753736] [075/155] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [433.856027] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [433.860146] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [433.948651] [076/155] (593s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [434.048934] Starting subtest: extended-modeset-hang-oldfb-with-reset [434.051267] Starting dynamic subtest: pipe-A [445.723739] Dynamic subtest pipe-A: SUCCESS (11.674s) [445.735252] Starting dynamic subtest: pipe-D [458.475720] Dynamic subtest pipe-D: SUCCESS (12.749s) [458.477924] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.427s) [459.376199] [077/155] (568s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [459.442484] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [459.547093] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s) [459.640881] [078/155] (567s left) kms_addfb_basic (basic) [459.692767] Starting subtest: basic [459.695057] Subtest basic: SUCCESS (0.000s) [459.829738] [079/155] (567s left) gem_exec_schedule (u-independent) [459.898845] Starting subtest: u-independent [459.901133] Starting dynamic subtest: rcs0 [461.536544] Dynamic subtest rcs0: SUCCESS (1.645s) [461.550725] Starting dynamic subtest: vcs0 [463.590713] Dynamic subtest vcs0: SUCCESS (2.052s) [463.605195] Starting dynamic subtest: vcs1 [465.583289] Dynamic subtest vcs1: SUCCESS (1.991s) [465.596395] Starting dynamic subtest: vecs0 [467.572239] Dynamic subtest vecs0: SUCCESS (1.988s) [467.585630] Starting dynamic subtest: ccs0 [469.536730] Dynamic subtest ccs0: SUCCESS (1.961s) [469.539766] Subtest u-independent: SUCCESS (9.648s) [469.859086] [080/155] (557s left) kms_panel_fitting (legacy) [469.951183] Starting subtest: legacy [469.953502] Starting dynamic subtest: pipe-A-eDP-1 [470.471058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s) [470.499391] Starting dynamic subtest: pipe-B-eDP-1 [471.990258] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s) [472.019934] Starting dynamic subtest: pipe-C-eDP-1 [473.499150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s) [473.527688] Starting dynamic subtest: pipe-D-eDP-1 [475.035821] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s) [475.038202] Subtest legacy: SUCCESS (5.086s) [476.284382] [081/155] (551s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [476.390769] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [476.394953] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [476.514723] [082/155] (551s left) gem_ctx_persistence (engines-cleanup) [476.576315] Starting subtest: engines-cleanup [476.578637] Starting dynamic subtest: rcs0 [476.633853] Dynamic subtest rcs0: SUCCESS (0.057s) [476.646037] Starting dynamic subtest: bcs0 [476.672654] Dynamic subtest bcs0: SUCCESS (0.038s) [476.684957] Starting dynamic subtest: vcs0 [476.716638] Dynamic subtest vcs0: SUCCESS (0.042s) [476.727505] Starting dynamic subtest: vcs1 [476.768979] Dynamic subtest vcs1: SUCCESS (0.051s) [476.781288] Starting dynamic subtest: vecs0 [476.810653] Dynamic subtest vecs0: SUCCESS (0.040s) [476.822699] Starting dynamic subtest: ccs0 [476.856735] Dynamic subtest ccs0: SUCCESS (0.044s) [476.859114] Subtest engines-cleanup: SUCCESS (0.282s) [476.938406] [083/155] (550s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [477.049868] Starting subtest: nonblocking-modeset-vs-cursor-atomic [478.449267] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.399s) [479.344157] [084/155] (548s left) kms_properties (colorop-properties-atomic) [479.451348] Starting subtest: colorop-properties-atomic [479.453589] Starting dynamic subtest: pipe-A-eDP-1 [479.820820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s) [479.833260] Starting dynamic subtest: pipe-B-eDP-1 [480.895659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.074s) [480.908434] Starting dynamic subtest: pipe-C-eDP-1 [481.943317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.045s) [481.957425] Starting dynamic subtest: pipe-D-eDP-1 [483.082603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [483.084800] Subtest colorop-properties-atomic: SUCCESS (3.635s) [483.893636] [085/155] (543s left) kms_invalid_mode (zero-hdisplay) [483.995393] Starting subtest: zero-hdisplay [483.997602] Starting dynamic subtest: pipe-A-eDP-1 [484.282515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [484.294418] Starting dynamic subtest: pipe-B-eDP-1 [484.296657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [484.309892] Starting dynamic subtest: pipe-C-eDP-1 [484.312191] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [484.335630] Starting dynamic subtest: pipe-D-eDP-1 [484.337920] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [484.340267] Subtest zero-hdisplay: SUCCESS (0.291s) [485.124846] [086/155] (542s left) perf_pmu (busy-accuracy-2) [485.169021] Starting subtest: busy-accuracy-2 [485.170877] Starting dynamic subtest: rcs0 [488.212291] Dynamic subtest rcs0: SUCCESS (3.042s) [488.225836] Starting dynamic subtest: bcs0 [491.273277] Dynamic subtest bcs0: SUCCESS (3.059s) [491.286175] Starting dynamic subtest: vcs0 [494.320554] Dynamic subtest vcs0: SUCCESS (3.046s) [494.331921] Starting dynamic subtest: vcs1 [497.366228] Dynamic subtest vcs1: SUCCESS (3.043s) [497.377759] Starting dynamic subtest: vecs0 [500.411962] Dynamic subtest vecs0: SUCCESS (3.043s) [500.425549] Starting dynamic subtest: ccs0 [503.475100] Dynamic subtest ccs0: SUCCESS (3.061s) [503.477504] Subtest busy-accuracy-2: SUCCESS (18.308s) [503.605625] [087/155] (524s left) syncobj_wait (invalid-signal-zero-handles) [503.664421] Starting subtest: invalid-signal-zero-handles [503.666737] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [503.779385] [088/155] (524s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [503.880482] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [503.884627] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [503.966982] [089/155] (523s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [504.024244] Starting subtest: etime-single-wait-all-for-submit-submitted [504.130581] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s) [504.211270] [090/155] (523s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render) [504.305013] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render [504.309557] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [504.400276] [091/155] (523s left) gem_create (create-valid-nonaligned) [504.456822] Starting subtest: create-valid-nonaligned [504.458927] Subtest create-valid-nonaligned: SUCCESS (0.000s) [504.643418] [092/155] (523s left) i915_query (hwconfig_table) [504.708872] Starting subtest: hwconfig_table [505.007082] Subtest hwconfig_table: SUCCESS (0.001s) [505.050174] [093/155] (523s left) api_intel_bb (object-noreloc-purge-cache-simple) [505.105690] Starting subtest: object-noreloc-purge-cache-simple [505.111779] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.010s) [505.239513] [094/155] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [505.347798] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [505.352055] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [505.460235] [095/155] (522s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [505.558261] Starting subtest: psr-modesetfrombusy [511.796927] Subtest psr-modesetfrombusy: SUCCESS (6.246s) [511.927998] [096/155] (516s left) gem_userptr_blits (sync-unmap-after-close) [511.990017] Starting subtest: sync-unmap-after-close [512.001611] Subtest sync-unmap-after-close: SUCCESS (0.010s) [512.123338] [097/155] (516s left) gem_exec_fence (invalid-timeline-fence-array) [512.690994] Starting subtest: invalid-timeline-fence-array [512.697983] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [513.664099] [098/155] (514s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt) [513.761898] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt [513.765961] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [513.859601] [099/155] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [513.953548] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [521.380113] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.432s) [521.549775] [100/155] (506s left) gem_lmem_swapping (parallel-random-engines) [521.591824] Subtest parallel-random-engines: SKIP (0.000s) [521.637427] [101/155] (506s left) gem_exec_reloc (basic-write-cpu) [521.710386] Subtest basic-write-cpu: SKIP (0.000s) [521.784299] [102/155] (506s left) gem_mmap_gtt (hang) [521.843892] Subtest hang: SKIP (0.000s) [521.905113] [103/155] (506s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [522.025721] Starting subtest: short-flip-before-cursor-atomic-transitions [522.982266] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s) [523.858320] [104/155] (504s left) gem_ctx_persistence (saturated-hostile) [523.913171] Starting subtest: saturated-hostile [523.915516] Starting dynamic subtest: rcs0 [524.715562] Dynamic subtest rcs0: SUCCESS (0.802s) [524.729985] Starting dynamic subtest: bcs0 [525.522262] Dynamic subtest bcs0: SUCCESS (0.804s) [525.536423] Starting dynamic subtest: vcs0 [526.314664] Dynamic subtest vcs0: SUCCESS (0.790s) [526.328359] Starting dynamic subtest: vcs1 [527.122285] Dynamic subtest vcs1: SUCCESS (0.806s) [527.134072] Starting dynamic subtest: vecs0 [527.908598] Dynamic subtest vecs0: SUCCESS (0.784s) [527.922602] Starting dynamic subtest: ccs0 [528.756717] Dynamic subtest ccs0: SUCCESS (0.846s) [528.762576] Subtest saturated-hostile: SUCCESS (4.845s) [528.840157] [105/155] (499s left) syncobj_wait (invalid-single-wait-unsubmitted) [528.892269] Starting subtest: invalid-single-wait-unsubmitted [528.894509] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [528.998422] [106/155] (499s left) prime_vgem (basic-fence-mmap) [529.069424] Starting subtest: basic-fence-mmap [529.074047] Subtest basic-fence-mmap: SKIP (0.000s) [529.163901] [107/155] (499s left) gem_bad_reloc (negative-reloc) [529.223982] Subtest negative-reloc: SKIP (0.000s) [529.299142] [108/155] (499s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [529.354597] Starting subtest: yf-tiled-ccs-to-y-tiled [529.359053] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [529.544314] [109/155] (499s left) kms_psr2_su (page_flip-p010) [529.598708] Subtest page_flip-P010: SKIP (0.000s) [529.662013] [110/155] (499s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [529.756848] Starting subtest: psr2-overlay-plane-move-continuous-sf [529.759153] Starting dynamic subtest: pipe-A-eDP-1 [535.725886] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.970s) [535.737965] Starting dynamic subtest: pipe-B-eDP-1 [542.428674] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.705s) [542.431026] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.678s) [543.303024] [111/155] (485s left) kms_cursor_crc (cursor-sliding-32x32) [543.447398] Starting subtest: cursor-sliding-32x32 [543.492192] Subtest cursor-sliding-32x32: SKIP (0.043s) [543.795431] [112/155] (485s left) kms_pm_rpm (fences) [545.724135] Starting subtest: fences [545.729284] Subtest fences: SKIP (0.000s) [546.123556] [113/155] (482s left) gem_ctx_bad_destroy (invalid-ctx) [546.171971] Starting subtest: invalid-ctx [546.174256] Subtest invalid-ctx: SUCCESS (0.000s) [546.247267] [114/155] (482s left) kms_universal_plane (disable-primary-vs-flip) [546.343310] Starting subtest: disable-primary-vs-flip [546.345260] Starting dynamic subtest: pipe-A-eDP-1 [547.917744] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.575s) [547.929281] Starting dynamic subtest: pipe-B-eDP-1 [550.173945] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.253s) [550.185413] Starting dynamic subtest: pipe-C-eDP-1 [552.424805] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s) [552.436688] Starting dynamic subtest: pipe-D-eDP-1 [554.715423] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.289s) [554.717330] Subtest disable-primary-vs-flip: SUCCESS (8.373s) [555.596877] [115/155] (473s left) kms_psr (fbc-psr2-sprite-plane-move) [555.689521] Starting subtest: fbc-psr2-sprite-plane-move [555.691841] Starting dynamic subtest: eDP-1 [555.696276] Dynamic subtest eDP-1: SKIP (0.000s) [555.700678] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [555.767793] [116/155] (473s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [555.886822] Starting subtest: cursorB-vs-flipA-toggle [555.891399] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [556.046897] [117/155] (473s left) gem_exec_balancer (parallel-out-fence) [556.302919] Starting subtest: parallel-out-fence [557.595677] Subtest parallel-out-fence: SUCCESS (1.293s) [557.722623] [118/155] (471s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt) [557.820167] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt [557.824338] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [557.923594] [119/155] (471s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [558.031324] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [558.035568] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [558.146452] [120/155] (471s left) sysfs_heartbeat_interval (precise) [558.197416] Starting subtest: precise [558.199494] Starting dynamic subtest: vecs0 [565.531121] Dynamic subtest vecs0: SUCCESS (7.334s) [565.544759] Starting dynamic subtest: ccs0 [568.580942] Dynamic subtest ccs0: SUCCESS (3.049s) [568.593263] Starting dynamic subtest: vcs0 [576.546452] Dynamic subtest vcs0: SUCCESS (7.968s) [576.561870] Starting dynamic subtest: bcs0 [577.662115] Dynamic subtest bcs0: SUCCESS (1.113s) [577.674720] Starting dynamic subtest: rcs0 [578.755302] Dynamic subtest rcs0: SUCCESS (1.092s) [578.767774] Starting dynamic subtest: vcs1 [586.584360] Dynamic subtest vcs1: SUCCESS (7.831s) [586.586810] Subtest precise: SUCCESS (28.396s) [586.677758] [121/155] (442s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [586.776964] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [586.781255] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [586.864891] [122/155] (442s left) gem_mmap_gtt (basic-small-copy-xy) [586.911859] Subtest basic-small-copy-XY: SKIP (0.000s) [586.974800] [123/155] (442s left) kms_psr (psr-sprite-mmap-gtt) [587.061352] Starting subtest: psr-sprite-mmap-gtt [587.063625] Starting dynamic subtest: eDP-1 [588.484191] Dynamic subtest eDP-1: SKIP (1.420s) [588.489316] Subtest psr-sprite-mmap-gtt: SKIP (1.422s) [588.643893] [124/155] (440s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [588.740543] Starting subtest: yf-tiled-16bpp-rotate-180 [588.744674] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [588.832127] [125/155] (440s left) kms_addfb_basic (tile-pitch-mismatch) [588.890845] Starting subtest: tile-pitch-mismatch [588.895014] Subtest tile-pitch-mismatch: SKIP (0.000s) [589.021348] [126/155] (440s left) kms_pm_rpm (system-suspend-modeset) [590.749734] Starting subtest: system-suspend-modeset [611.215006] Subtest system-suspend-modeset: SUCCESS (4.651s) [615.613467] [127/155] (418s left) i915_pm_freq_api (freq-reset-multiple) [615.690639] Starting subtest: freq-reset-multiple [615.693317] Starting dynamic subtest: gt0 [624.798755] Dynamic subtest gt0: SUCCESS (9.150s) [624.810276] Starting dynamic subtest: gt1 [632.640871] Dynamic subtest gt1: SUCCESS (7.888s) [632.643510] Subtest freq-reset-multiple: SUCCESS (17.041s) [632.722898] [128/155] (400s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [632.827251] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [632.831522] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [632.915987] [129/155] (400s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [633.008408] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [633.010291] Starting dynamic subtest: pipe-A-eDP-1 [635.197540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.197s) [635.208965] Starting dynamic subtest: pipe-B-eDP-1 [637.594313] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.400s) [637.612069] Starting dynamic subtest: pipe-C-eDP-1 [639.709422] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.119s) [639.721578] Starting dynamic subtest: pipe-D-eDP-1 [641.815196] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.108s) [641.817180] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.830s) [643.000256] [130/155] (390s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render) [643.104910] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render [643.109340] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [643.219485] [131/155] (390s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [643.316394] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc [643.320547] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [643.430478] [132/155] (390s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt) [643.531593] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt [643.536005] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [643.622246] [133/155] (390s left) kms_flip (wf_vblank-ts-check) [643.717532] Starting subtest: wf_vblank-ts-check [643.719755] Starting dynamic subtest: A-eDP1 [652.647479] Dynamic subtest A-eDP1: SUCCESS (8.937s) [652.660666] Starting dynamic subtest: B-eDP1 [661.579382] Dynamic subtest B-eDP1: SUCCESS (8.927s) [661.592857] Starting dynamic subtest: C-eDP1 [670.502852] Dynamic subtest C-eDP1: SUCCESS (8.920s) [670.515833] Starting dynamic subtest: D-eDP1 [679.447805] Dynamic subtest D-eDP1: SUCCESS (8.943s) [679.450079] Subtest wf_vblank-ts-check: SUCCESS (35.738s) [680.684141] [134/155] (353s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt) [680.792632] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt [680.797764] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [680.888351] [135/155] (353s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [680.973934] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [680.976147] Starting dynamic subtest: pipe-A-eDP-1 [681.035575] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [681.048471] Starting dynamic subtest: pipe-B-eDP-1 [681.106434] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [681.119106] Starting dynamic subtest: pipe-C-eDP-1 [681.174294] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [681.186739] Starting dynamic subtest: pipe-D-eDP-1 [681.245559] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [681.250023] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [683.235564] [136/155] (350s left) kms_psr (psr-basic) [683.321001] Starting subtest: psr-basic [683.323285] Starting dynamic subtest: eDP-1 [684.919701] Dynamic subtest eDP-1: SUCCESS (1.600s) [684.922165] Subtest psr-basic: SUCCESS (1.601s) [685.803801] [137/155] (348s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt) [685.904175] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt [685.908251] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [686.000595] [138/155] (348s left) gem_mmap_offset (bad-extensions) [686.062763] Starting subtest: bad-extensions [686.065039] Subtest bad-extensions: SUCCESS (0.000s) [686.189236] [139/155] (347s left) gem_ctx_exec (basic-close-race) [686.246239] Starting subtest: basic-close-race [691.993211] Subtest basic-close-race: SUCCESS (5.747s) [692.147998] [140/155] (342s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [692.201979] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [692.306825] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [692.402610] [141/155] (341s left) gem_mmap_offset (ptrace) [692.454019] Starting subtest: ptrace [692.458973] Starting dynamic subtest: smem0-wb [692.471492] Dynamic subtest smem0-wb: SUCCESS (0.013s) [692.485185] Starting dynamic subtest: smem0-wc [692.490955] Dynamic subtest smem0-wc: SUCCESS (0.019s) [692.501930] Starting dynamic subtest: smem0-uc [692.508737] Dynamic subtest smem0-uc: SUCCESS (0.017s) [692.510970] Subtest ptrace: SUCCESS (0.057s) [692.639125] [142/155] (341s left) gem_exec_schedule (pi-ringfull) [692.823430] Starting subtest: pi-ringfull [692.825756] Starting dynamic subtest: rcs0 [692.860858] Dynamic subtest rcs0: SUCCESS (0.041s) [692.872863] Starting dynamic subtest: bcs0 [692.900909] Dynamic subtest bcs0: SUCCESS (0.039s) [692.917296] Starting dynamic subtest: vcs0 [692.943835] Dynamic subtest vcs0: SUCCESS (0.039s) [692.961223] Starting dynamic subtest: vcs1 [692.978828] Dynamic subtest vcs1: SUCCESS (0.037s) [692.994424] Starting dynamic subtest: vecs0 [693.014407] Dynamic subtest vecs0: SUCCESS (0.035s) [693.025380] Starting dynamic subtest: ccs0 [693.048616] Dynamic subtest ccs0: SUCCESS (0.033s) [693.050840] Subtest pi-ringfull: SUCCESS (0.230s) [693.283784] [143/155] (341s left) kms_frontbuffer_tracking (fbchdr-stridechange) [693.387398] Starting subtest: fbchdr-stridechange [693.391365] Subtest fbchdr-stridechange: SKIP (0.000s) [693.486565] [144/155] (340s left) i915_pm_rc6_residency (rc6-fence) [693.541655] Starting subtest: rc6-fence [693.555571] Starting dynamic subtest: gt0 [705.874128] Dynamic subtest gt0: SUCCESS (12.322s) [705.888013] Starting dynamic subtest: gt1 [720.294695] Dynamic subtest gt1: SUCCESS (14.419s) [720.297969] Subtest rc6-fence: SUCCESS (26.762s) [720.378250] [145/155] (314s left) gem_exec_fence (basic-busy-all) [720.435190] Starting subtest: basic-busy-all [720.536941] Subtest basic-busy-all: SUCCESS (0.103s) [722.497939] [146/155] (312s left) kms_async_flips (test-cursor) [722.603827] Starting subtest: test-cursor [722.974142] Starting dynamic subtest: pipe-A-eDP-1 [723.780332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s) [724.169948] Starting dynamic subtest: pipe-B-eDP-1 [724.916616] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s) [725.295443] Starting dynamic subtest: pipe-C-eDP-1 [726.062832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s) [726.439228] Starting dynamic subtest: pipe-D-eDP-1 [727.195922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s) [727.198625] Subtest test-cursor: SUCCESS (4.593s) [728.367251] [147/155] (306s left) kms_color (ctm-red-to-blue) [728.470913] Starting subtest: ctm-red-to-blue [728.472794] Starting dynamic subtest: pipe-A-eDP-1 [729.177599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [729.189454] Starting dynamic subtest: pipe-B-eDP-1 [730.592455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s) [730.604473] Starting dynamic subtest: pipe-C-eDP-1 [731.966812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s) [731.978941] Starting dynamic subtest: pipe-D-eDP-1 [733.374130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s) [733.376363] Subtest ctm-red-to-blue: SUCCESS (4.904s) [734.183269] [148/155] (300s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [734.278887] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [734.281182] Starting dynamic subtest: pipe-A [734.389683] Dynamic subtest pipe-A: SKIP (0.107s) [734.402058] Starting dynamic subtest: pipe-B [735.555905] Dynamic subtest pipe-B: SKIP (1.165s) [735.568388] Starting dynamic subtest: pipe-C [736.779846] Dynamic subtest pipe-C: SUCCESS (1.229s) [736.792653] Starting dynamic subtest: pipe-D [738.017684] Dynamic subtest pipe-D: SUCCESS (1.236s) [738.020267] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.741s) [739.214051] [149/155] (295s left) kms_flip (2x-blocking-absolute-wf_vblank) [739.315188] Starting subtest: 2x-blocking-absolute-wf_vblank [739.324434] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [739.404461] [150/155] (295s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render) [739.505095] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render [739.509507] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [739.612704] [151/155] (295s left) prime_mmap_coherency (read) [739.665467] Starting subtest: read [745.040851] Subtest read: SUCCESS (5.374s) [745.163391] [152/155] (289s left) kms_big_fb (4-tiled-addfb) [745.257104] Starting subtest: 4-tiled-addfb [745.259364] Subtest 4-tiled-addfb: SUCCESS (0.000s) [745.356086] [153/155] (289s left) api_intel_bb (crc32) [745.408950] Starting subtest: crc32 [745.411236] Starting dynamic subtest: rcs0-smem0 [745.712514] Dynamic subtest rcs0-smem0: SUCCESS (0.301s) [745.726699] Starting dynamic subtest: bcs0-smem0 [746.067007] Dynamic subtest bcs0-smem0: SUCCESS (0.352s) [746.081411] Starting dynamic subtest: vcs0-smem0 [746.451212] Dynamic subtest vcs0-smem0: SUCCESS (0.382s) [746.466089] Starting dynamic subtest: vcs1-smem0 [746.897227] Dynamic subtest vcs1-smem0: SUCCESS (0.443s) [746.909929] Starting dynamic subtest: vecs0-smem0 [747.305620] Dynamic subtest vecs0-smem0: SUCCESS (0.405s) [747.320115] Starting dynamic subtest: ccs0-smem0 [747.644406] Dynamic subtest ccs0-smem0: SUCCESS (0.336s) [747.646958] Subtest crc32: SUCCESS (2.236s) [747.789289] [154/155] (287s left) kms_cursor_crc (cursor-onscreen-max-size) [748.100614] Starting subtest: cursor-onscreen-max-size [748.107482] Subtest cursor-onscreen-max-size: SKIP (0.000s) [748.248792] [155/155] (286s left) kms_psr (psr2-cursor-mmap-cpu) [748.339843] Starting subtest: psr2-cursor-mmap-cpu [748.342666] Starting dynamic subtest: eDP-1 [750.105159] Dynamic subtest eDP-1: SUCCESS (1.763s) [750.107367] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.764s) [750.988689] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_rotation_crc results: parsing output: 2/ for test: kms_chamelium_edid results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_mmap_write_crc results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_crc results: parsing output: 7/ for test: kms_plane_multiple results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_exec_balancer results: parsing output: 10/ for test: i915_drm_fdinfo results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_plane results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: gem_watchdog results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_workarounds results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: gem_eio results: parsing output: 22/ for test: gem_exec_params results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: gem_userptr_blits results: parsing output: 26/ for test: kms_addfb_basic results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: gem_softpin results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: prime_busy results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_whisper results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_spin_batch results: parsing output: 36/ for test: gem_ringfill results: parsing output: 37/ for test: core_getversion results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_flink_race results: parsing output: 40/ for test: kms_feature_discovery results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_gttfill results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_chamelium_hpd results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: kms_flip_scaled_crc results: parsing output: 52/ for test: kms_invalid_mode results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_pipe_stress results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: gem_media_fill results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_workarounds results: parsing output: 61/ for test: kms_vblank results: parsing output: 62/ for test: kms_pm_backlight results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gen9_exec_parse results: parsing output: 67/ for test: gem_exec_flush results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: syncobj_basic results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_busy results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_panel_fitting results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_ctx_persistence results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_properties results: parsing output: 84/ for test: kms_invalid_mode results: parsing output: 85/ for test: perf_pmu results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_create results: parsing output: 91/ for test: i915_query results: parsing output: 92/ for test: api_intel_bb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_userptr_blits results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_lmem_swapping results: parsing output: 100/ for test: gem_exec_reloc results: parsing output: 101/ for test: gem_mmap_gtt results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: gem_ctx_persistence results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: prime_vgem results: parsing output: 106/ for test: gem_bad_reloc results: parsing output: 107/ for test: gem_render_copy results: parsing output: 108/ for test: kms_psr2_su results: parsing output: 109/ for test: kms_psr2_sf results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: gem_ctx_bad_destroy results: parsing output: 113/ for test: kms_universal_plane results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: gem_exec_balancer results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: sysfs_heartbeat_interval results: parsing output: 120/ for test: kms_flip_scaled_crc results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_addfb_basic results: parsing output: 125/ for test: kms_pm_rpm results: parsing output: 126/ for test: i915_pm_freq_api results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_flip results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_ccs results: parsing output: 135/ for test: kms_psr results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: gem_mmap_offset results: parsing output: 138/ for test: gem_ctx_exec results: parsing output: 139/ for test: syncobj_wait results: parsing output: 140/ for test: gem_mmap_offset results: parsing output: 141/ for test: gem_exec_schedule results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: i915_pm_rc6_residency results: parsing output: 144/ for test: gem_exec_fence results: parsing output: 145/ for test: kms_async_flips results: parsing output: 146/ for test: kms_color results: parsing output: 147/ for test: kms_plane_scaling results: parsing output: 148/ for test: kms_flip results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: prime_mmap_coherency results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: api_intel_bb results: parsing output: 153/ for test: kms_cursor_crc results: parsing output: 154/ for test: kms_psr Done.