[42.819183] Initializing watchdogs [42.819274] /dev/watchdog0 [42.825164] [001/171] (960s left) i915_module_load (load) [42.915591] Starting subtest: load [44.963514] Subtest load: SUCCESS (2.047s) [44.993321] [002/171] (958s left) core_auth (basic-auth) [45.124374] Starting subtest: basic-auth [45.125771] Subtest basic-auth: SUCCESS (0.001s) [45.178204] [003/171] (958s left) debugfs_test (read_all_entries) [45.268316] Starting subtest: read_all_entries [45.330591] Subtest read_all_entries: SUCCESS (0.061s) [45.743458] [004/171] (957s left) debugfs_test (basic-hwmon) [45.829684] Starting subtest: basic-hwmon [45.830872] Subtest basic-hwmon: SKIP (0.000s) [46.260163] [005/171] (957s left) fbdev (eof) [46.346377] Starting subtest: eof [46.347100] Subtest eof: SUCCESS (0.001s) [46.395388] [006/171] (957s left) fbdev (info) [46.477902] Starting subtest: info [46.478579] Subtest info: SUCCESS (0.000s) [46.545352] [007/171] (956s left) fbdev (nullptr) [46.646338] Starting subtest: nullptr [46.646931] Subtest nullptr: SUCCESS (0.000s) [46.695199] [008/171] (956s left) fbdev (read) [46.779318] Starting subtest: read [47.002026] Subtest read: SUCCESS (0.222s) [47.043123] [009/171] (956s left) fbdev (write) [47.129130] Starting subtest: write [47.246056] Subtest write: SUCCESS (0.117s) [47.293158] [010/171] (956s left) gem_basic (bad-close) [47.372688] Starting subtest: bad-close [47.374402] Subtest bad-close: SUCCESS (0.000s) [47.427708] [011/171] (956s left) gem_basic (create-close) [47.510721] Starting subtest: create-close [47.511797] Subtest create-close: SUCCESS (0.000s) [47.579055] [012/171] (955s left) gem_basic (create-fd-close) [47.665094] Starting subtest: create-fd-close [47.666264] Subtest create-fd-close: SUCCESS (0.000s) [47.727383] [013/171] (955s left) gem_busy (busy@all-engines) [47.822265] Starting subtest: busy [47.822896] Starting dynamic subtest: all-engines [47.870499] Dynamic subtest all-engines: SUCCESS (0.050s) [47.871184] Subtest busy: SUCCESS (0.050s) [48.263190] [014/171] (955s left) gem_close_race (basic-process) [48.375534] Starting subtest: basic-process [48.435277] Subtest basic-process: SUCCESS (0.060s) [48.647531] [015/171] (954s left) gem_close_race (basic-threads) [48.744465] Starting subtest: basic-threads [49.905102] Subtest basic-threads: SUCCESS (1.161s) [50.116389] [016/171] (953s left) gem_ctx_create (basic) [50.232319] Starting subtest: basic [50.232955] Subtest basic: SUCCESS (0.000s) [50.429815] [017/171] (953s left) gem_ctx_create (basic-files) [50.523482] Starting subtest: basic-files [52.539946] Subtest basic-files: SUCCESS (2.016s) [52.783819] [018/171] (950s left) gem_ctx_exec (basic) [52.887643] Starting subtest: basic [52.890594] Subtest basic: SUCCESS (0.003s) [53.000612] [019/171] (950s left) gem_exec_basic (basic) [53.090478] Starting subtest: basic [53.091038] Starting dynamic subtest: rcs0-smem [53.092347] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [53.098943] Starting dynamic subtest: bcs0-smem [53.099590] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [53.105064] Starting dynamic subtest: vcs0-smem [53.105855] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [53.110790] Starting dynamic subtest: vcs1-smem [53.111409] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [53.116183] Starting dynamic subtest: vecs0-smem [53.116770] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [53.117335] Subtest basic: SUCCESS (0.005s) [53.322032] [020/171] (950s left) gem_exec_create (basic) [53.435644] Starting subtest: basic [53.436180] Starting dynamic subtest: smem [55.475866] Dynamic subtest smem: SUCCESS (2.040s) [55.476412] Subtest basic: SUCCESS (2.041s) [55.673893] [021/171] (948s left) gem_exec_fence (basic-busy) [55.904068] Starting subtest: basic-busy [55.905947] Starting dynamic subtest: rcs0 [55.939709] Dynamic subtest rcs0: SUCCESS (0.036s) [55.953929] Starting dynamic subtest: bcs0 [55.960912] Dynamic subtest bcs0: SUCCESS (0.021s) [55.967818] Starting dynamic subtest: vcs0 [55.984906] Dynamic subtest vcs0: SUCCESS (0.024s) [55.991750] Starting dynamic subtest: vcs1 [56.001943] Dynamic subtest vcs1: SUCCESS (0.017s) [56.007971] Starting dynamic subtest: vecs0 [56.025988] Dynamic subtest vecs0: SUCCESS (0.024s) [56.026814] Subtest basic-busy: SUCCESS (0.124s) [56.674830] [022/171] (947s left) gem_exec_fence (basic-wait) [56.927484] Starting subtest: basic-wait [56.929815] Starting dynamic subtest: rcs0 [56.954490] Dynamic subtest rcs0: SUCCESS (0.027s) [56.962681] Starting dynamic subtest: bcs0 [56.977843] Dynamic subtest bcs0: SUCCESS (0.024s) [56.983989] Starting dynamic subtest: vcs0 [56.998939] Dynamic subtest vcs0: SUCCESS (0.021s) [57.005451] Starting dynamic subtest: vcs1 [57.020831] Dynamic subtest vcs1: SUCCESS (0.022s) [57.026877] Starting dynamic subtest: vecs0 [57.037836] Dynamic subtest vecs0: SUCCESS (0.017s) [57.038380] Subtest basic-wait: SUCCESS (0.112s) [57.640610] [023/171] (946s left) gem_exec_fence (basic-await) [57.873631] Starting subtest: basic-await [57.875225] Starting dynamic subtest: rcs0 [57.986166] Dynamic subtest rcs0: SUCCESS (0.113s) [57.992317] Starting dynamic subtest: bcs0 [58.080100] Dynamic subtest bcs0: SUCCESS (0.094s) [58.088462] Starting dynamic subtest: vcs0 [58.185589] Dynamic subtest vcs0: SUCCESS (0.105s) [58.193140] Starting dynamic subtest: vcs1 [58.291549] Dynamic subtest vcs1: SUCCESS (0.106s) [58.303413] Starting dynamic subtest: vecs0 [58.420954] Dynamic subtest vecs0: SUCCESS (0.129s) [58.422285] Subtest basic-await: SUCCESS (0.548s) [59.082546] [024/171] (944s left) gem_exec_fence (nb-await) [59.307495] Starting subtest: nb-await [59.308913] Starting dynamic subtest: rcs0 [59.381987] Dynamic subtest rcs0: SUCCESS (0.075s) [59.409395] Starting dynamic subtest: bcs0 [59.468642] Dynamic subtest bcs0: SUCCESS (0.086s) [59.494708] Starting dynamic subtest: vcs0 [59.557608] Dynamic subtest vcs0: SUCCESS (0.088s) [59.583592] Starting dynamic subtest: vcs1 [59.646713] Dynamic subtest vcs1: SUCCESS (0.089s) [59.673623] Starting dynamic subtest: vecs0 [59.732813] Dynamic subtest vecs0: SUCCESS (0.085s) [59.735762] Subtest nb-await: SUCCESS (0.426s) [60.393875] [025/171] (943s left) gem_exec_gttfill (basic) [60.499668] Starting subtest: basic [68.404965] Subtest basic: SUCCESS (7.905s) [68.582025] [026/171] (935s left) gem_exec_parallel (engines) [68.745767] Starting subtest: engines [68.746344] Starting dynamic subtest: basic [70.798247] Dynamic subtest basic: SUCCESS (2.052s) [70.805517] Starting dynamic subtest: contexts [73.555344] Dynamic subtest contexts: SUCCESS (2.757s) [73.561557] Starting dynamic subtest: fds [76.275941] Dynamic subtest fds: SUCCESS (2.721s) [76.282208] Starting dynamic subtest: userptr [78.311151] Dynamic subtest userptr: SUCCESS (2.035s) [78.311818] Subtest engines: SUCCESS (9.565s) [78.500411] [027/171] (925s left) gem_exec_store (basic) [78.596789] Starting subtest: basic [78.643934] Subtest basic: SUCCESS (0.047s) [78.855984] [028/171] (925s left) gem_flink_basic (bad-flink) [78.958694] Starting subtest: bad-flink [78.959227] Subtest bad-flink: SUCCESS (0.000s) [79.010787] [029/171] (924s left) gem_flink_basic (bad-open) [79.087932] Starting subtest: bad-open [79.088626] Subtest bad-open: SUCCESS (0.000s) [79.146376] [030/171] (924s left) gem_flink_basic (basic) [79.231079] Starting subtest: basic [79.231870] Subtest basic: SUCCESS (0.000s) [79.326471] [031/171] (924s left) gem_flink_basic (double-flink) [79.414793] Starting subtest: double-flink [79.415520] Subtest double-flink: SUCCESS (0.000s) [79.503443] [032/171] (924s left) gem_flink_basic (flink-lifetime) [79.597015] Starting subtest: flink-lifetime [79.598165] Subtest flink-lifetime: SUCCESS (0.001s) [79.683815] [033/171] (924s left) gem_huc_copy (huc-copy) [79.778164] Starting subtest: huc-copy [79.779169] Subtest huc-copy: SKIP (0.000s) [79.881776] [034/171] (924s left) gem_linear_blits (basic) [80.098104] Starting subtest: basic [80.104797] Subtest basic: SUCCESS (0.007s) [80.259697] [035/171] (923s left) gem_mmap (basic) [80.420263] Starting subtest: basic [80.423247] Subtest basic: SUCCESS (0.000s) [80.505089] [036/171] (923s left) gem_mmap_gtt (basic) [80.605214] Starting subtest: basic [80.605987] Subtest basic: SUCCESS (0.001s) [80.654066] [037/171] (923s left) gem_render_linear_blits (basic) [80.739545] Starting subtest: basic [80.768844] Subtest basic: SUCCESS (0.029s) [80.803669] [038/171] (923s left) gem_render_tiled_blits (basic) [80.892279] Starting subtest: basic [80.926726] Subtest basic: SUCCESS (0.034s) [80.970180] [039/171] (923s left) gem_ringfill (basic-all) [81.243412] Starting subtest: basic-all [82.406804] Subtest basic-all: SUCCESS (1.163s) [82.511066] [040/171] (921s left) gem_softpin (allocator-basic) [82.618541] Starting subtest: allocator-basic [82.720504] Subtest allocator-basic: SUCCESS (0.101s) [82.819930] [041/171] (921s left) gem_softpin (allocator-basic-reserve) [82.922675] Starting subtest: allocator-basic-reserve [83.025689] Subtest allocator-basic-reserve: SUCCESS (0.103s) [83.113398] [042/171] (921s left) gem_softpin (safe-alignment) [83.204320] Starting subtest: safe-alignment [83.218716] Subtest safe-alignment: SUCCESS (0.014s) [83.342718] [043/171] (920s left) gem_sync (basic-all) [83.445776] Starting subtest: basic-all [85.541086] Subtest basic-all: SUCCESS (2.095s) [85.747880] [044/171] (918s left) gem_sync (basic-each) [85.841934] Starting subtest: basic-each [88.042930] Subtest basic-each: SUCCESS (2.201s) [88.265836] [045/171] (916s left) gem_tiled_blits (basic) [88.496224] Starting subtest: basic [88.514811] Subtest basic: SUCCESS (0.019s) [88.691960] [046/171] (915s left) gem_tiled_fence_blits (basic) [88.972510] Starting subtest: basic [88.981929] Subtest basic: SUCCESS (0.010s) [89.137536] [047/171] (915s left) gem_tiled_pread_basic [89.488912] [048/171] (914s left) gem_wait (busy@all-engines) [89.604536] Starting subtest: busy [89.604993] Starting dynamic subtest: all-engines [90.132960] Dynamic subtest all-engines: SUCCESS (0.528s) [90.133613] Subtest busy: SUCCESS (0.528s) [90.374366] [049/171] (914s left) gem_wait (wait@all-engines) [90.472493] Starting subtest: wait [90.472990] Starting dynamic subtest: all-engines [91.521601] Dynamic subtest all-engines: SUCCESS (1.047s) [91.524078] Subtest wait: SUCCESS (1.048s) [91.794836] [050/171] (912s left) i915_getparams_basic (basic-eu-total) [91.877947] Starting subtest: basic-eu-total [91.879246] Subtest basic-eu-total: SUCCESS (0.000s) [91.927593] [051/171] (912s left) i915_getparams_basic (basic-subslice-total) [92.004988] Starting subtest: basic-subslice-total [92.006236] Subtest basic-subslice-total: SUCCESS (0.000s) [92.062622] [052/171] (912s left) i915_hangman (error-state-basic) [92.159149] Starting subtest: error-state-basic [92.164985] Subtest error-state-basic: SUCCESS (0.006s) [92.228245] [053/171] (912s left) i915_pciid [92.362444] [054/171] (912s left) kms_addfb_basic (addfb25-bad-modifier) [92.445803] Starting subtest: addfb25-bad-modifier [92.446483] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [92.911601] [055/171] (911s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [92.993558] Starting subtest: addfb25-framebuffer-vs-set-tiling [92.994314] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.445224] [056/171] (911s left) kms_addfb_basic (addfb25-modifier-no-flag) [93.526673] Starting subtest: addfb25-modifier-no-flag [93.527361] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [93.961222] [057/171] (910s left) kms_addfb_basic (addfb25-x-tiled-legacy) [94.040831] Starting subtest: addfb25-x-tiled-legacy [94.041435] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [94.494955] [058/171] (910s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [94.575169] Starting subtest: addfb25-x-tiled-mismatch-legacy [94.575824] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [95.027919] [059/171] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [95.478211] Starting subtest: addfb25-yf-tiled-legacy [95.478881] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [95.561192] [060/171] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.015589] Starting subtest: addfb25-y-tiled-legacy [96.016230] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.094685] [061/171] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [96.549328] Starting subtest: addfb25-y-tiled-small-legacy [96.550080] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [96.611459] [062/171] (907s left) kms_addfb_basic (bad-pitch-0) [96.692054] Starting subtest: bad-pitch-0 [96.692754] Subtest bad-pitch-0: SUCCESS (0.000s) [97.127817] [063/171] (907s left) kms_addfb_basic (bad-pitch-1024) [97.208309] Starting subtest: bad-pitch-1024 [97.208984] Subtest bad-pitch-1024: SUCCESS (0.000s) [97.649140] [064/171] (906s left) kms_addfb_basic (bad-pitch-128) [97.728622] Starting subtest: bad-pitch-128 [97.729491] Subtest bad-pitch-128: SUCCESS (0.000s) [98.179233] [065/171] (906s left) kms_addfb_basic (bad-pitch-256) [98.260803] Starting subtest: bad-pitch-256 [98.261384] Subtest bad-pitch-256: SUCCESS (0.000s) [98.728062] [066/171] (905s left) kms_addfb_basic (bad-pitch-32) [98.809179] Starting subtest: bad-pitch-32 [98.809823] Subtest bad-pitch-32: SUCCESS (0.000s) [99.261536] [067/171] (905s left) kms_addfb_basic (bad-pitch-63) [99.341740] Starting subtest: bad-pitch-63 [99.342269] Subtest bad-pitch-63: SUCCESS (0.000s) [99.795094] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536) [99.875513] Starting subtest: bad-pitch-65536 [99.876220] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.327794] [069/171] (904s left) kms_addfb_basic (bad-pitch-999) [100.407708] Starting subtest: bad-pitch-999 [100.408204] Subtest bad-pitch-999: SUCCESS (0.000s) [100.861306] [070/171] (903s left) kms_addfb_basic (basic) [100.942939] Starting subtest: basic [100.943739] Subtest basic: SUCCESS (0.000s) [101.394646] [071/171] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [101.475456] Starting subtest: basic-x-tiled-legacy [101.476187] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.928529] [072/171] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [102.010299] Starting subtest: basic-y-tiled-legacy [102.010908] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [102.461659] [073/171] (902s left) kms_addfb_basic (bo-too-small) [102.917034] Starting subtest: bo-too-small [102.917729] Subtest bo-too-small: SUCCESS (0.000s) [102.994386] [074/171] (901s left) kms_addfb_basic (bo-too-small-due-to-tiling) [103.446559] Starting subtest: bo-too-small-due-to-tiling [103.447240] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [103.529109] [075/171] (901s left) kms_addfb_basic (clobberred-modifier) [103.607660] Starting subtest: clobberred-modifier [103.608224] Subtest clobberred-modifier: SUCCESS (0.000s) [104.061706] [076/171] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.142719] Starting subtest: framebuffer-vs-set-tiling [104.143250] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s) [104.577527] [077/171] (900s left) kms_addfb_basic (invalid-get-prop) [104.658712] Starting subtest: invalid-get-prop [104.659218] Subtest invalid-get-prop: SUCCESS (0.000s) [105.111424] [078/171] (899s left) kms_addfb_basic (invalid-get-prop-any) [105.192202] Starting subtest: invalid-get-prop-any [105.192901] Subtest invalid-get-prop-any: SUCCESS (0.000s) [105.627871] [079/171] (899s left) kms_addfb_basic (invalid-set-prop) [105.708686] Starting subtest: invalid-set-prop [105.709195] Subtest invalid-set-prop: SUCCESS (0.000s) [106.144510] [080/171] (898s left) kms_addfb_basic (invalid-set-prop-any) [106.225614] Starting subtest: invalid-set-prop-any [106.226308] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.677860] [081/171] (898s left) kms_addfb_basic (no-handle) [106.758314] Starting subtest: no-handle [106.758849] Subtest no-handle: SUCCESS (0.000s) [107.211758] [082/171] (897s left) kms_addfb_basic (size-max) [107.663467] Starting subtest: size-max [107.664104] Subtest size-max: SUCCESS (0.000s) [107.745825] [083/171] (897s left) kms_addfb_basic (small-bo) [108.196210] Starting subtest: small-bo [108.196835] Subtest small-bo: SUCCESS (0.000s) [108.278562] [084/171] (896s left) kms_addfb_basic (tile-pitch-mismatch) [108.358341] Starting subtest: tile-pitch-mismatch [108.358866] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [108.811123] [085/171] (896s left) kms_addfb_basic (too-high) [109.259937] Starting subtest: too-high [109.260770] Subtest too-high: SUCCESS (0.001s) [109.328070] [086/171] (895s left) kms_addfb_basic (too-wide) [109.792488] Starting subtest: too-wide [109.792928] Subtest too-wide: SUCCESS (0.000s) [109.863998] [087/171] (895s left) kms_addfb_basic (unused-handle) [109.946360] Starting subtest: unused-handle [109.946869] Subtest unused-handle: SUCCESS (0.000s) [110.432779] [088/171] (894s left) kms_addfb_basic (unused-modifier) [110.513950] Starting subtest: unused-modifier [110.514509] Subtest unused-modifier: SUCCESS (0.000s) [110.961612] [089/171] (894s left) kms_addfb_basic (unused-offsets) [111.041058] Starting subtest: unused-offsets [111.041761] Subtest unused-offsets: SUCCESS (0.000s) [111.495222] [090/171] (893s left) kms_addfb_basic (unused-pitches) [111.574904] Starting subtest: unused-pitches [111.575637] Subtest unused-pitches: SUCCESS (0.000s) [112.029587] [091/171] (892s left) kms_busy (basic) [112.486429] Starting subtest: basic [112.488565] Starting dynamic subtest: flip [113.135846] Dynamic subtest flip: SUCCESS (0.647s) [113.143211] Starting dynamic subtest: modeset [114.132732] Dynamic subtest modeset: SUCCESS (0.996s) [114.133405] Subtest basic: SUCCESS (1.646s) [114.377064] [092/171] (890s left) kms_chamelium_hpd (dp-hpd-fast) [115.678083] Subtest dp-hpd-fast: SKIP (0.000s) [117.041544] [093/171] (888s left) kms_chamelium_edid (dp-edid-read) [118.319700] Subtest dp-edid-read: SKIP (0.000s) [119.668690] [094/171] (885s left) kms_chamelium_frames (dp-crc-fast) [121.000804] Subtest dp-crc-fast: SKIP (0.000s) [122.370581] [095/171] (882s left) kms_chamelium_hpd (hdmi-hpd-fast) [123.666744] Starting subtest: hdmi-hpd-fast [126.204645] Subtest hdmi-hpd-fast: SUCCESS (2.540s) [127.573855] [096/171] (877s left) kms_chamelium_edid (hdmi-edid-read) [128.868864] Starting subtest: hdmi-edid-read [131.538482] Subtest hdmi-edid-read: SUCCESS (2.669s) [132.916626] [097/171] (872s left) kms_chamelium_frames (hdmi-crc-fast) [134.209706] Starting subtest: hdmi-crc-fast [143.254432] Subtest hdmi-crc-fast: SUCCESS (9.045s) [144.659561] [098/171] (860s left) kms_chamelium_hpd (vga-hpd-fast) [145.968131] Subtest vga-hpd-fast: SKIP (0.000s) [147.335015] [099/171] (857s left) kms_chamelium_edid (vga-edid-read) [148.633491] Subtest vga-edid-read: SKIP (0.000s) [149.993271] [100/171] (855s left) kms_prop_blob (basic) [150.075054] Starting subtest: basic [150.075691] Subtest basic: SUCCESS (0.000s) [150.143582] [101/171] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [150.611992] Starting subtest: basic-busy-flip-before-cursor-atomic [150.613249] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [150.681475] [102/171] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [151.137376] Starting subtest: basic-busy-flip-before-cursor-legacy [151.138709] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [151.190844] [103/171] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [151.655153] Starting subtest: basic-flip-after-cursor-atomic [152.632845] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.977s) [152.875657] [104/171] (852s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [153.323857] Starting subtest: basic-flip-after-cursor-legacy [154.309790] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.984s) [154.542792] [105/171] (850s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [154.979750] Starting subtest: basic-flip-after-cursor-varying-size [155.961128] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.981s) [156.181832] [106/171] (849s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [156.626072] Starting subtest: basic-flip-before-cursor-atomic [157.589363] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.963s) [157.824168] [107/171] (847s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [158.271198] Starting subtest: basic-flip-before-cursor-legacy [159.246872] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.976s) [159.469564] [108/171] (845s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [159.917600] Starting subtest: basic-flip-before-cursor-varying-size [160.893844] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.975s) [161.138059] [109/171] (844s left) kms_flip (basic-flip-vs-dpms) [161.355716] Starting subtest: basic-flip-vs-dpms [161.359728] Starting dynamic subtest: A-DP1 [162.460298] Dynamic subtest A-DP1: SUCCESS (1.099s) [162.469078] Starting dynamic subtest: B-DP1 [163.504887] Dynamic subtest B-DP1: SUCCESS (1.043s) [163.514681] Starting dynamic subtest: C-DP1 [164.576894] Dynamic subtest C-DP1: SUCCESS (1.070s) [164.579097] Subtest basic-flip-vs-dpms: SUCCESS (3.223s) [164.828009] [110/171] (840s left) kms_flip (basic-flip-vs-modeset) [165.045559] Starting subtest: basic-flip-vs-modeset [165.047513] Starting dynamic subtest: A-DP1 [166.168048] Dynamic subtest A-DP1: SUCCESS (1.121s) [166.178658] Starting dynamic subtest: B-DP1 [167.231563] Dynamic subtest B-DP1: SUCCESS (1.060s) [167.241074] Starting dynamic subtest: C-DP1 [168.277714] Dynamic subtest C-DP1: SUCCESS (1.043s) [168.280851] Subtest basic-flip-vs-modeset: SUCCESS (3.234s) [168.530611] [111/171] (836s left) kms_flip (basic-flip-vs-wf_vblank) [168.750049] Starting subtest: basic-flip-vs-wf_vblank [168.753136] Starting dynamic subtest: A-DP1 [170.052201] Dynamic subtest A-DP1: SUCCESS (1.299s) [170.062545] Starting dynamic subtest: B-DP1 [171.325018] Dynamic subtest B-DP1: SUCCESS (1.270s) [171.336159] Starting dynamic subtest: C-DP1 [172.582856] Dynamic subtest C-DP1: SUCCESS (1.255s) [172.586190] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.836s) [172.878070] [112/171] (832s left) kms_flip (basic-plain-flip) [173.094825] Starting subtest: basic-plain-flip [173.098066] Starting dynamic subtest: A-DP1 [174.118833] Dynamic subtest A-DP1: SUCCESS (1.021s) [174.128213] Starting dynamic subtest: B-DP1 [175.093420] Dynamic subtest B-DP1: SUCCESS (0.973s) [175.103694] Starting dynamic subtest: C-DP1 [176.064210] Dynamic subtest C-DP1: SUCCESS (0.968s) [176.071574] Subtest basic-plain-flip: SUCCESS (2.975s) [176.382139] [113/171] (829s left) kms_force_connector_basic (force-connector-state) [176.652539] Starting subtest: force-connector-state [177.609709] Subtest force-connector-state: SUCCESS (0.957s) [178.407155] [114/171] (827s left) kms_force_connector_basic (force-edid) [178.675993] Starting subtest: force-edid [179.025699] Subtest force-edid: SUCCESS (0.351s) [179.551976] [115/171] (825s left) kms_force_connector_basic (force-load-detect) [179.817860] Starting subtest: force-load-detect [179.819147] Subtest force-load-detect: SKIP (0.000s) [180.210865] [116/171] (825s left) kms_force_connector_basic (prune-stale-modes) [180.487435] Starting subtest: prune-stale-modes [180.893518] Subtest prune-stale-modes: SUCCESS (0.405s) [181.419070] [117/171] (824s left) kms_frontbuffer_tracking (basic) [181.877134] Starting subtest: basic [184.521421] Subtest basic: SUCCESS (2.642s) [184.653627] [118/171] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [185.101320] Starting subtest: compare-crc-sanitycheck-xr24 [185.101990] Starting dynamic subtest: pipe-A-DP-1 [185.545537] Dynamic subtest pipe-A-DP-1: SUCCESS (0.443s) [185.557745] Starting dynamic subtest: pipe-B-DP-1 [186.075223] Dynamic subtest pipe-B-DP-1: SUCCESS (0.526s) [186.085707] Starting dynamic subtest: pipe-C-DP-1 [186.660748] Dynamic subtest pipe-C-DP-1: SUCCESS (0.581s) [186.661477] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.560s) [186.908826] [119/171] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [187.349733] Starting subtest: compare-crc-sanitycheck-nv12 [187.352199] Starting dynamic subtest: pipe-A-DP-1 [187.795278] Dynamic subtest pipe-A-DP-1: SUCCESS (0.442s) [187.805429] Starting dynamic subtest: pipe-B-DP-1 [188.344688] Dynamic subtest pipe-B-DP-1: SUCCESS (0.547s) [188.356040] Starting dynamic subtest: pipe-C-DP-1 [188.357119] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [188.357763] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.000s) [188.578958] [120/171] (816s left) kms_pipe_crc_basic (hang-read-crc) [189.023285] Starting subtest: hang-read-crc [189.023903] Starting dynamic subtest: pipe-A-DP-1 [190.159957] Dynamic subtest pipe-A-DP-1: SUCCESS (1.135s) [190.168844] Starting dynamic subtest: pipe-B-DP-1 [191.479811] Dynamic subtest pipe-B-DP-1: SUCCESS (1.315s) [191.486880] Starting dynamic subtest: pipe-C-DP-1 [192.802661] Dynamic subtest pipe-C-DP-1: SUCCESS (1.322s) [192.804920] Subtest hang-read-crc: SUCCESS (3.782s) [193.027929] [121/171] (812s left) kms_pipe_crc_basic (nonblocking-crc) [193.484197] Starting subtest: nonblocking-crc [193.485101] Starting dynamic subtest: pipe-A-DP-1 [194.098042] Dynamic subtest pipe-A-DP-1: SUCCESS (0.611s) [194.107401] Starting dynamic subtest: pipe-B-DP-1 [194.794211] Dynamic subtest pipe-B-DP-1: SUCCESS (0.694s) [194.802481] Starting dynamic subtest: pipe-C-DP-1 [195.517334] Dynamic subtest pipe-C-DP-1: SUCCESS (0.720s) [195.517789] Subtest nonblocking-crc: SUCCESS (2.034s) [195.746528] [122/171] (809s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [196.194014] Starting subtest: nonblocking-crc-frame-sequence [196.196388] Starting dynamic subtest: pipe-A-DP-1 [196.816358] Dynamic subtest pipe-A-DP-1: SUCCESS (0.620s) [196.827859] Starting dynamic subtest: pipe-B-DP-1 [197.506805] Dynamic subtest pipe-B-DP-1: SUCCESS (0.686s) [197.515768] Starting dynamic subtest: pipe-C-DP-1 [198.263949] Dynamic subtest pipe-C-DP-1: SUCCESS (0.753s) [198.264480] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.070s) [198.494636] [123/171] (807s left) kms_pipe_crc_basic (read-crc) [198.949215] Starting subtest: read-crc [198.950070] Starting dynamic subtest: pipe-A-DP-1 [199.480132] Dynamic subtest pipe-A-DP-1: SUCCESS (0.530s) [199.491100] Starting dynamic subtest: pipe-B-DP-1 [200.107148] Dynamic subtest pipe-B-DP-1: SUCCESS (0.625s) [200.116800] Starting dynamic subtest: pipe-C-DP-1 [200.774088] Dynamic subtest pipe-C-DP-1: SUCCESS (0.663s) [200.774671] Subtest read-crc: SUCCESS (1.827s) [200.994398] [124/171] (804s left) kms_pipe_crc_basic (read-crc-frame-sequence) [201.430192] Starting subtest: read-crc-frame-sequence [201.431050] Starting dynamic subtest: pipe-A-DP-1 [201.949371] Dynamic subtest pipe-A-DP-1: SUCCESS (0.517s) [201.960267] Starting dynamic subtest: pipe-B-DP-1 [202.575314] Dynamic subtest pipe-B-DP-1: SUCCESS (0.624s) [202.584803] Starting dynamic subtest: pipe-C-DP-1 [203.238738] Dynamic subtest pipe-C-DP-1: SUCCESS (0.659s) [203.239231] Subtest read-crc-frame-sequence: SUCCESS (1.810s) [203.472654] [125/171] (802s left) kms_psr (primary_page_flip) [203.556192] Subtest primary_page_flip: SKIP (0.000s) [203.580263] [126/171] (802s left) kms_psr (cursor_plane_move) [203.663737] Subtest cursor_plane_move: SKIP (0.000s) [203.694360] [127/171] (801s left) kms_psr (sprite_plane_onoff) [203.774900] Subtest sprite_plane_onoff: SKIP (0.000s) [203.810501] [128/171] (801s left) kms_psr (primary_mmap_gtt) [203.891645] Subtest primary_mmap_gtt: SKIP (0.000s) [203.927419] [129/171] (801s left) kms_setmode (basic-clone-single-crtc) [204.008552] Starting subtest: basic-clone-single-crtc [204.010195] Subtest basic-clone-single-crtc: SKIP (0.000s) [204.067613] [130/171] (801s left) i915_pm_backlight (basic-brightness) [204.520603] Subtest basic-brightness: SKIP (0.000s) [204.546833] [131/171] (801s left) i915_pm_rpm (basic-pci-d3-state) [206.549695] Starting subtest: basic-pci-d3-state [217.330495] Subtest basic-pci-d3-state: FAIL (10.777s) [217.710060] [132/171] (788s left) i915_pm_rpm (basic-rte) [217.795619] Starting subtest: basic-rte [230.437455] Subtest basic-rte: FAIL (12.606s) [241.434792] [133/171] (764s left) i915_pm_rps (basic-api) [241.539134] Starting subtest: basic-api [241.542544] Subtest basic-api: SUCCESS (0.003s) [241.601815] [134/171] (764s left) prime_self_import (basic-llseek-bad) [241.679897] Starting subtest: basic-llseek-bad [241.682714] Subtest basic-llseek-bad: SUCCESS (0.002s) [241.783725] [135/171] (764s left) prime_self_import (basic-llseek-size) [241.884270] Starting subtest: basic-llseek-size [241.887327] Subtest basic-llseek-size: SUCCESS (0.003s) [241.952919] [136/171] (763s left) prime_self_import (basic-with_fd_dup) [242.036640] Starting subtest: basic-with_fd_dup [242.039531] Subtest basic-with_fd_dup: SUCCESS (0.003s) [242.122420] [137/171] (763s left) prime_self_import (basic-with_one_bo) [242.207981] Starting subtest: basic-with_one_bo [242.211691] Subtest basic-with_one_bo: SUCCESS (0.004s) [242.259810] [138/171] (763s left) prime_self_import (basic-with_one_bo_two_files) [242.336947] Starting subtest: basic-with_one_bo_two_files [242.339817] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [242.429900] [139/171] (763s left) prime_self_import (basic-with_two_bos) [242.518708] Starting subtest: basic-with_two_bos [242.521621] Subtest basic-with_two_bos: SUCCESS (0.003s) [242.609771] [140/171] (763s left) prime_vgem (basic-fence-flip) [242.724249] Starting subtest: basic-fence-flip [243.518795] Subtest basic-fence-flip: SUCCESS (0.794s) [243.618954] [141/171] (762s left) prime_vgem (basic-fence-mmap) [243.708219] Starting subtest: basic-fence-mmap [243.734372] Subtest basic-fence-mmap: SUCCESS (0.026s) [243.836842] [142/171] (762s left) prime_vgem (basic-fence-read) [243.957139] Starting subtest: basic-fence-read [243.998913] Subtest basic-fence-read: SUCCESS (0.042s) [244.117542] [143/171] (761s left) prime_vgem (basic-gtt) [244.225540] Starting subtest: basic-gtt [244.237274] Subtest basic-gtt: SUCCESS (0.012s) [244.322257] [144/171] (761s left) prime_vgem (basic-read) [244.431102] Starting subtest: basic-read [244.449868] Subtest basic-read: SUCCESS (0.019s) [244.552993] [145/171] (761s left) prime_vgem (basic-write) [244.673776] Starting subtest: basic-write [244.694603] Subtest basic-write: SUCCESS (0.021s) [244.753597] [146/171] (761s left) vgem_basic (setversion) [244.851641] Starting subtest: setversion [244.852914] Subtest setversion: SUCCESS (0.000s) [244.902822] [147/171] (761s left) vgem_basic (create) [244.985140] Starting subtest: create [244.985808] Subtest create: SUCCESS (0.000s) [245.035316] [148/171] (761s left) vgem_basic (debugfs) [245.118223] Starting subtest: debugfs [245.118775] Subtest debugfs: SUCCESS (0.000s) [245.167947] [149/171] (760s left) vgem_basic (dmabuf-export) [245.251940] Starting subtest: dmabuf-export [245.254968] Subtest dmabuf-export: SUCCESS (0.002s) [245.346391] [150/171] (760s left) vgem_basic (dmabuf-fence) [245.451753] Starting subtest: dmabuf-fence [245.454142] Subtest dmabuf-fence: SUCCESS (0.001s) [245.503236] [151/171] (760s left) vgem_basic (dmabuf-fence-before) [245.601840] Starting subtest: dmabuf-fence-before [245.602469] Subtest dmabuf-fence-before: SUCCESS (0.000s) [245.653557] [152/171] (760s left) vgem_basic (dmabuf-mmap) [245.752197] Starting subtest: dmabuf-mmap [245.765969] Subtest dmabuf-mmap: SUCCESS (0.014s) [245.820981] [153/171] (760s left) vgem_basic (mmap) [245.918964] Starting subtest: mmap [245.928622] Subtest mmap: SUCCESS (0.010s) [245.969426] [154/171] (760s left) vgem_basic (second-client) [246.051360] Starting subtest: second-client [246.084657] Subtest second-client: SUCCESS (0.033s) [246.170881] [155/171] (760s left) vgem_basic (sysfs) [246.268490] Starting subtest: sysfs [246.269198] Subtest sysfs: SUCCESS (0.001s) [246.317941] [156/171] (759s left) core_hotunplug (unbind-rebind) [246.484885] Starting subtest: unbind-rebind [248.474779] Subtest unbind-rebind: SUCCESS (1.990s) [248.515775] [157/171] (757s left) vgem_basic (unload) [248.611479] Starting subtest: unload [277.607264] Subtest unload: SUCCESS (28.994s) [277.744984] [158/171] (728s left) i915_module_load (reload) [277.830551] Starting subtest: reload [280.990107] Subtest reload: SUCCESS (3.150s) [281.006092] [159/171] (725s left) gem_lmem_swapping (basic) [281.115952] Subtest basic: SKIP (0.000s) [281.153035] [160/171] (725s left) gem_lmem_swapping (parallel-random-engines) [281.238065] Subtest parallel-random-engines: SKIP (0.000s) [281.269831] [161/171] (725s left) gem_lmem_swapping (random-engines) [281.354760] Subtest random-engines: SKIP (0.000s) [281.386525] [162/171] (725s left) gem_lmem_swapping (verify-random) [281.471587] Subtest verify-random: SKIP (0.000s) [281.503408] [163/171] (724s left) i915_pm_rpm (module-reload) [283.967231] Starting subtest: module-reload [303.653378] Subtest module-reload: FAIL (19.629s) [304.093392] [164/171] (702s left) i915_selftest (live) [304.946084] Starting subtest: live [304.951371] Starting dynamic subtest: sanitycheck [306.190923] Dynamic subtest sanitycheck: SUCCESS (1.242s) [306.198778] Starting dynamic subtest: uncore [307.414339] Dynamic subtest uncore: SUCCESS (1.222s) [307.422254] Starting dynamic subtest: workarounds [308.900521] Dynamic subtest workarounds: SUCCESS (1.485s) [308.908680] Starting dynamic subtest: gt_engines [310.694431] Dynamic subtest gt_engines: SUCCESS (1.792s) [310.701336] Starting dynamic subtest: gt_timelines [321.719405] Dynamic subtest gt_timelines: SUCCESS (11.023s) [321.728860] Starting dynamic subtest: gt_contexts [323.059510] Dynamic subtest gt_contexts: SUCCESS (1.338s) [323.067379] Starting dynamic subtest: gt_lrc [327.443478] Dynamic subtest gt_lrc: SUCCESS (4.382s) [327.450938] Starting dynamic subtest: gt_mocs [328.780861] Dynamic subtest gt_mocs: SUCCESS (1.336s) [328.790841] Starting dynamic subtest: gt_pm [335.930683] Dynamic subtest gt_pm: SUCCESS (7.148s) [335.939265] Starting dynamic subtest: gt_heartbeat [337.363548] Dynamic subtest gt_heartbeat: SUCCESS (1.431s) [337.371652] Starting dynamic subtest: gt_tlb [339.618544] Dynamic subtest gt_tlb: SUCCESS (2.253s) [339.627074] Starting dynamic subtest: requests [348.368695] Dynamic subtest requests: SUCCESS (8.748s) [348.378091] Starting dynamic subtest: migrate [352.317504] Dynamic subtest migrate: SUCCESS (3.947s) [352.326042] Starting dynamic subtest: active [353.570798] Dynamic subtest active: SUCCESS (1.251s) [353.578742] Starting dynamic subtest: objects [355.746609] Dynamic subtest objects: SUCCESS (2.174s) [355.754222] Starting dynamic subtest: mman [360.847451] Dynamic subtest mman: SUCCESS (5.099s) [360.856344] Starting dynamic subtest: dmabuf [362.136596] Dynamic subtest dmabuf: SUCCESS (1.287s) [362.143015] Starting dynamic subtest: vma [363.363541] Dynamic subtest vma: SUCCESS (1.225s) [363.371519] Starting dynamic subtest: coherency [365.594513] Dynamic subtest coherency: SUCCESS (2.229s) [365.603839] Starting dynamic subtest: gtt [374.334574] Dynamic subtest gtt: SUCCESS (8.738s) [374.342061] Starting dynamic subtest: gem [375.870735] Dynamic subtest gem: SUCCESS (1.534s) [375.878212] Starting dynamic subtest: evict [378.649585] Dynamic subtest evict: SUCCESS (2.777s) [378.657227] Starting dynamic subtest: hugepages [385.860396] Dynamic subtest hugepages: SUCCESS (7.209s) [385.867192] Starting dynamic subtest: gem_contexts [402.890528] Dynamic subtest gem_contexts: SUCCESS (17.028s) [402.899764] Starting dynamic subtest: client [404.144496] Dynamic subtest client: SUCCESS (1.252s) [404.151048] Starting dynamic subtest: gem_migrate [405.391626] Dynamic subtest gem_migrate: SUCCESS (1.245s) [405.399954] Starting dynamic subtest: reset [407.330850] Dynamic subtest reset: SUCCESS (1.937s) [407.338263] Starting dynamic subtest: memory_region [408.580738] Dynamic subtest memory_region: SUCCESS (1.248s) [408.588329] Starting dynamic subtest: hangcheck [438.447526] Dynamic subtest hangcheck: SUCCESS (29.865s) [438.454371] Starting dynamic subtest: execlists [452.128593] Dynamic subtest execlists: SUCCESS (13.679s) [452.135759] Starting dynamic subtest: ring_submission [453.364714] Dynamic subtest ring_submission: SUCCESS (1.234s) [453.373814] Starting dynamic subtest: perf [454.788838] Dynamic subtest perf: SUCCESS (1.423s) [454.796866] Starting dynamic subtest: slpc [456.033506] Dynamic subtest slpc: SUCCESS (1.243s) [456.040060] Starting dynamic subtest: guc [457.286780] Dynamic subtest guc: SUCCESS (1.252s) [457.295036] Starting dynamic subtest: guc_multi_lrc [458.529680] Dynamic subtest guc_multi_lrc: SUCCESS (1.241s) [458.538792] Starting dynamic subtest: guc_hang [459.780770] Dynamic subtest guc_hang: SUCCESS (1.249s) [459.789890] Starting dynamic subtest: late_gt_pm [461.041749] Dynamic subtest late_gt_pm: SUCCESS (1.259s) [461.042539] Subtest live: SUCCESS (156.098s) [461.255350] [165/171] (545s left) dmabuf (all-tests) [461.362129] Starting subtest: all-tests [461.365921] Starting dynamic subtest: sanitycheck [461.431280] Dynamic subtest sanitycheck: SUCCESS (0.069s) [461.445546] Starting dynamic subtest: dma_fence [461.622221] Dynamic subtest dma_fence: SUCCESS (0.188s) [461.633935] Starting dynamic subtest: dma_fence_chain [475.793749] Dynamic subtest dma_fence_chain: SUCCESS (14.169s) [475.825319] Starting dynamic subtest: dma_fence_unwrap [475.882535] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [475.913487] Starting dynamic subtest: dma_resv [475.971063] Dynamic subtest dma_resv: SUCCESS (0.084s) [475.972181] Subtest all-tests: SUCCESS (14.611s) [475.997769] [166/171] (530s left) i915_suspend (basic-s2idle-without-i915) [476.083380] Starting subtest: basic-s2idle-without-i915 [496.046721] Subtest basic-s2idle-without-i915: SUCCESS (5.059s) [499.435851] [167/171] (524s left) i915_suspend (basic-s3-without-i915) [499.519225] Starting subtest: basic-s3-without-i915 [519.192954] Subtest basic-s3-without-i915: SUCCESS (4.885s) [521.361190] [168/171] (519s left) gem_exec_suspend (basic-s0) [521.462485] Starting subtest: basic-S0 [521.464440] Starting dynamic subtest: smem [540.569147] Dynamic subtest smem: SUCCESS (3.374s) [540.569985] Subtest basic-S0: SUCCESS (3.376s) [543.706448] [169/171] (516s left) gem_exec_suspend (basic-s3) [543.799551] Starting subtest: basic-S3 [543.801967] Starting dynamic subtest: smem [563.141569] Dynamic subtest smem: SUCCESS (5.170s) [563.142610] Subtest basic-S3: SUCCESS (5.172s) [565.300284] [170/171] (510s left) kms_chamelium_hpd (common-hpd-after-suspend) [566.650091] Starting subtest: common-hpd-after-suspend [608.883024] Subtest common-hpd-after-suspend: SUCCESS (11.783s) [610.212352] [171/171] (496s left) kms_pipe_crc_basic (suspend-read-crc) [610.670241] Starting subtest: suspend-read-crc [610.670850] Starting dynamic subtest: pipe-A-DP-1 [629.686805] Dynamic subtest pipe-A-DP-1: SUCCESS (3.903s) [629.698232] Starting dynamic subtest: pipe-B-DP-1 [648.731200] Dynamic subtest pipe-B-DP-1: SUCCESS (4.013s) [648.740559] Starting dynamic subtest: pipe-C-DP-1 [667.934069] Dynamic subtest pipe-C-DP-1: SUCCESS (4.104s) [668.047463] Subtest suspend-read-crc: SUCCESS (12.029s) [670.154715] Closing watchdogs Done.