[42.545115] Initializing watchdogs [42.545174] /dev/watchdog0 [42.551718] [001/171] (960s left) i915_module_load (load) [42.601316] Starting subtest: load [43.458290] Subtest load: SUCCESS (0.857s) [43.476327] [002/171] (959s left) core_auth (basic-auth) [43.553064] Starting subtest: basic-auth [43.554548] Subtest basic-auth: SUCCESS (0.000s) [43.602669] [003/171] (959s left) debugfs_test (read_all_entries) [43.654233] Starting subtest: read_all_entries [43.708240] Subtest read_all_entries: SUCCESS (0.054s) [43.818868] [004/171] (959s left) debugfs_test (basic-hwmon) [43.866215] Starting subtest: basic-hwmon [43.869137] Subtest basic-hwmon: SKIP (0.000s) [43.967881] [005/171] (959s left) fbdev (eof) [44.024957] Starting subtest: eof [44.026676] Subtest eof: SUCCESS (0.000s) [44.071267] [006/171] (959s left) fbdev (info) [44.147968] Starting subtest: info [44.149722] Subtest info: SUCCESS (0.000s) [44.202341] [007/171] (958s left) fbdev (nullptr) [44.274668] Starting subtest: nullptr [44.276307] Subtest nullptr: SUCCESS (0.000s) [44.319368] [008/171] (958s left) fbdev (read) [44.374860] Starting subtest: read [44.591375] Subtest read: SUCCESS (0.217s) [44.634800] [009/171] (958s left) fbdev (write) [44.691530] Starting subtest: write [44.802352] Subtest write: SUCCESS (0.111s) [44.834936] [010/171] (958s left) gem_basic (bad-close) [44.879962] Starting subtest: bad-close [44.883881] Subtest bad-close: SUCCESS (0.000s) [44.937983] [011/171] (958s left) gem_basic (create-close) [44.987875] Starting subtest: create-close [44.990920] Subtest create-close: SUCCESS (0.000s) [45.056978] [012/171] (958s left) gem_basic (create-fd-close) [45.104204] Starting subtest: create-fd-close [45.107593] Subtest create-fd-close: SUCCESS (0.000s) [45.172198] [013/171] (958s left) gem_busy (busy@all-engines) [45.229709] Starting subtest: busy [45.231227] Starting dynamic subtest: all-engines [45.246333] Dynamic subtest all-engines: SUCCESS (0.016s) [45.249197] Subtest busy: SUCCESS (0.017s) [45.626326] [014/171] (957s left) gem_close_race (basic-process) [45.680980] Starting subtest: basic-process [45.728989] Subtest basic-process: SUCCESS (0.048s) [45.907968] [015/171] (957s left) gem_close_race (basic-threads) [46.013898] Starting subtest: basic-threads [47.214787] Subtest basic-threads: SUCCESS (1.201s) [47.405234] [016/171] (955s left) gem_ctx_create (basic) [47.459711] Starting subtest: basic [47.461284] Subtest basic: SUCCESS (0.000s) [47.656483] [017/171] (955s left) gem_ctx_create (basic-files) [47.744348] Starting subtest: basic-files [49.752536] Subtest basic-files: SUCCESS (2.008s) [49.989654] [018/171] (953s left) gem_ctx_exec (basic) [50.081467] Starting subtest: basic [50.083080] Subtest basic: SUCCESS (0.002s) [50.172313] [019/171] (953s left) gem_exec_basic (basic) [50.263531] Starting subtest: basic [50.265241] Starting dynamic subtest: rcs0-smem [50.266892] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [50.271909] Starting dynamic subtest: bcs0-smem [50.273647] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [50.278547] Starting dynamic subtest: vcs0-smem [50.280235] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [50.285203] Starting dynamic subtest: vecs0-smem [50.286877] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [50.288789] Subtest basic: SUCCESS (0.002s) [50.489171] [020/171] (952s left) gem_exec_create (basic) [50.554066] Starting subtest: basic [50.555907] Starting dynamic subtest: smem [52.600029] Dynamic subtest smem: SUCCESS (2.046s) [52.601762] Subtest basic: SUCCESS (2.046s) [52.770584] [021/171] (950s left) gem_exec_fence (basic-busy) [52.970592] Starting subtest: basic-busy [52.973412] Starting dynamic subtest: rcs0 [53.009604] Dynamic subtest rcs0: SUCCESS (0.040s) [53.015381] Starting dynamic subtest: bcs0 [53.040907] Dynamic subtest bcs0: SUCCESS (0.031s) [53.050958] Starting dynamic subtest: vcs0 [53.067051] Dynamic subtest vcs0: SUCCESS (0.026s) [53.079238] Starting dynamic subtest: vecs0 [53.091074] Dynamic subtest vecs0: SUCCESS (0.024s) [53.093045] Subtest basic-busy: SUCCESS (0.121s) [53.625968] [022/171] (949s left) gem_exec_fence (basic-wait) [53.810960] Starting subtest: basic-wait [53.813772] Starting dynamic subtest: rcs0 [53.864048] Dynamic subtest rcs0: SUCCESS (0.053s) [53.887527] Starting dynamic subtest: bcs0 [53.902185] Dynamic subtest bcs0: SUCCESS (0.039s) [53.914015] Starting dynamic subtest: vcs0 [53.931967] Dynamic subtest vcs0: SUCCESS (0.030s) [53.941961] Starting dynamic subtest: vecs0 [53.956996] Dynamic subtest vecs0: SUCCESS (0.025s) [53.958848] Subtest basic-wait: SUCCESS (0.147s) [54.457917] [023/171] (949s left) gem_exec_fence (basic-await) [54.657819] Starting subtest: basic-await [54.660654] Starting dynamic subtest: rcs0 [54.741021] Dynamic subtest rcs0: SUCCESS (0.084s) [54.748879] Starting dynamic subtest: bcs0 [54.809585] Dynamic subtest bcs0: SUCCESS (0.068s) [54.818724] Starting dynamic subtest: vcs0 [54.890608] Dynamic subtest vcs0: SUCCESS (0.080s) [54.911976] Starting dynamic subtest: vecs0 [54.984840] Dynamic subtest vecs0: SUCCESS (0.095s) [54.986874] Subtest basic-await: SUCCESS (0.328s) [55.493148] [024/171] (947s left) gem_exec_fence (nb-await) [55.678644] Starting subtest: nb-await [55.681227] Starting dynamic subtest: rcs0 [55.751158] Dynamic subtest rcs0: SUCCESS (0.072s) [55.772341] Starting dynamic subtest: bcs0 [55.823368] Dynamic subtest bcs0: SUCCESS (0.072s) [55.833758] Starting dynamic subtest: vcs0 [55.884191] Dynamic subtest vcs0: SUCCESS (0.061s) [55.903324] Starting dynamic subtest: vecs0 [55.950953] Dynamic subtest vecs0: SUCCESS (0.066s) [55.953649] Subtest nb-await: SUCCESS (0.272s) [56.442769] [025/171] (947s left) gem_exec_gttfill (basic) [56.496258] Starting subtest: basic [60.947093] Subtest basic: SUCCESS (4.451s) [61.102584] [026/171] (942s left) gem_exec_parallel (engines) [61.202130] Starting subtest: engines [61.203649] Starting dynamic subtest: basic [62.577647] Dynamic subtest basic: SUCCESS (1.375s) [62.583595] Starting dynamic subtest: contexts [64.890038] Dynamic subtest contexts: SUCCESS (2.313s) [64.895794] Starting dynamic subtest: fds [67.034858] Dynamic subtest fds: SUCCESS (2.145s) [67.040988] Starting dynamic subtest: userptr [68.650564] Dynamic subtest userptr: SUCCESS (1.615s) [68.652131] Subtest engines: SUCCESS (7.448s) [68.835212] [027/171] (934s left) gem_exec_store (basic) [68.912212] Starting subtest: basic [68.964969] Subtest basic: SUCCESS (0.053s) [69.125902] [028/171] (934s left) gem_flink_basic (bad-flink) [69.175995] Starting subtest: bad-flink [69.177443] Subtest bad-flink: SUCCESS (0.000s) [69.240247] [029/171] (934s left) gem_flink_basic (bad-open) [69.311923] Starting subtest: bad-open [69.313388] Subtest bad-open: SUCCESS (0.000s) [69.371716] [030/171] (934s left) gem_flink_basic (basic) [69.443896] Starting subtest: basic [69.446112] Subtest basic: SUCCESS (0.000s) [69.504384] [031/171] (934s left) gem_flink_basic (double-flink) [69.578251] Starting subtest: double-flink [69.579641] Subtest double-flink: SUCCESS (0.000s) [69.664806] [032/171] (933s left) gem_flink_basic (flink-lifetime) [69.745974] Starting subtest: flink-lifetime [69.747346] Subtest flink-lifetime: SUCCESS (0.001s) [69.827377] [033/171] (933s left) gem_huc_copy (huc-copy) [69.882945] Starting subtest: huc-copy [69.885970] Subtest huc-copy: SKIP (0.000s) [69.986797] [034/171] (933s left) gem_linear_blits (basic) [70.102071] Starting subtest: basic [70.106425] Subtest basic: SUCCESS (0.004s) [70.241157] [035/171] (933s left) gem_mmap (basic) [70.379051] Starting subtest: basic [70.386815] Subtest basic: SUCCESS (0.000s) [70.466454] [036/171] (933s left) gem_mmap_gtt (basic) [70.552431] Starting subtest: basic [70.554128] Subtest basic: SUCCESS (0.000s) [70.598271] [037/171] (933s left) gem_render_linear_blits (basic) [70.649245] Starting subtest: basic [70.668263] Subtest basic: SUCCESS (0.019s) [70.717018] [038/171] (933s left) gem_render_tiled_blits (basic) [70.771728] Starting subtest: basic [70.792890] Subtest basic: SUCCESS (0.022s) [70.832243] [039/171] (932s left) gem_ringfill (basic-all) [71.082543] Starting subtest: basic-all [72.223918] Subtest basic-all: SUCCESS (1.144s) [72.360812] [040/171] (931s left) gem_softpin (allocator-basic) [72.449124] Starting subtest: allocator-basic [72.504470] Subtest allocator-basic: SUCCESS (0.056s) [72.604677] [041/171] (931s left) gem_softpin (allocator-basic-reserve) [72.660686] Starting subtest: allocator-basic-reserve [72.717131] Subtest allocator-basic-reserve: SUCCESS (0.056s) [72.826488] [042/171] (931s left) gem_softpin (safe-alignment) [72.915982] Starting subtest: safe-alignment [72.923174] Subtest safe-alignment: SUCCESS (0.007s) [73.028400] [043/171] (930s left) gem_sync (basic-all) [73.128534] Starting subtest: basic-all [75.192691] Subtest basic-all: SUCCESS (2.071s) [75.393724] [044/171] (928s left) gem_sync (basic-each) [75.453406] Starting subtest: basic-each [77.521690] Subtest basic-each: SUCCESS (2.075s) [77.691262] [045/171] (926s left) gem_tiled_blits (basic) [77.837600] Starting subtest: basic [77.851238] Subtest basic: SUCCESS (0.013s) [77.986967] [046/171] (925s left) gem_tiled_fence_blits (basic) [78.169597] Starting subtest: basic [78.177298] Subtest basic: SUCCESS (0.008s) [78.315950] [047/171] (925s left) gem_tiled_pread_basic [78.575727] [048/171] (925s left) gem_wait (busy@all-engines) [78.635417] Starting subtest: busy [78.637053] Starting dynamic subtest: all-engines [79.149815] Dynamic subtest all-engines: SUCCESS (0.514s) [79.151375] Subtest busy: SUCCESS (0.514s) [79.343512] [049/171] (924s left) gem_wait (wait@all-engines) [79.396735] Starting subtest: wait [79.398253] Starting dynamic subtest: all-engines [80.423820] Dynamic subtest all-engines: SUCCESS (1.026s) [80.426410] Subtest wait: SUCCESS (1.026s) [80.630995] [050/171] (923s left) i915_getparams_basic (basic-eu-total) [80.677195] Starting subtest: basic-eu-total [80.680295] Subtest basic-eu-total: SUCCESS (0.000s) [80.740905] [051/171] (923s left) i915_getparams_basic (basic-subslice-total) [80.820472] Starting subtest: basic-subslice-total [80.823572] Subtest basic-subslice-total: SUCCESS (0.000s) [80.869713] [052/171] (923s left) i915_hangman (error-state-basic) [80.923633] Starting subtest: error-state-basic [80.927759] Subtest error-state-basic: SUCCESS (0.004s) [80.990284] [053/171] (923s left) i915_pciid [81.121268] [054/171] (922s left) kms_addfb_basic (addfb25-bad-modifier) [81.237601] Starting subtest: addfb25-bad-modifier [81.239166] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [81.403675] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [81.499280] Starting subtest: addfb25-framebuffer-vs-set-tiling [81.500733] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [81.670231] [056/171] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [81.767254] Starting subtest: addfb25-modifier-no-flag [81.768618] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [81.937267] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [82.033295] Starting subtest: addfb25-x-tiled-legacy [82.034850] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [82.204147] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [82.299267] Starting subtest: addfb25-x-tiled-mismatch-legacy [82.300834] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [82.471145] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [82.615385] Starting subtest: addfb25-yf-tiled-legacy [82.616856] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [82.737195] [060/171] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy) [82.879639] Starting subtest: addfb25-y-tiled-legacy [82.881126] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [83.003993] [061/171] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [83.146218] Starting subtest: addfb25-y-tiled-small-legacy [83.147679] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [83.270978] [062/171] (920s left) kms_addfb_basic (bad-pitch-0) [83.318483] Starting subtest: bad-pitch-0 [83.320024] Subtest bad-pitch-0: SUCCESS (0.000s) [83.537648] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024) [83.583023] Starting subtest: bad-pitch-1024 [83.584468] Subtest bad-pitch-1024: SUCCESS (0.000s) [83.804163] [064/171] (920s left) kms_addfb_basic (bad-pitch-128) [83.850209] Starting subtest: bad-pitch-128 [83.851698] Subtest bad-pitch-128: SUCCESS (0.000s) [84.071212] [065/171] (920s left) kms_addfb_basic (bad-pitch-256) [84.117554] Starting subtest: bad-pitch-256 [84.119170] Subtest bad-pitch-256: SUCCESS (0.000s) [84.337953] [066/171] (919s left) kms_addfb_basic (bad-pitch-32) [84.384181] Starting subtest: bad-pitch-32 [84.385771] Subtest bad-pitch-32: SUCCESS (0.000s) [84.603806] [067/171] (919s left) kms_addfb_basic (bad-pitch-63) [84.649902] Starting subtest: bad-pitch-63 [84.651451] Subtest bad-pitch-63: SUCCESS (0.000s) [84.870379] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536) [84.917628] Starting subtest: bad-pitch-65536 [84.919302] Subtest bad-pitch-65536: SUCCESS (0.000s) [85.137031] [069/171] (919s left) kms_addfb_basic (bad-pitch-999) [85.184275] Starting subtest: bad-pitch-999 [85.185768] Subtest bad-pitch-999: SUCCESS (0.000s) [85.387273] [070/171] (918s left) kms_addfb_basic (basic) [85.434181] Starting subtest: basic [85.435758] Subtest basic: SUCCESS (0.000s) [85.653982] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [85.845865] Starting subtest: basic-x-tiled-legacy [85.847284] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [85.920138] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [86.120854] Starting subtest: basic-y-tiled-legacy [86.122223] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [86.203197] [073/171] (918s left) kms_addfb_basic (bo-too-small) [86.296980] Starting subtest: bo-too-small [86.298478] Subtest bo-too-small: SUCCESS (0.000s) [86.453480] [074/171] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [86.547418] Starting subtest: bo-too-small-due-to-tiling [86.548864] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [86.703834] [075/171] (917s left) kms_addfb_basic (clobberred-modifier) [86.749120] Starting subtest: clobberred-modifier [86.750728] Subtest clobberred-modifier: SUCCESS (0.000s) [86.970084] [076/171] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling) [87.170558] Starting subtest: framebuffer-vs-set-tiling [87.172141] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [87.253544] [077/171] (917s left) kms_addfb_basic (invalid-get-prop) [87.442312] Starting subtest: invalid-get-prop [87.443773] Subtest invalid-get-prop: SUCCESS (0.000s) [87.519981] [078/171] (916s left) kms_addfb_basic (invalid-get-prop-any) [87.709539] Starting subtest: invalid-get-prop-any [87.710910] Subtest invalid-get-prop-any: SUCCESS (0.000s) [87.786956] [079/171] (916s left) kms_addfb_basic (invalid-set-prop) [87.976229] Starting subtest: invalid-set-prop [87.977808] Subtest invalid-set-prop: SUCCESS (0.000s) [88.053801] [080/171] (916s left) kms_addfb_basic (invalid-set-prop-any) [88.243148] Starting subtest: invalid-set-prop-any [88.244596] Subtest invalid-set-prop-any: SUCCESS (0.000s) [88.304110] [081/171] (916s left) kms_addfb_basic (no-handle) [88.349998] Starting subtest: no-handle [88.351504] Subtest no-handle: SUCCESS (0.000s) [88.587239] [082/171] (915s left) kms_addfb_basic (size-max) [88.682213] Starting subtest: size-max [88.683655] Subtest size-max: SUCCESS (0.000s) [88.853216] [083/171] (915s left) kms_addfb_basic (small-bo) [88.947263] Starting subtest: small-bo [88.948668] Subtest small-bo: SUCCESS (0.000s) [89.103595] [084/171] (915s left) kms_addfb_basic (tile-pitch-mismatch) [89.295169] Starting subtest: tile-pitch-mismatch [89.296728] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [89.353701] [085/171] (915s left) kms_addfb_basic (too-high) [89.448103] Starting subtest: too-high [89.449447] Subtest too-high: SUCCESS (0.001s) [89.620621] [086/171] (914s left) kms_addfb_basic (too-wide) [89.715754] Starting subtest: too-wide [89.717368] Subtest too-wide: SUCCESS (0.000s) [89.870437] [087/171] (914s left) kms_addfb_basic (unused-handle) [89.916896] Starting subtest: unused-handle [89.918369] Subtest unused-handle: SUCCESS (0.000s) [90.137401] [088/171] (914s left) kms_addfb_basic (unused-modifier) [90.185583] Starting subtest: unused-modifier [90.187041] Subtest unused-modifier: SUCCESS (0.000s) [90.403770] [089/171] (914s left) kms_addfb_basic (unused-offsets) [90.456849] Starting subtest: unused-offsets [90.458855] Subtest unused-offsets: SUCCESS (0.000s) [90.687237] [090/171] (913s left) kms_addfb_basic (unused-pitches) [90.733112] Starting subtest: unused-pitches [90.734683] Subtest unused-pitches: SUCCESS (0.000s) [90.953719] [091/171] (913s left) kms_busy (basic) [91.065657] Starting subtest: basic [91.067187] Starting dynamic subtest: flip [91.511475] Dynamic subtest flip: SUCCESS (0.445s) [91.518682] Starting dynamic subtest: modeset [91.886521] Dynamic subtest modeset: SUCCESS (0.374s) [91.888011] Subtest basic: SUCCESS (0.821s) [91.998700] [092/171] (912s left) kms_chamelium_hpd (dp-hpd-fast) [92.109126] Subtest dp-hpd-fast: SKIP (0.000s) [92.153579] [093/171] (912s left) kms_chamelium_edid (dp-edid-read) [92.264607] Subtest dp-edid-read: SKIP (0.000s) [92.310453] [094/171] (912s left) kms_chamelium_frames (dp-crc-fast) [92.424703] Subtest dp-crc-fast: SKIP (0.000s) [92.471397] [095/171] (912s left) kms_chamelium_hpd (hdmi-hpd-fast) [92.582642] Subtest hdmi-hpd-fast: SKIP (0.000s) [92.628332] [096/171] (911s left) kms_chamelium_edid (hdmi-edid-read) [92.741522] Subtest hdmi-edid-read: SKIP (0.000s) [92.785913] [097/171] (911s left) kms_chamelium_frames (hdmi-crc-fast) [92.898649] Subtest hdmi-crc-fast: SKIP (0.000s) [92.943683] [098/171] (911s left) kms_chamelium_hpd (vga-hpd-fast) [93.056154] Subtest vga-hpd-fast: SKIP (0.000s) [93.102638] [099/171] (911s left) kms_chamelium_edid (vga-edid-read) [93.230520] Subtest vga-edid-read: SKIP (0.000s) [93.277338] [100/171] (911s left) kms_prop_blob (basic) [93.325827] Starting subtest: basic [93.327386] Subtest basic: SUCCESS (0.000s) [93.378709] [101/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [93.476578] Starting subtest: basic-busy-flip-before-cursor-atomic [93.479642] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [93.527309] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [93.621595] Starting subtest: basic-busy-flip-before-cursor-legacy [93.624597] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [93.679233] [103/171] (911s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [93.777660] Starting subtest: basic-flip-after-cursor-atomic [94.686539] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.909s) [94.779210] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [94.875362] Starting subtest: basic-flip-after-cursor-legacy [95.787394] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s) [95.886375] [105/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [96.001510] Starting subtest: basic-flip-after-cursor-varying-size [96.911322] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.908s) [97.010266] [106/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [97.105041] Starting subtest: basic-flip-before-cursor-atomic [98.036200] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.931s) [98.138280] [107/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [98.234885] Starting subtest: basic-flip-before-cursor-legacy [99.147129] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.912s) [99.244173] [108/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [99.340107] Starting subtest: basic-flip-before-cursor-varying-size [100.271366] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.931s) [100.371532] [109/171] (904s left) kms_flip (basic-flip-vs-dpms) [100.453496] Starting subtest: basic-flip-vs-dpms [100.454856] Starting dynamic subtest: A-HDMI-A1 [101.283810] Dynamic subtest A-HDMI-A1: SUCCESS (0.828s) [101.290905] Starting dynamic subtest: B-HDMI-A1 [102.101277] Dynamic subtest B-HDMI-A1: SUCCESS (0.816s) [102.107869] Starting dynamic subtest: C-HDMI-A1 [102.945044] Dynamic subtest C-HDMI-A1: SUCCESS (0.845s) [102.946472] Subtest basic-flip-vs-dpms: SUCCESS (2.493s) [103.058825] [110/171] (901s left) kms_flip (basic-flip-vs-modeset) [103.147776] Starting subtest: basic-flip-vs-modeset [103.149260] Starting dynamic subtest: A-HDMI-A1 [103.939493] Dynamic subtest A-HDMI-A1: SUCCESS (0.791s) [103.945555] Starting dynamic subtest: B-HDMI-A1 [104.707794] Dynamic subtest B-HDMI-A1: SUCCESS (0.767s) [104.713724] Starting dynamic subtest: C-HDMI-A1 [105.475591] Dynamic subtest C-HDMI-A1: SUCCESS (0.768s) [105.477132] Subtest basic-flip-vs-modeset: SUCCESS (2.330s) [105.587678] [111/171] (899s left) kms_flip (basic-flip-vs-wf_vblank) [105.678155] Starting subtest: basic-flip-vs-wf_vblank [105.679733] Starting dynamic subtest: A-HDMI-A1 [106.779556] Dynamic subtest A-HDMI-A1: SUCCESS (1.102s) [106.786713] Starting dynamic subtest: B-HDMI-A1 [107.853959] Dynamic subtest B-HDMI-A1: SUCCESS (1.074s) [107.860175] Starting dynamic subtest: C-HDMI-A1 [108.942024] Dynamic subtest C-HDMI-A1: SUCCESS (1.087s) [108.943595] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.268s) [109.060134] [112/171] (895s left) kms_flip (basic-plain-flip) [109.146705] Starting subtest: basic-plain-flip [109.148445] Starting dynamic subtest: A-HDMI-A1 [109.953630] Dynamic subtest A-HDMI-A1: SUCCESS (0.808s) [109.959776] Starting dynamic subtest: B-HDMI-A1 [110.742449] Dynamic subtest B-HDMI-A1: SUCCESS (0.788s) [110.748523] Starting dynamic subtest: C-HDMI-A1 [111.532900] Dynamic subtest C-HDMI-A1: SUCCESS (0.790s) [111.534407] Subtest basic-plain-flip: SUCCESS (2.391s) [111.649920] [113/171] (893s left) kms_force_connector_basic (force-connector-state) [111.796391] Starting subtest: force-connector-state [112.143601] Subtest force-connector-state: SUCCESS (0.347s) [112.552390] [114/171] (892s left) kms_force_connector_basic (force-edid) [112.696153] Starting subtest: force-edid [112.832916] Subtest force-edid: SUCCESS (0.137s) [113.035402] [115/171] (891s left) kms_force_connector_basic (force-load-detect) [113.180223] Starting subtest: force-load-detect [113.182812] Subtest force-load-detect: SKIP (0.000s) [113.369384] [116/171] (891s left) kms_force_connector_basic (prune-stale-modes) [113.513235] Starting subtest: prune-stale-modes [113.648153] Subtest prune-stale-modes: SUCCESS (0.135s) [113.852334] [117/171] (891s left) kms_frontbuffer_tracking (basic) [113.954832] Starting subtest: basic [116.339529] Subtest basic: SUCCESS (2.389s) [116.421026] [118/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [116.517345] Starting subtest: compare-crc-sanitycheck [116.518803] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.878827] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.361s) [116.886260] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.229684] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.350s) [117.238077] Starting dynamic subtest: pipe-C-HDMI-A-1 [117.584060] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.352s) [117.585691] Subtest compare-crc-sanitycheck: SUCCESS (1.066s) [117.689169] [119/171] (887s left) kms_pipe_crc_basic (hang-read-crc) [117.787300] Starting subtest: hang-read-crc [117.788651] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.617245] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.829s) [118.623357] Starting dynamic subtest: pipe-B-HDMI-A-1 [119.444717] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.826s) [119.450963] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.334547] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.889s) [120.335797] Subtest hang-read-crc: SUCCESS (2.547s) [120.411491] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc) [120.508026] Starting subtest: nonblocking-crc [120.509518] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.985718] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.475s) [120.992857] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.479297] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.494s) [121.487602] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.999332] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.518s) [122.000802] Subtest nonblocking-crc: SUCCESS (1.490s) [122.076932] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.173051] Starting subtest: nonblocking-crc-frame-sequence [122.174520] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.653569] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.479s) [122.661577] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.129687] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.475s) [123.136059] Starting dynamic subtest: pipe-C-HDMI-A-1 [123.642429] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.512s) [123.643804] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.469s) [123.769658] [122/171] (881s left) kms_pipe_crc_basic (read-crc) [123.866084] Starting subtest: read-crc [123.867558] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.279445] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s) [124.286571] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.689441] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.409s) [124.696047] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.136413] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.446s) [125.137864] Subtest read-crc: SUCCESS (1.270s) [125.213930] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.310051] Starting subtest: read-crc-frame-sequence [125.311502] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.740492] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.430s) [125.748688] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.152563] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.410s) [126.159150] Starting dynamic subtest: pipe-C-HDMI-A-1 [126.613894] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.460s) [126.615485] Subtest read-crc-frame-sequence: SUCCESS (1.304s) [126.693118] [124/171] (878s left) kms_psr (primary_page_flip) [126.742056] Subtest primary_page_flip: SKIP (0.000s) [126.754095] [125/171] (878s left) kms_psr (cursor_plane_move) [126.801176] Subtest cursor_plane_move: SKIP (0.000s) [126.820585] [126/171] (878s left) kms_psr (sprite_plane_onoff) [126.868452] Subtest sprite_plane_onoff: SKIP (0.000s) [126.887556] [127/171] (878s left) kms_psr (primary_mmap_gtt) [126.935392] Subtest primary_mmap_gtt: SKIP (0.000s) [126.954474] [128/171] (878s left) kms_setmode (basic-clone-single-crtc) [126.999760] Starting subtest: basic-clone-single-crtc [127.004626] Subtest basic-clone-single-crtc: SKIP (0.000s) [127.062915] [129/171] (877s left) i915_pm_backlight (basic-brightness) [127.186700] Subtest basic-brightness: SKIP (0.000s) [127.205459] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state) [128.591573] Starting subtest: basic-pci-d3-state [129.022456] Subtest basic-pci-d3-state: SUCCESS (0.430s) [129.300430] [131/171] (875s left) i915_pm_rpm (basic-rte) [129.359639] Starting subtest: basic-rte [131.090418] Subtest basic-rte: SUCCESS (1.731s) [131.692279] [132/171] (873s left) i915_pm_rps (basic-api) [131.742626] Starting subtest: basic-api [131.745773] Subtest basic-api: SUCCESS (0.002s) [131.814928] [133/171] (873s left) prime_self_import (basic-llseek-bad) [131.886252] Starting subtest: basic-llseek-bad [131.887617] Subtest basic-llseek-bad: SUCCESS (0.001s) [131.966168] [134/171] (873s left) prime_self_import (basic-llseek-size) [132.016791] Starting subtest: basic-llseek-size [132.018199] Subtest basic-llseek-size: SUCCESS (0.001s) [132.104381] [135/171] (873s left) prime_self_import (basic-with_fd_dup) [132.157303] Starting subtest: basic-with_fd_dup [132.158715] Subtest basic-with_fd_dup: SUCCESS (0.002s) [132.263163] [136/171] (872s left) prime_self_import (basic-with_one_bo) [132.316436] Starting subtest: basic-with_one_bo [132.318092] Subtest basic-with_one_bo: SUCCESS (0.002s) [132.371132] [137/171] (872s left) prime_self_import (basic-with_one_bo_two_files) [132.428717] Starting subtest: basic-with_one_bo_two_files [132.430077] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [132.529469] [138/171] (872s left) prime_self_import (basic-with_two_bos) [132.585278] Starting subtest: basic-with_two_bos [132.586675] Subtest basic-with_two_bos: SUCCESS (0.001s) [132.671427] [139/171] (872s left) prime_vgem (basic-fence-flip) [132.765965] Starting subtest: basic-fence-flip [133.162022] Subtest basic-fence-flip: SUCCESS (0.396s) [133.231425] [140/171] (872s left) prime_vgem (basic-fence-mmap) [133.304404] Starting subtest: basic-fence-mmap [133.317690] Subtest basic-fence-mmap: SUCCESS (0.013s) [133.451461] [141/171] (871s left) prime_vgem (basic-fence-read) [133.515787] Starting subtest: basic-fence-read [133.537763] Subtest basic-fence-read: SUCCESS (0.022s) [133.669834] [142/171] (871s left) prime_vgem (basic-gtt) [133.732354] Starting subtest: basic-gtt [133.739422] Subtest basic-gtt: SUCCESS (0.007s) [133.850062] [143/171] (871s left) prime_vgem (basic-read) [133.959316] Starting subtest: basic-read [133.969783] Subtest basic-read: SUCCESS (0.010s) [134.054599] [144/171] (871s left) prime_vgem (basic-write) [134.158387] Starting subtest: basic-write [134.170202] Subtest basic-write: SUCCESS (0.012s) [134.298776] [145/171] (871s left) prime_vgem (basic-userptr) [134.382110] Starting subtest: basic-userptr [134.387732] Subtest basic-userptr: SKIP (0.004s) [134.466674] [146/171] (871s left) vgem_basic (setversion) [134.529212] Starting subtest: setversion [134.532592] Subtest setversion: SUCCESS (0.000s) [134.577978] [147/171] (870s left) vgem_basic (create) [134.629240] Starting subtest: create [134.630915] Subtest create: SUCCESS (0.000s) [134.676609] [148/171] (870s left) vgem_basic (debugfs) [134.745963] Starting subtest: debugfs [134.747719] Subtest debugfs: SUCCESS (0.000s) [134.792377] [149/171] (870s left) vgem_basic (dmabuf-export) [134.862548] Starting subtest: dmabuf-export [134.864159] Subtest dmabuf-export: SUCCESS (0.001s) [134.931377] [150/171] (870s left) vgem_basic (dmabuf-fence) [134.995966] Starting subtest: dmabuf-fence [134.997830] Subtest dmabuf-fence: SUCCESS (0.000s) [135.045518] [151/171] (870s left) vgem_basic (dmabuf-fence-before) [135.095700] Starting subtest: dmabuf-fence-before [135.097297] Subtest dmabuf-fence-before: SUCCESS (0.000s) [135.144728] [152/171] (870s left) vgem_basic (dmabuf-mmap) [135.229044] Starting subtest: dmabuf-mmap [135.237981] Subtest dmabuf-mmap: SUCCESS (0.009s) [135.280620] [153/171] (870s left) vgem_basic (mmap) [135.362680] Starting subtest: mmap [135.368175] Subtest mmap: SUCCESS (0.006s) [135.407851] [154/171] (870s left) vgem_basic (second-client) [135.463705] Starting subtest: second-client [135.512286] Subtest second-client: SUCCESS (0.050s) [135.579357] [155/171] (870s left) vgem_basic (sysfs) [135.629459] Starting subtest: sysfs [135.631201] Subtest sysfs: SUCCESS (0.000s) [135.674915] [156/171] (870s left) core_hotunplug (unbind-rebind) [135.745864] Starting subtest: unbind-rebind [136.531524] Subtest unbind-rebind: SUCCESS (0.786s) [136.545735] [157/171] (869s left) vgem_basic (unload) [136.595909] Starting subtest: unload [165.276909] Subtest unload: SUCCESS (28.681s) [165.352176] [158/171] (840s left) i915_module_load (reload) [165.404591] Starting subtest: reload [166.892569] Subtest reload: SUCCESS (1.487s) [166.910733] [159/171] (838s left) gem_lmem_swapping (basic) [166.982759] Subtest basic: SKIP (0.000s) [167.000888] [160/171] (838s left) gem_lmem_swapping (parallel-random-engines) [167.052610] Subtest parallel-random-engines: SKIP (0.000s) [167.066065] [161/171] (838s left) gem_lmem_swapping (random-engines) [167.118901] Subtest random-engines: SKIP (0.000s) [167.132306] [162/171] (838s left) gem_lmem_swapping (verify-random) [167.182536] Subtest verify-random: SKIP (0.000s) [167.198549] [163/171] (838s left) i915_pm_rpm (module-reload) [168.881362] Starting subtest: module-reload [175.894966] Subtest module-reload: SUCCESS (7.015s) [175.906907] [164/171] (829s left) i915_selftest (live) [175.968499] Starting subtest: live [175.970123] Starting dynamic subtest: sanitycheck [176.387120] Dynamic subtest sanitycheck: SUCCESS (0.418s) [176.392280] Starting dynamic subtest: uncore [176.834899] Dynamic subtest uncore: SUCCESS (0.448s) [176.840103] Starting dynamic subtest: workarounds [177.431977] Dynamic subtest workarounds: SUCCESS (0.597s) [177.437152] Starting dynamic subtest: gt_engines [178.334882] Dynamic subtest gt_engines: SUCCESS (0.903s) [178.340056] Starting dynamic subtest: gt_timelines [183.934817] Dynamic subtest gt_timelines: SUCCESS (5.599s) [183.939955] Starting dynamic subtest: gt_contexts [184.532911] Dynamic subtest gt_contexts: SUCCESS (0.598s) [184.538071] Starting dynamic subtest: gt_lrc [187.296048] Dynamic subtest gt_lrc: SUCCESS (2.763s) [187.301381] Starting dynamic subtest: gt_mocs [187.799803] Dynamic subtest gt_mocs: SUCCESS (0.504s) [187.804727] Starting dynamic subtest: gt_pm [190.098905] Dynamic subtest gt_pm: SUCCESS (2.299s) [190.103730] Starting dynamic subtest: gt_heartbeat [190.651773] Dynamic subtest gt_heartbeat: SUCCESS (0.553s) [190.656930] Starting dynamic subtest: requests [197.385030] Dynamic subtest requests: SUCCESS (6.733s) [197.390069] Starting dynamic subtest: migrate [200.664836] Dynamic subtest migrate: SUCCESS (3.280s) [200.669837] Starting dynamic subtest: active [201.063969] Dynamic subtest active: SUCCESS (0.399s) [201.068953] Starting dynamic subtest: objects [202.075935] Dynamic subtest objects: SUCCESS (1.012s) [202.080976] Starting dynamic subtest: mman [205.786657] Dynamic subtest mman: SUCCESS (3.711s) [205.791901] Starting dynamic subtest: dmabuf [206.329810] Dynamic subtest dmabuf: SUCCESS (0.543s) [206.334886] Starting dynamic subtest: vma [206.751054] Dynamic subtest vma: SUCCESS (0.421s) [206.756353] Starting dynamic subtest: coherency [207.711970] Dynamic subtest coherency: SUCCESS (0.961s) [207.717111] Starting dynamic subtest: gtt [217.894015] Dynamic subtest gtt: SUCCESS (10.182s) [217.899081] Starting dynamic subtest: gem [218.398809] Dynamic subtest gem: SUCCESS (0.505s) [218.403851] Starting dynamic subtest: evict [219.456521] Dynamic subtest evict: SUCCESS (1.057s) [219.466794] Starting dynamic subtest: hugepages [224.978842] Dynamic subtest hugepages: SUCCESS (5.522s) [224.984050] Starting dynamic subtest: gem_contexts [236.938992] Dynamic subtest gem_contexts: SUCCESS (11.960s) [236.944357] Starting dynamic subtest: client [237.396942] Dynamic subtest client: SUCCESS (0.458s) [237.402219] Starting dynamic subtest: gem_migrate [237.820870] Dynamic subtest gem_migrate: SUCCESS (0.424s) [237.826245] Starting dynamic subtest: reset [238.576894] Dynamic subtest reset: SUCCESS (0.756s) [238.582062] Starting dynamic subtest: memory_region [238.974942] Dynamic subtest memory_region: SUCCESS (0.398s) [238.980228] Starting dynamic subtest: hangcheck [262.445824] Dynamic subtest hangcheck: SUCCESS (23.471s) [262.452714] Starting dynamic subtest: execlists [270.466958] Dynamic subtest execlists: SUCCESS (8.021s) [270.472212] Starting dynamic subtest: ring_submission [270.887853] Dynamic subtest ring_submission: SUCCESS (0.421s) [270.892979] Starting dynamic subtest: perf [271.384062] Dynamic subtest perf: SUCCESS (0.496s) [271.389387] Starting dynamic subtest: slpc [271.789853] Dynamic subtest slpc: SUCCESS (0.406s) [271.794923] Starting dynamic subtest: guc [272.192424] Dynamic subtest guc: SUCCESS (0.402s) [272.197821] Starting dynamic subtest: guc_multi_lrc [272.581832] Dynamic subtest guc_multi_lrc: SUCCESS (0.390s) [272.587077] Starting dynamic subtest: guc_hang [273.037933] Dynamic subtest guc_hang: SUCCESS (0.455s) [273.043173] Starting dynamic subtest: late_gt_pm [273.510100] Dynamic subtest late_gt_pm: SUCCESS (0.472s) [273.511600] Subtest live: SUCCESS (97.541s) [273.578348] [165/171] (732s left) dmabuf (all-tests) [273.644832] Starting subtest: all-tests [273.646997] Starting dynamic subtest: sanitycheck [273.671809] Dynamic subtest sanitycheck: SUCCESS (0.027s) [273.677108] Starting dynamic subtest: dma_fence [273.798850] Dynamic subtest dma_fence: SUCCESS (0.127s) [273.803942] Starting dynamic subtest: dma_fence_chain [284.035891] Dynamic subtest dma_fence_chain: SUCCESS (10.237s) [284.041097] Starting dynamic subtest: dma_fence_unwrap [284.065923] Dynamic subtest dma_fence_unwrap: SUCCESS (0.030s) [284.072276] Starting dynamic subtest: dma_resv [284.086871] Dynamic subtest dma_resv: SUCCESS (0.021s) [284.088441] Subtest all-tests: SUCCESS (10.442s) [284.100712] [166/171] (721s left) i915_suspend (basic-s2idle-without-i915) [284.151544] Starting subtest: basic-s2idle-without-i915 [301.276587] Subtest basic-s2idle-without-i915: SUCCESS (1.662s) [307.399578] [167/171] (719s left) i915_suspend (basic-s3-without-i915) [307.449081] Starting subtest: basic-s3-without-i915 [325.355165] Subtest basic-s3-without-i915: SUCCESS (1.581s) [331.818795] [168/171] (718s left) gem_exec_suspend (basic-s0) [331.879493] Starting subtest: basic-S0 [331.881225] Starting dynamic subtest: smem [349.331960] Dynamic subtest smem: SUCCESS (1.619s) [349.333736] Subtest basic-S0: SUCCESS (1.619s) [355.526409] [169/171] (716s left) gem_exec_suspend (basic-s3) [355.581430] Starting subtest: basic-S3 [355.583393] Starting dynamic subtest: smem [373.409463] Dynamic subtest smem: SUCCESS (1.753s) [373.411324] Subtest basic-S3: SUCCESS (1.754s) [379.594286] [170/171] (714s left) kms_chamelium_hpd (common-hpd-after-suspend) [379.723010] Subtest common-hpd-after-suspend: SKIP (0.000s) [379.769388] [171/171] (714s left) kms_pipe_crc_basic (suspend-read-crc) [379.864190] Starting subtest: suspend-read-crc [379.865858] Starting dynamic subtest: pipe-A-HDMI-A-1 [397.445727] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.593s) [397.458332] Starting dynamic subtest: pipe-B-HDMI-A-1 [415.446169] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.593s) [415.455248] Starting dynamic subtest: pipe-C-HDMI-A-1 [433.516358] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.718s) [433.518156] Subtest suspend-read-crc: SUCCESS (4.907s) [437.564179] Closing watchdogs Done.