[81.345595] Initializing watchdogs [81.345757] /dev/watchdog0 [81.355376] [001/171] (960s left) i915_module_load (load) [81.651430] Starting subtest: load [84.195945] Subtest load: SUCCESS (2.544s) [84.219980] [002/171] (957s left) core_auth (basic-auth) [84.357723] Starting subtest: basic-auth [84.358808] Subtest basic-auth: SUCCESS (0.002s) [84.432214] [003/171] (957s left) debugfs_test (read_all_entries) [84.577444] Starting subtest: read_all_entries [84.646609] Subtest read_all_entries: SUCCESS (0.069s) [84.759531] [004/171] (957s left) debugfs_test (basic-hwmon) [84.895544] Starting subtest: basic-hwmon [84.897848] Subtest basic-hwmon: SKIP (0.000s) [84.997477] [005/171] (956s left) fbdev (eof) [85.162482] Starting subtest: eof [85.163836] Subtest eof: SUCCESS (0.000s) [85.243376] [006/171] (956s left) fbdev (info) [85.375083] Starting subtest: info [85.376333] Subtest info: SUCCESS (0.000s) [85.444900] [007/171] (956s left) fbdev (nullptr) [85.578716] Starting subtest: nullptr [85.579974] Subtest nullptr: SUCCESS (0.000s) [85.646112] [008/171] (956s left) fbdev (read) [85.796995] Starting subtest: read [92.904948] Subtest read: SUCCESS (7.074s) [92.944279] [009/171] (949s left) fbdev (write) [93.079731] Starting subtest: write [96.863491] Subtest write: SUCCESS (3.749s) [96.910485] [010/171] (945s left) gem_basic (bad-close) [97.040502] Starting subtest: bad-close [97.042683] Subtest bad-close: SUCCESS (0.000s) [97.127697] [011/171] (944s left) gem_basic (create-close) [97.264441] Starting subtest: create-close [97.266437] Subtest create-close: SUCCESS (0.000s) [97.377168] [012/171] (944s left) gem_basic (create-fd-close) [97.512601] Starting subtest: create-fd-close [97.514624] Subtest create-fd-close: SUCCESS (0.000s) [97.609828] [013/171] (944s left) gem_busy (busy@all-engines) [97.765756] Starting subtest: busy [97.766971] Starting dynamic subtest: all-engines [97.819397] Dynamic subtest all-engines: SUCCESS (0.056s) [97.820743] Subtest busy: SUCCESS (0.056s) [98.211622] [014/171] (943s left) gem_close_race (basic-process) [98.367182] Starting subtest: basic-process [98.434536] Subtest basic-process: SUCCESS (0.067s) [98.627707] [015/171] (943s left) gem_close_race (basic-threads) [98.784210] Starting subtest: basic-threads [99.952351] Subtest basic-threads: SUCCESS (1.168s) [100.173439] [016/171] (942s left) gem_ctx_create (basic) [100.329526] Starting subtest: basic [100.330788] Subtest basic: SUCCESS (0.000s) [100.528837] [017/171] (941s left) gem_ctx_create (basic-files) [100.679545] Starting subtest: basic-files [102.702427] Subtest basic-files: SUCCESS (2.023s) [102.975651] [018/171] (939s left) gem_ctx_exec (basic) [103.120584] Starting subtest: basic [103.125528] Subtest basic: SUCCESS (0.005s) [103.259773] [019/171] (939s left) gem_exec_basic (basic) [103.404393] Starting subtest: basic [103.405536] Starting dynamic subtest: rcs0-smem [103.406643] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [103.417527] Starting dynamic subtest: bcs0-smem [103.418748] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [103.429046] Starting dynamic subtest: vcs0-smem [103.430457] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [103.440623] Starting dynamic subtest: vecs0-smem [103.441957] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [103.443254] Subtest basic: SUCCESS (0.005s) [103.611314] [020/171] (938s left) gem_exec_create (basic) [103.761628] Starting subtest: basic [103.762820] Starting dynamic subtest: smem [105.835909] Dynamic subtest smem: SUCCESS (2.049s) [105.838108] Subtest basic: SUCCESS (2.050s) [106.030450] [021/171] (936s left) gem_exec_fence (basic-busy) [106.322742] Starting subtest: basic-busy [106.324229] Starting dynamic subtest: rcs0 [106.335390] Dynamic subtest rcs0: SUCCESS (0.018s) [106.345986] Starting dynamic subtest: bcs0 [106.363306] Dynamic subtest bcs0: SUCCESS (0.027s) [106.380910] Starting dynamic subtest: vcs0 [106.390613] Dynamic subtest vcs0: SUCCESS (0.027s) [106.401847] Starting dynamic subtest: vecs0 [106.411405] Dynamic subtest vecs0: SUCCESS (0.021s) [106.412844] Subtest basic-busy: SUCCESS (0.094s) [107.029185] [022/171] (935s left) gem_exec_fence (basic-wait) [107.341568] Starting subtest: basic-wait [107.342766] Starting dynamic subtest: rcs0 [107.357411] Dynamic subtest rcs0: SUCCESS (0.024s) [107.369641] Starting dynamic subtest: bcs0 [107.383573] Dynamic subtest bcs0: SUCCESS (0.026s) [107.395543] Starting dynamic subtest: vcs0 [107.414648] Dynamic subtest vcs0: SUCCESS (0.031s) [107.425725] Starting dynamic subtest: vecs0 [107.433465] Dynamic subtest vecs0: SUCCESS (0.019s) [107.434635] Subtest basic-wait: SUCCESS (0.101s) [107.963178] [023/171] (934s left) gem_exec_fence (basic-await) [108.264110] Starting subtest: basic-await [108.265292] Starting dynamic subtest: rcs0 [108.355467] Dynamic subtest rcs0: SUCCESS (0.098s) [108.381471] Starting dynamic subtest: bcs0 [108.481225] Dynamic subtest bcs0: SUCCESS (0.126s) [108.508849] Starting dynamic subtest: vcs0 [108.618653] Dynamic subtest vcs0: SUCCESS (0.128s) [108.644488] Starting dynamic subtest: vecs0 [108.738415] Dynamic subtest vecs0: SUCCESS (0.128s) [108.740405] Subtest basic-await: SUCCESS (0.482s) [109.346158] [024/171] (933s left) gem_exec_fence (nb-await) [109.645385] Starting subtest: nb-await [109.646524] Starting dynamic subtest: rcs0 [109.701239] Dynamic subtest rcs0: SUCCESS (0.063s) [109.721891] Starting dynamic subtest: bcs0 [109.772781] Dynamic subtest bcs0: SUCCESS (0.071s) [109.799973] Starting dynamic subtest: vcs0 [109.849242] Dynamic subtest vcs0: SUCCESS (0.076s) [109.875367] Starting dynamic subtest: vecs0 [109.923655] Dynamic subtest vecs0: SUCCESS (0.074s) [109.927311] Subtest nb-await: SUCCESS (0.286s) [110.496723] [025/171] (931s left) gem_exec_gttfill (basic) [110.650450] Starting subtest: basic [118.363169] Subtest basic: SUCCESS (7.704s) [118.549574] [026/171] (923s left) gem_exec_parallel (engines) [118.768624] Starting subtest: engines [118.769846] Starting dynamic subtest: basic [121.283204] Dynamic subtest basic: SUCCESS (2.495s) [121.309581] Starting dynamic subtest: contexts [124.656409] Dynamic subtest contexts: SUCCESS (3.384s) [124.671181] Starting dynamic subtest: fds [129.748533] Dynamic subtest fds: SUCCESS (5.100s) [129.763211] Starting dynamic subtest: userptr [132.297629] Dynamic subtest userptr: SUCCESS (2.519s) [132.299483] Subtest engines: SUCCESS (13.499s) [132.466345] [027/171] (910s left) gem_exec_store (basic) [132.617864] Starting subtest: basic [132.679054] Subtest basic: SUCCESS (0.061s) [132.881305] [028/171] (909s left) gem_flink_basic (bad-flink) [133.016270] Starting subtest: bad-flink [133.019221] Subtest bad-flink: SUCCESS (0.000s) [133.096718] [029/171] (909s left) gem_flink_basic (bad-open) [133.231400] Starting subtest: bad-open [133.232594] Subtest bad-open: SUCCESS (0.000s) [133.314366] [030/171] (909s left) gem_flink_basic (basic) [133.450693] Starting subtest: basic [133.451815] Subtest basic: SUCCESS (0.000s) [133.547772] [031/171] (909s left) gem_flink_basic (double-flink) [133.683369] Starting subtest: double-flink [133.684406] Subtest double-flink: SUCCESS (0.000s) [133.780485] [032/171] (908s left) gem_flink_basic (flink-lifetime) [133.935394] Starting subtest: flink-lifetime [133.936595] Subtest flink-lifetime: SUCCESS (0.002s) [134.031278] [033/171] (908s left) gem_huc_copy (huc-copy) [134.183272] Starting subtest: huc-copy [134.185608] Subtest huc-copy: SKIP (0.000s) [134.284573] [034/171] (908s left) gem_linear_blits (basic) [134.584930] Starting subtest: basic [134.597306] Subtest basic: SUCCESS (0.012s) [134.715515] [035/171] (907s left) gem_mmap (basic) [134.914630] Starting subtest: basic [134.920138] Subtest basic: SUCCESS (0.001s) [135.014104] [036/171] (907s left) gem_mmap_gtt (basic) [135.152207] Starting subtest: basic [135.153433] Subtest basic: SUCCESS (0.001s) [135.229245] [037/171] (907s left) gem_render_linear_blits (basic) [135.368049] Starting subtest: basic [135.417217] Subtest basic: SUCCESS (0.049s) [135.480511] [038/171] (907s left) gem_render_tiled_blits (basic) [135.620953] Starting subtest: basic [135.681427] Subtest basic: SUCCESS (0.060s) [135.747998] [039/171] (907s left) gem_ringfill (basic-all) [136.033829] Starting subtest: basic-all [137.288603] Subtest basic-all: SUCCESS (1.245s) [137.364902] [040/171] (905s left) gem_softpin (allocator-basic) [137.510349] Starting subtest: allocator-basic [137.678565] Subtest allocator-basic: SUCCESS (0.160s) [137.781384] [041/171] (905s left) gem_softpin (allocator-basic-reserve) [137.935374] Starting subtest: allocator-basic-reserve [138.101543] Subtest allocator-basic-reserve: SUCCESS (0.157s) [138.215569] [042/171] (904s left) gem_softpin (safe-alignment) [138.366240] Starting subtest: safe-alignment [138.383564] Subtest safe-alignment: SUCCESS (0.017s) [138.497236] [043/171] (904s left) gem_sync (basic-all) [138.642693] Starting subtest: basic-all [140.988423] Subtest basic-all: SUCCESS (2.321s) [141.169672] [044/171] (901s left) gem_sync (basic-each) [141.323381] Starting subtest: basic-each [143.499328] Subtest basic-each: SUCCESS (2.176s) [143.724515] [045/171] (899s left) gem_tiled_blits (basic) [143.999593] Starting subtest: basic [144.029837] Subtest basic: SUCCESS (0.029s) [144.165482] [046/171] (898s left) gem_tiled_fence_blits (basic) [144.506938] Starting subtest: basic [144.533853] Subtest basic: SUCCESS (0.027s) [144.677786] [047/171] (898s left) gem_tiled_pread_basic [145.215424] [048/171] (897s left) gem_wait (busy@all-engines) [145.379084] Starting subtest: busy [145.380370] Starting dynamic subtest: all-engines [145.929401] Dynamic subtest all-engines: SUCCESS (0.551s) [145.930519] Subtest busy: SUCCESS (0.551s) [146.165489] [049/171] (896s left) gem_wait (wait@all-engines) [146.326072] Starting subtest: wait [146.327398] Starting dynamic subtest: all-engines [147.357367] Dynamic subtest all-engines: SUCCESS (1.031s) [147.358624] Subtest wait: SUCCESS (1.032s) [147.598975] [050/171] (895s left) i915_getparams_basic (basic-eu-total) [147.733285] Starting subtest: basic-eu-total [147.735630] Subtest basic-eu-total: SUCCESS (0.000s) [147.813978] [051/171] (895s left) i915_getparams_basic (basic-subslice-total) [147.949575] Starting subtest: basic-subslice-total [147.951959] Subtest basic-subslice-total: SUCCESS (0.000s) [148.031706] [052/171] (895s left) i915_hangman (error-state-basic) [148.184143] Starting subtest: error-state-basic [148.194238] Subtest error-state-basic: SUCCESS (0.010s) [148.280951] [053/171] (894s left) i915_pciid [148.497943] [054/171] (894s left) kms_addfb_basic (addfb25-bad-modifier) [148.636823] Starting subtest: addfb25-bad-modifier [148.638105] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [148.780028] [055/171] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [148.918726] Starting subtest: addfb25-framebuffer-vs-set-tiling [148.920679] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [149.048775] [056/171] (894s left) kms_addfb_basic (addfb25-modifier-no-flag) [149.185449] Starting subtest: addfb25-modifier-no-flag [149.186515] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [149.314238] [057/171] (893s left) kms_addfb_basic (addfb25-x-tiled-legacy) [149.449620] Starting subtest: addfb25-x-tiled-legacy [149.450774] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [149.580695] [058/171] (893s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [149.717399] Starting subtest: addfb25-x-tiled-mismatch-legacy [149.718454] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [149.847350] [059/171] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [150.014519] Starting subtest: addfb25-yf-tiled-legacy [150.015637] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [150.114185] [060/171] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy) [150.279700] Starting subtest: addfb25-y-tiled-legacy [150.280823] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [150.381295] [061/171] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [150.545932] Starting subtest: addfb25-y-tiled-small-legacy [150.547148] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [150.646659] [062/171] (892s left) kms_addfb_basic (bad-pitch-0) [150.782975] Starting subtest: bad-pitch-0 [150.784236] Subtest bad-pitch-0: SUCCESS (0.000s) [150.896979] [063/171] (892s left) kms_addfb_basic (bad-pitch-1024) [151.033598] Starting subtest: bad-pitch-1024 [151.034669] Subtest bad-pitch-1024: SUCCESS (0.000s) [151.163548] [064/171] (892s left) kms_addfb_basic (bad-pitch-128) [151.300767] Starting subtest: bad-pitch-128 [151.301943] Subtest bad-pitch-128: SUCCESS (0.000s) [151.431435] [065/171] (892s left) kms_addfb_basic (bad-pitch-256) [151.574345] Starting subtest: bad-pitch-256 [151.575585] Subtest bad-pitch-256: SUCCESS (0.000s) [151.697428] [066/171] (891s left) kms_addfb_basic (bad-pitch-32) [151.832651] Starting subtest: bad-pitch-32 [151.833809] Subtest bad-pitch-32: SUCCESS (0.000s) [151.965118] [067/171] (891s left) kms_addfb_basic (bad-pitch-63) [152.100725] Starting subtest: bad-pitch-63 [152.101888] Subtest bad-pitch-63: SUCCESS (0.000s) [152.230914] [068/171] (891s left) kms_addfb_basic (bad-pitch-65536) [152.367029] Starting subtest: bad-pitch-65536 [152.368157] Subtest bad-pitch-65536: SUCCESS (0.000s) [152.497499] [069/171] (891s left) kms_addfb_basic (bad-pitch-999) [152.633476] Starting subtest: bad-pitch-999 [152.634546] Subtest bad-pitch-999: SUCCESS (0.000s) [152.764082] [070/171] (890s left) kms_addfb_basic (basic) [152.901837] Starting subtest: basic [152.903255] Subtest basic: SUCCESS (0.000s) [153.031077] [071/171] (890s left) kms_addfb_basic (basic-x-tiled-legacy) [153.169495] Starting subtest: basic-x-tiled-legacy [153.170579] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [153.301375] [072/171] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [153.439330] Starting subtest: basic-y-tiled-legacy [153.440386] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [153.564062] [073/171] (890s left) kms_addfb_basic (bo-too-small) [153.727950] Starting subtest: bo-too-small [153.729247] Subtest bo-too-small: SUCCESS (0.000s) [153.813272] [074/171] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling) [153.977095] Starting subtest: bo-too-small-due-to-tiling [153.978317] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [154.080320] [075/171] (889s left) kms_addfb_basic (clobberred-modifier) [154.217103] Starting subtest: clobberred-modifier [154.218263] Subtest clobberred-modifier: SUCCESS (0.000s) [154.347378] [076/171] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [154.484798] Starting subtest: framebuffer-vs-set-tiling [154.486116] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [154.615442] [077/171] (889s left) kms_addfb_basic (invalid-get-prop) [154.752034] Starting subtest: invalid-get-prop [154.753245] Subtest invalid-get-prop: SUCCESS (0.000s) [154.880510] [078/171] (888s left) kms_addfb_basic (invalid-get-prop-any) [155.009104] Starting subtest: invalid-get-prop-any [155.010177] Subtest invalid-get-prop-any: SUCCESS (0.000s) [155.131187] [079/171] (888s left) kms_addfb_basic (invalid-set-prop) [155.268879] Starting subtest: invalid-set-prop [155.269962] Subtest invalid-set-prop: SUCCESS (0.000s) [155.397907] [080/171] (888s left) kms_addfb_basic (invalid-set-prop-any) [155.532626] Starting subtest: invalid-set-prop-any [155.533793] Subtest invalid-set-prop-any: SUCCESS (0.000s) [155.664072] [081/171] (888s left) kms_addfb_basic (no-handle) [155.800262] Starting subtest: no-handle [155.801326] Subtest no-handle: SUCCESS (0.000s) [155.931045] [082/171] (888s left) kms_addfb_basic (size-max) [156.092635] Starting subtest: size-max [156.093787] Subtest size-max: SUCCESS (0.000s) [156.197499] [083/171] (887s left) kms_addfb_basic (small-bo) [156.365354] Starting subtest: small-bo [156.366527] Subtest small-bo: SUCCESS (0.000s) [156.485244] [084/171] (887s left) kms_addfb_basic (tile-pitch-mismatch) [156.619528] Starting subtest: tile-pitch-mismatch [156.620610] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [156.747562] [085/171] (887s left) kms_addfb_basic (too-high) [156.910452] Starting subtest: too-high [156.911715] Subtest too-high: SUCCESS (0.001s) [157.013444] [086/171] (887s left) kms_addfb_basic (too-wide) [157.178559] Starting subtest: too-wide [157.179904] Subtest too-wide: SUCCESS (0.000s) [157.302649] [087/171] (886s left) kms_addfb_basic (unused-handle) [157.439875] Starting subtest: unused-handle [157.441176] Subtest unused-handle: SUCCESS (0.000s) [157.583286] [088/171] (886s left) kms_addfb_basic (unused-modifier) [157.720921] Starting subtest: unused-modifier [157.722222] Subtest unused-modifier: SUCCESS (0.000s) [157.847747] [089/171] (886s left) kms_addfb_basic (unused-offsets) [157.976996] Starting subtest: unused-offsets [157.978156] Subtest unused-offsets: SUCCESS (0.000s) [158.114942] [090/171] (886s left) kms_addfb_basic (unused-pitches) [158.250995] Starting subtest: unused-pitches [158.252159] Subtest unused-pitches: SUCCESS (0.000s) [158.380705] [091/171] (885s left) kms_busy (basic) [158.568261] Starting subtest: basic [158.570626] Starting dynamic subtest: flip [159.555225] Dynamic subtest flip: SUCCESS (0.980s) [159.570706] Starting dynamic subtest: modeset [163.442956] Dynamic subtest modeset: SUCCESS (3.890s) [163.446249] Subtest basic: SUCCESS (4.873s) [164.411529] [092/171] (879s left) kms_chamelium_hpd (dp-hpd-fast) [164.897559] Subtest dp-hpd-fast: SKIP (0.000s) [165.769287] [093/171] (878s left) kms_chamelium_edid (dp-edid-read) [166.252272] Subtest dp-edid-read: SKIP (0.000s) [167.111536] [094/171] (877s left) kms_chamelium_frames (dp-crc-fast) [167.593916] Subtest dp-crc-fast: SKIP (0.000s) [168.455926] [095/171] (875s left) kms_chamelium_hpd (hdmi-hpd-fast) [168.941678] Subtest hdmi-hpd-fast: SKIP (0.000s) [169.799086] [096/171] (874s left) kms_chamelium_edid (hdmi-edid-read) [170.281929] Subtest hdmi-edid-read: SKIP (0.000s) [171.142763] [097/171] (873s left) kms_chamelium_frames (hdmi-crc-fast) [171.623413] Subtest hdmi-crc-fast: SKIP (0.000s) [172.489921] [098/171] (871s left) kms_chamelium_hpd (vga-hpd-fast) [172.975152] Subtest vga-hpd-fast: SKIP (0.000s) [173.895046] [099/171] (870s left) kms_chamelium_edid (vga-edid-read) [174.377347] Subtest vga-edid-read: SKIP (0.000s) [175.239065] [100/171] (869s left) kms_prop_blob (basic) [175.377892] Starting subtest: basic [175.379140] Subtest basic: SUCCESS (0.000s) [175.459428] [101/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [175.623867] Starting subtest: basic-busy-flip-before-cursor-atomic [175.626031] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [175.704324] [102/171] (868s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [175.861624] Starting subtest: basic-busy-flip-before-cursor-legacy [175.863819] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [175.938845] [103/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [176.102332] Starting subtest: basic-flip-after-cursor-atomic [177.383213] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.281s) [178.297572] [104/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [178.462017] Starting subtest: basic-flip-after-cursor-legacy [179.756193] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.294s) [180.728500] [105/171] (863s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [180.891111] Starting subtest: basic-flip-after-cursor-varying-size [182.187347] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.295s) [183.164510] [106/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [183.328403] Starting subtest: basic-flip-before-cursor-atomic [184.623193] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.295s) [185.592789] [107/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [185.749538] Starting subtest: basic-flip-before-cursor-legacy [187.036452] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.287s) [187.960814] [108/171] (856s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [188.127132] Starting subtest: basic-flip-before-cursor-varying-size [189.409662] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.282s) [190.327869] [109/171] (854s left) kms_flip (basic-flip-vs-dpms) [190.473149] Starting subtest: basic-flip-vs-dpms [190.476104] Starting dynamic subtest: A-eDP1 [193.348061] Dynamic subtest A-eDP1: SUCCESS (2.860s) [193.362354] Starting dynamic subtest: B-eDP1 [195.684329] Dynamic subtest B-eDP1: SUCCESS (2.348s) [195.700547] Starting dynamic subtest: C-eDP1 [198.073852] Dynamic subtest C-eDP1: SUCCESS (2.388s) [198.078612] Subtest basic-flip-vs-dpms: SUCCESS (7.604s) [198.979824] [110/171] (845s left) kms_flip (basic-flip-vs-modeset) [199.123325] Starting subtest: basic-flip-vs-modeset [199.126527] Starting dynamic subtest: A-eDP1 [201.969203] Dynamic subtest A-eDP1: SUCCESS (2.843s) [201.985486] Starting dynamic subtest: B-eDP1 [204.339500] Dynamic subtest B-eDP1: SUCCESS (2.369s) [204.356901] Starting dynamic subtest: C-eDP1 [206.709377] Dynamic subtest C-eDP1: SUCCESS (2.369s) [206.713108] Subtest basic-flip-vs-modeset: SUCCESS (7.589s) [207.674965] [111/171] (837s left) kms_flip (basic-flip-vs-wf_vblank) [207.820237] Starting subtest: basic-flip-vs-wf_vblank [207.823441] Starting dynamic subtest: A-eDP1 [210.138465] Dynamic subtest A-eDP1: SUCCESS (2.316s) [210.154567] Starting dynamic subtest: B-eDP1 [212.423634] Dynamic subtest B-eDP1: SUCCESS (2.284s) [212.440067] Starting dynamic subtest: C-eDP1 [214.729834] Dynamic subtest C-eDP1: SUCCESS (2.305s) [214.732345] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.914s) [215.994970] [112/171] (828s left) kms_flip (basic-plain-flip) [216.139508] Starting subtest: basic-plain-flip [216.142975] Starting dynamic subtest: A-eDP1 [218.173976] Dynamic subtest A-eDP1: SUCCESS (2.032s) [218.190297] Starting dynamic subtest: B-eDP1 [220.144267] Dynamic subtest B-eDP1: SUCCESS (1.969s) [220.160770] Starting dynamic subtest: C-eDP1 [222.128075] Dynamic subtest C-eDP1: SUCCESS (1.983s) [222.130638] Subtest basic-plain-flip: SUCCESS (5.993s) [223.421122] [113/171] (821s left) kms_force_connector_basic (force-connector-state) [223.565459] Starting subtest: force-connector-state [225.275077] Subtest force-connector-state: SUCCESS (1.711s) [225.892525] [114/171] (818s left) kms_force_connector_basic (force-edid) [226.032769] Starting subtest: force-edid [226.290485] Subtest force-edid: SUCCESS (0.253s) [226.425948] [115/171] (818s left) kms_force_connector_basic (force-load-detect) [226.566565] Starting subtest: force-load-detect [226.569290] Subtest force-load-detect: SKIP (0.000s) [226.675840] [116/171] (818s left) kms_force_connector_basic (prune-stale-modes) [226.815698] Starting subtest: prune-stale-modes [227.121542] Subtest prune-stale-modes: SUCCESS (0.306s) [227.260388] [117/171] (817s left) kms_frontbuffer_tracking (basic) [227.435060] Starting subtest: basic [230.743067] Subtest basic: SUCCESS (3.306s) [230.860421] [118/171] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [231.022685] Starting subtest: compare-crc-sanitycheck-xr24 [231.025671] Starting dynamic subtest: pipe-A-eDP-1 [231.702288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s) [231.722680] Starting dynamic subtest: pipe-B-eDP-1 [233.085668] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s) [233.101191] Starting dynamic subtest: pipe-C-eDP-1 [234.608857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [234.609965] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.586s) [235.571575] [119/171] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [235.738145] Starting subtest: compare-crc-sanitycheck-nv12 [235.741288] Starting dynamic subtest: pipe-A-eDP-1 [236.645741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.905s) [236.664516] Starting dynamic subtest: pipe-B-eDP-1 [238.091541] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s) [238.109866] Starting dynamic subtest: pipe-C-eDP-1 [239.868316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.773s) [239.869455] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.131s) [240.822156] [120/171] (804s left) kms_pipe_crc_basic (hang-read-crc) [240.992864] Starting subtest: hang-read-crc [240.996344] Starting dynamic subtest: pipe-A-eDP-1 [243.300346] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.306s) [243.319596] Starting dynamic subtest: pipe-B-eDP-1 [246.276573] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.970s) [246.294673] Starting dynamic subtest: pipe-C-eDP-1 [249.580511] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.300s) [249.581693] Subtest hang-read-crc: SUCCESS (8.588s) [250.547463] [121/171] (794s left) kms_pipe_crc_basic (nonblocking-crc) [250.720362] Starting subtest: nonblocking-crc [250.721784] Starting dynamic subtest: pipe-A-eDP-1 [251.574897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s) [251.593446] Starting dynamic subtest: pipe-B-eDP-1 [253.126253] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s) [253.144011] Starting dynamic subtest: pipe-C-eDP-1 [254.830531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.700s) [254.831625] Subtest nonblocking-crc: SUCCESS (4.111s) [255.796835] [122/171] (789s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [255.967784] Starting subtest: nonblocking-crc-frame-sequence [255.969059] Starting dynamic subtest: pipe-A-eDP-1 [256.821556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s) [256.840796] Starting dynamic subtest: pipe-B-eDP-1 [258.374402] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [258.394094] Starting dynamic subtest: pipe-C-eDP-1 [260.076293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.696s) [260.077464] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.110s) [261.044883] [123/171] (784s left) kms_pipe_crc_basic (read-crc) [261.212519] Starting subtest: read-crc [261.215680] Starting dynamic subtest: pipe-A-eDP-1 [262.005540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s) [262.023428] Starting dynamic subtest: pipe-B-eDP-1 [263.491922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [263.510075] Starting dynamic subtest: pipe-C-eDP-1 [265.125163] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.628s) [265.126367] Subtest read-crc: SUCCESS (3.911s) [266.037764] [124/171] (779s left) kms_pipe_crc_basic (read-crc-frame-sequence) [266.203499] Starting subtest: read-crc-frame-sequence [266.206886] Starting dynamic subtest: pipe-A-eDP-1 [266.998505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [267.016059] Starting dynamic subtest: pipe-B-eDP-1 [268.507665] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s) [268.527246] Starting dynamic subtest: pipe-C-eDP-1 [270.153361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.639s) [270.154532] Subtest read-crc-frame-sequence: SUCCESS (3.949s) [271.091785] [125/171] (774s left) kms_psr (primary_page_flip) [271.263792] Starting subtest: primary_page_flip [275.455918] Subtest primary_page_flip: SUCCESS (4.189s) [276.404800] [126/171] (768s left) kms_psr (cursor_plane_move) [276.573542] Starting subtest: cursor_plane_move [280.728695] Subtest cursor_plane_move: SUCCESS (4.154s) [281.651589] [127/171] (763s left) kms_psr (sprite_plane_onoff) [281.821649] Starting subtest: sprite_plane_onoff [286.077913] Subtest sprite_plane_onoff: SUCCESS (4.257s) [287.028779] [128/171] (758s left) kms_psr (primary_mmap_gtt) [287.198117] Starting subtest: primary_mmap_gtt [291.399173] Subtest primary_mmap_gtt: SUCCESS (4.189s) [292.340792] [129/171] (752s left) kms_setmode (basic-clone-single-crtc) [292.481483] Starting subtest: basic-clone-single-crtc [292.484517] Subtest basic-clone-single-crtc: SKIP (0.000s) [292.557039] [130/171] (752s left) i915_pm_backlight (basic-brightness) [292.724401] Starting subtest: basic-brightness [292.847958] Starting dynamic subtest: eDP-1 [293.401060] Dynamic subtest eDP-1: SUCCESS (0.560s) [293.402197] Subtest basic-brightness: SUCCESS (0.677s) [294.327084] [131/171] (751s left) i915_pm_rpm (basic-pci-d3-state) [296.214610] Starting subtest: basic-pci-d3-state [300.626614] Subtest basic-pci-d3-state: SUCCESS (4.411s) [300.826392] [132/171] (744s left) i915_pm_rpm (basic-rte) [300.961615] Starting subtest: basic-rte [307.086606] Subtest basic-rte: SUCCESS (6.124s) [312.461382] [133/171] (732s left) i915_pm_rps (basic-api) [312.605910] Starting subtest: basic-api [312.609887] Subtest basic-api: SUCCESS (0.004s) [312.697369] [134/171] (732s left) prime_self_import (basic-llseek-bad) [312.833532] Starting subtest: basic-llseek-bad [312.835905] Subtest basic-llseek-bad: SUCCESS (0.002s) [312.953054] [135/171] (732s left) prime_self_import (basic-llseek-size) [313.087358] Starting subtest: basic-llseek-size [313.091672] Subtest basic-llseek-size: SUCCESS (0.004s) [313.181103] [136/171] (732s left) prime_self_import (basic-with_fd_dup) [313.315289] Starting subtest: basic-with_fd_dup [313.319942] Subtest basic-with_fd_dup: SUCCESS (0.004s) [313.414349] [137/171] (732s left) prime_self_import (basic-with_one_bo) [313.548656] Starting subtest: basic-with_one_bo [313.553266] Subtest basic-with_one_bo: SUCCESS (0.005s) [313.642337] [138/171] (731s left) prime_self_import (basic-with_one_bo_two_files) [313.768025] Starting subtest: basic-with_one_bo_two_files [313.772541] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [313.876811] [139/171] (731s left) prime_self_import (basic-with_two_bos) [314.009540] Starting subtest: basic-with_two_bos [314.014267] Subtest basic-with_two_bos: SUCCESS (0.004s) [314.131956] [140/171] (731s left) prime_vgem (basic-fence-flip) [314.280663] Starting subtest: basic-fence-flip [314.805783] Subtest basic-fence-flip: SUCCESS (0.524s) [314.928281] [141/171] (730s left) prime_vgem (basic-fence-mmap) [315.085793] Starting subtest: basic-fence-mmap [315.132826] Subtest basic-fence-mmap: SUCCESS (0.047s) [315.247941] [142/171] (730s left) prime_vgem (basic-fence-read) [315.397215] Starting subtest: basic-fence-read [315.470464] Subtest basic-fence-read: SUCCESS (0.073s) [315.566314] [143/171] (730s left) prime_vgem (basic-gtt) [315.720533] Starting subtest: basic-gtt [315.743652] Subtest basic-gtt: SUCCESS (0.023s) [315.847478] [144/171] (729s left) prime_vgem (basic-read) [316.002395] Starting subtest: basic-read [316.037813] Subtest basic-read: SUCCESS (0.035s) [316.147661] [145/171] (729s left) prime_vgem (basic-write) [316.297462] Starting subtest: basic-write [316.338469] Subtest basic-write: SUCCESS (0.041s) [316.430619] [146/171] (729s left) vgem_basic (setversion) [316.573177] Starting subtest: setversion [316.575547] Subtest setversion: SUCCESS (0.000s) [316.648165] [147/171] (729s left) vgem_basic (create) [316.790322] Starting subtest: create [316.791574] Subtest create: SUCCESS (0.000s) [316.864284] [148/171] (728s left) vgem_basic (debugfs) [317.006578] Starting subtest: debugfs [317.007760] Subtest debugfs: SUCCESS (0.001s) [317.082054] [149/171] (728s left) vgem_basic (dmabuf-export) [317.223351] Starting subtest: dmabuf-export [317.225762] Subtest dmabuf-export: SUCCESS (0.003s) [317.331223] [150/171] (728s left) vgem_basic (dmabuf-fence) [317.473233] Starting subtest: dmabuf-fence [317.474484] Subtest dmabuf-fence: SUCCESS (0.001s) [317.547826] [151/171] (728s left) vgem_basic (dmabuf-fence-before) [317.691181] Starting subtest: dmabuf-fence-before [317.692380] Subtest dmabuf-fence-before: SUCCESS (0.000s) [317.760752] [152/171] (728s left) vgem_basic (dmabuf-mmap) [317.909242] Starting subtest: dmabuf-mmap [317.933524] Subtest dmabuf-mmap: SUCCESS (0.026s) [318.010769] [153/171] (727s left) vgem_basic (mmap) [318.158489] Starting subtest: mmap [318.174136] Subtest mmap: SUCCESS (0.017s) [318.243895] [154/171] (727s left) vgem_basic (second-client) [318.392338] Starting subtest: second-client [318.441346] Subtest second-client: SUCCESS (0.049s) [318.511172] [155/171] (727s left) vgem_basic (sysfs) [318.658440] Starting subtest: sysfs [318.659565] Subtest sysfs: SUCCESS (0.001s) [318.726995] [156/171] (727s left) core_hotunplug (unbind-rebind) [318.908330] Starting subtest: unbind-rebind [321.342413] Subtest unbind-rebind: SUCCESS (2.435s) [321.403230] [157/171] (724s left) vgem_basic (unload) [321.539880] Starting subtest: unload [350.601725] Subtest unload: SUCCESS (29.027s) [350.698954] [158/171] (695s left) i915_module_load (reload) [350.836073] Starting subtest: reload [354.366514] Subtest reload: SUCCESS (3.530s) [354.398273] [159/171] (691s left) gem_lmem_swapping (basic) [354.552158] Subtest basic: SKIP (0.000s) [354.600858] [160/171] (691s left) gem_lmem_swapping (parallel-random-engines) [354.750557] Subtest parallel-random-engines: SKIP (0.000s) [354.800585] [161/171] (691s left) gem_lmem_swapping (random-engines) [354.942239] Subtest random-engines: SKIP (0.000s) [354.983475] [162/171] (691s left) gem_lmem_swapping (verify-random) [355.127305] Subtest verify-random: SKIP (0.000s) [355.166669] [163/171] (691s left) i915_pm_rpm (module-reload) [367.681066] Starting subtest: module-reload [402.459634] Subtest module-reload: SUCCESS (34.772s) [402.484217] [164/171] (643s left) i915_selftest (live) [402.627937] Starting subtest: live [402.629480] Starting dynamic subtest: sanitycheck [404.443286] Dynamic subtest sanitycheck: SUCCESS (1.806s) [404.457778] Starting dynamic subtest: uncore [406.303569] Dynamic subtest uncore: SUCCESS (1.858s) [406.318078] Starting dynamic subtest: workarounds [408.348917] Dynamic subtest workarounds: SUCCESS (2.043s) [408.363886] Starting dynamic subtest: gt_engines [410.589506] Dynamic subtest gt_engines: SUCCESS (2.239s) [410.604111] Starting dynamic subtest: gt_timelines [423.128377] Dynamic subtest gt_timelines: SUCCESS (12.537s) [423.142928] Starting dynamic subtest: gt_contexts [425.053295] Dynamic subtest gt_contexts: SUCCESS (1.923s) [425.067868] Starting dynamic subtest: gt_lrc [429.482171] Dynamic subtest gt_lrc: SUCCESS (4.427s) [429.496715] Starting dynamic subtest: gt_mocs [431.393478] Dynamic subtest gt_mocs: SUCCESS (1.909s) [431.407933] Starting dynamic subtest: gt_pm [436.477653] Dynamic subtest gt_pm: SUCCESS (5.082s) [436.492431] Starting dynamic subtest: gt_heartbeat [438.356999] Dynamic subtest gt_heartbeat: SUCCESS (1.877s) [438.372028] Starting dynamic subtest: gt_tlb [441.508220] Dynamic subtest gt_tlb: SUCCESS (3.150s) [441.522806] Starting dynamic subtest: requests [449.122620] Dynamic subtest requests: SUCCESS (7.612s) [449.136968] Starting dynamic subtest: migrate [453.706585] Dynamic subtest migrate: SUCCESS (4.584s) [453.720815] Starting dynamic subtest: active [455.523639] Dynamic subtest active: SUCCESS (1.813s) [455.538371] Starting dynamic subtest: objects [459.023465] Dynamic subtest objects: SUCCESS (3.498s) [459.038110] Starting dynamic subtest: mman [465.994456] Dynamic subtest mman: SUCCESS (6.969s) [466.009078] Starting dynamic subtest: dmabuf [467.884626] Dynamic subtest dmabuf: SUCCESS (1.888s) [467.899144] Starting dynamic subtest: vma [469.721903] Dynamic subtest vma: SUCCESS (1.835s) [469.736994] Starting dynamic subtest: coherency [476.077763] Dynamic subtest coherency: SUCCESS (6.354s) [476.092524] Starting dynamic subtest: gtt [485.484520] Dynamic subtest gtt: SUCCESS (9.405s) [485.499429] Starting dynamic subtest: gem [487.396439] Dynamic subtest gem: SUCCESS (1.910s) [487.411373] Starting dynamic subtest: evict [491.253763] Dynamic subtest evict: SUCCESS (3.855s) [491.268636] Starting dynamic subtest: hugepages [498.204307] Dynamic subtest hugepages: SUCCESS (6.949s) [498.219453] Starting dynamic subtest: gem_contexts [513.414504] Dynamic subtest gem_contexts: SUCCESS (15.209s) [513.429545] Starting dynamic subtest: client [515.226465] Dynamic subtest client: SUCCESS (1.810s) [515.241621] Starting dynamic subtest: gem_migrate [517.019632] Dynamic subtest gem_migrate: SUCCESS (1.791s) [517.034833] Starting dynamic subtest: reset [522.418544] Dynamic subtest reset: SUCCESS (5.397s) [522.433552] Starting dynamic subtest: memory_region [524.242559] Dynamic subtest memory_region: SUCCESS (1.822s) [524.257843] Starting dynamic subtest: hangcheck [548.650144] Dynamic subtest hangcheck: SUCCESS (24.406s) [548.665451] Starting dynamic subtest: execlists [558.759979] Dynamic subtest execlists: SUCCESS (10.108s) [558.775493] Starting dynamic subtest: ring_submission [560.521493] Dynamic subtest ring_submission: SUCCESS (1.760s) [560.536797] Starting dynamic subtest: perf [562.481445] Dynamic subtest perf: SUCCESS (1.958s) [562.496658] Starting dynamic subtest: slpc [564.339569] Dynamic subtest slpc: SUCCESS (1.856s) [564.354995] Starting dynamic subtest: guc [566.179551] Dynamic subtest guc: SUCCESS (1.838s) [566.194890] Starting dynamic subtest: guc_multi_lrc [568.030365] Dynamic subtest guc_multi_lrc: SUCCESS (1.849s) [568.045533] Starting dynamic subtest: guc_hang [569.877397] Dynamic subtest guc_hang: SUCCESS (1.845s) [569.892714] Starting dynamic subtest: late_gt_pm [571.742647] Dynamic subtest late_gt_pm: SUCCESS (1.863s) [571.744023] Subtest live: SUCCESS (169.106s) [571.942549] [165/171] (474s left) dmabuf (all-tests) [572.078797] Starting subtest: all-tests [572.080024] Starting dynamic subtest: sanitycheck [572.141689] Dynamic subtest sanitycheck: SUCCESS (0.062s) [572.159346] Starting dynamic subtest: dma_fence [572.323523] Dynamic subtest dma_fence: SUCCESS (0.180s) [572.348851] Starting dynamic subtest: dma_fence_chain [589.960419] Dynamic subtest dma_fence_chain: SUCCESS (17.626s) [589.973131] Starting dynamic subtest: dma_fence_unwrap [590.033929] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s) [590.051272] Starting dynamic subtest: dma_resv [590.126983] Dynamic subtest dma_resv: SUCCESS (0.091s) [590.129183] Subtest all-tests: SUCCESS (18.048s) [590.159090] [166/171] (456s left) i915_suspend (basic-s2idle-without-i915) [590.295759] Starting subtest: basic-s2idle-without-i915 [613.208312] Subtest basic-s2idle-without-i915: SUCCESS (8.561s) [613.493487] [167/171] (447s left) i915_suspend (basic-s3-without-i915) [613.632335] Starting subtest: basic-s3-without-i915 [637.267522] Subtest basic-s3-without-i915: SUCCESS (7.181s) [637.565726] [168/171] (439s left) gem_exec_suspend (basic-s0) [637.719486] Starting subtest: basic-S0 [637.720701] Starting dynamic subtest: smem [657.267069] Dynamic subtest smem: SUCCESS (3.876s) [657.268131] Subtest basic-S0: SUCCESS (3.877s) [657.417703] [169/171] (435s left) gem_exec_suspend (basic-s3) [657.563911] Starting subtest: basic-S3 [657.565419] Starting dynamic subtest: smem [676.236122] Dynamic subtest smem: SUCCESS (3.600s) [676.237159] Subtest basic-S3: SUCCESS (3.601s) [676.389241] [170/171] (431s left) kms_chamelium_hpd (common-hpd-after-suspend) [676.866471] Subtest common-hpd-after-suspend: SKIP (0.000s) [677.753292] [171/171] (430s left) kms_pipe_crc_basic (suspend-read-crc) [677.914176] Starting subtest: suspend-read-crc [677.917385] Starting dynamic subtest: pipe-A-eDP-1 [695.240136] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.459s) [695.262401] Starting dynamic subtest: pipe-B-eDP-1 [713.183728] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.086s) [713.205471] Starting dynamic subtest: pipe-C-eDP-1 [732.181035] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.243s) [732.182265] Subtest suspend-read-crc: SUCCESS (8.801s) [733.075095] Closing watchdogs Done.