[42.552500] Initializing watchdogs [42.552562] /dev/watchdog0 [42.558853] [001/171] (960s left) i915_module_load (load) [42.613755] Starting subtest: load [43.535813] Subtest load: SUCCESS (0.922s) [43.552388] [002/171] (959s left) core_auth (basic-auth) [43.635111] Starting subtest: basic-auth [43.636554] Subtest basic-auth: SUCCESS (0.000s) [43.698241] [003/171] (959s left) debugfs_test (read_all_entries) [43.754964] Starting subtest: read_all_entries [43.802411] Subtest read_all_entries: SUCCESS (0.047s) [43.913311] [004/171] (959s left) debugfs_test (basic-hwmon) [43.967915] Starting subtest: basic-hwmon [43.971495] Subtest basic-hwmon: SKIP (0.000s) [44.064344] [005/171] (959s left) fbdev (eof) [44.119174] Starting subtest: eof [44.120814] Subtest eof: SUCCESS (0.000s) [44.163595] [006/171] (958s left) fbdev (info) [44.217597] Starting subtest: info [44.219614] Subtest info: SUCCESS (0.000s) [44.305631] [007/171] (958s left) fbdev (nullptr) [44.368917] Starting subtest: nullptr [44.370730] Subtest nullptr: SUCCESS (0.000s) [44.417051] [008/171] (958s left) fbdev (read) [44.502203] Starting subtest: read [44.719556] Subtest read: SUCCESS (0.217s) [44.763316] [009/171] (958s left) fbdev (write) [44.820852] Starting subtest: write [44.949100] Subtest write: SUCCESS (0.129s) [44.996946] [010/171] (958s left) gem_basic (bad-close) [45.048199] Starting subtest: bad-close [45.051480] Subtest bad-close: SUCCESS (0.000s) [45.097937] [011/171] (958s left) gem_basic (create-close) [45.156690] Starting subtest: create-close [45.160310] Subtest create-close: SUCCESS (0.000s) [45.238988] [012/171] (957s left) gem_basic (create-fd-close) [45.292226] Starting subtest: create-fd-close [45.295545] Subtest create-fd-close: SUCCESS (0.000s) [45.369614] [013/171] (957s left) gem_busy (busy@all-engines) [45.435748] Starting subtest: busy [45.437420] Starting dynamic subtest: all-engines [45.458111] Dynamic subtest all-engines: SUCCESS (0.022s) [45.459678] Subtest busy: SUCCESS (0.022s) [45.840313] [014/171] (957s left) gem_close_race (basic-process) [45.901359] Starting subtest: basic-process [45.954016] Subtest basic-process: SUCCESS (0.052s) [46.129395] [015/171] (957s left) gem_close_race (basic-threads) [46.238189] Starting subtest: basic-threads [47.448129] Subtest basic-threads: SUCCESS (1.210s) [47.658431] [016/171] (955s left) gem_ctx_create (basic) [47.753634] Starting subtest: basic [47.755228] Subtest basic: SUCCESS (0.000s) [47.930762] [017/171] (955s left) gem_ctx_create (basic-files) [48.002678] Starting subtest: basic-files [50.013084] Subtest basic-files: SUCCESS (2.010s) [50.240680] [018/171] (953s left) gem_ctx_exec (basic) [50.295995] Starting subtest: basic [50.297847] Subtest basic: SUCCESS (0.003s) [50.400988] [019/171] (952s left) gem_exec_basic (basic) [50.520163] Starting subtest: basic [50.521560] Starting dynamic subtest: rcs0-smem [50.523032] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [50.529175] Starting dynamic subtest: bcs0-smem [50.530684] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [50.536357] Starting dynamic subtest: vcs0-smem [50.538055] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [50.543623] Starting dynamic subtest: vecs0-smem [50.545316] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [50.547032] Subtest basic: SUCCESS (0.002s) [50.741306] [020/171] (952s left) gem_exec_create (basic) [50.800043] Starting subtest: basic [50.801519] Starting dynamic subtest: smem [52.850940] Dynamic subtest smem: SUCCESS (2.051s) [52.852687] Subtest basic: SUCCESS (2.051s) [53.059966] [021/171] (950s left) gem_exec_fence (basic-busy) [53.270798] Starting subtest: basic-busy [53.273636] Starting dynamic subtest: rcs0 [53.306913] Dynamic subtest rcs0: SUCCESS (0.036s) [53.329800] Starting dynamic subtest: bcs0 [53.351821] Dynamic subtest bcs0: SUCCESS (0.045s) [53.372621] Starting dynamic subtest: vcs0 [53.387979] Dynamic subtest vcs0: SUCCESS (0.036s) [53.399717] Starting dynamic subtest: vecs0 [53.416034] Dynamic subtest vecs0: SUCCESS (0.028s) [53.417686] Subtest basic-busy: SUCCESS (0.146s) [54.008284] [022/171] (949s left) gem_exec_fence (basic-wait) [54.208544] Starting subtest: basic-wait [54.210984] Starting dynamic subtest: rcs0 [54.239850] Dynamic subtest rcs0: SUCCESS (0.031s) [54.268701] Starting dynamic subtest: bcs0 [54.282194] Dynamic subtest bcs0: SUCCESS (0.042s) [54.303547] Starting dynamic subtest: vcs0 [54.317267] Dynamic subtest vcs0: SUCCESS (0.035s) [54.329391] Starting dynamic subtest: vecs0 [54.355159] Dynamic subtest vecs0: SUCCESS (0.038s) [54.357131] Subtest basic-wait: SUCCESS (0.147s) [54.856206] [023/171] (948s left) gem_exec_fence (basic-await) [55.057622] Starting subtest: basic-await [55.060177] Starting dynamic subtest: rcs0 [55.148692] Dynamic subtest rcs0: SUCCESS (0.092s) [55.156893] Starting dynamic subtest: bcs0 [55.226679] Dynamic subtest bcs0: SUCCESS (0.078s) [55.234994] Starting dynamic subtest: vcs0 [55.306902] Dynamic subtest vcs0: SUCCESS (0.079s) [55.328703] Starting dynamic subtest: vecs0 [55.405514] Dynamic subtest vecs0: SUCCESS (0.099s) [55.406962] Subtest basic-await: SUCCESS (0.349s) [55.978874] [024/171] (947s left) gem_exec_fence (nb-await) [56.182806] Starting subtest: nb-await [56.185735] Starting dynamic subtest: rcs0 [56.258280] Dynamic subtest rcs0: SUCCESS (0.075s) [56.265893] Starting dynamic subtest: bcs0 [56.317485] Dynamic subtest bcs0: SUCCESS (0.059s) [56.339092] Starting dynamic subtest: vcs0 [56.388443] Dynamic subtest vcs0: SUCCESS (0.070s) [56.410948] Starting dynamic subtest: vecs0 [56.460360] Dynamic subtest vecs0: SUCCESS (0.071s) [56.462316] Subtest nb-await: SUCCESS (0.278s) [56.963530] [025/171] (946s left) gem_exec_gttfill (basic) [57.034067] Starting subtest: basic [61.735061] Subtest basic: SUCCESS (4.701s) [61.896896] [026/171] (941s left) gem_exec_parallel (engines) [62.001446] Starting subtest: engines [62.002794] Starting dynamic subtest: basic [63.418804] Dynamic subtest basic: SUCCESS (1.417s) [63.426133] Starting dynamic subtest: contexts [66.086336] Dynamic subtest contexts: SUCCESS (2.667s) [66.092262] Starting dynamic subtest: fds [68.374127] Dynamic subtest fds: SUCCESS (2.288s) [68.380176] Starting dynamic subtest: userptr [70.226752] Dynamic subtest userptr: SUCCESS (1.852s) [70.228179] Subtest engines: SUCCESS (8.225s) [70.426028] [027/171] (933s left) gem_exec_store (basic) [70.492409] Starting subtest: basic [70.539168] Subtest basic: SUCCESS (0.046s) [70.741714] [028/171] (932s left) gem_flink_basic (bad-flink) [70.793626] Starting subtest: bad-flink [70.795226] Subtest bad-flink: SUCCESS (0.000s) [70.854483] [029/171] (932s left) gem_flink_basic (bad-open) [70.948818] Starting subtest: bad-open [70.950445] Subtest bad-open: SUCCESS (0.000s) [70.998480] [030/171] (932s left) gem_flink_basic (basic) [71.070528] Starting subtest: basic [71.072176] Subtest basic: SUCCESS (0.000s) [71.138318] [031/171] (932s left) gem_flink_basic (double-flink) [71.192902] Starting subtest: double-flink [71.194665] Subtest double-flink: SUCCESS (0.000s) [71.276779] [032/171] (932s left) gem_flink_basic (flink-lifetime) [71.333566] Starting subtest: flink-lifetime [71.334995] Subtest flink-lifetime: SUCCESS (0.001s) [71.429796] [033/171] (932s left) gem_huc_copy (huc-copy) [71.519947] Starting subtest: huc-copy [71.523246] Subtest huc-copy: SKIP (0.000s) [71.608975] [034/171] (932s left) gem_linear_blits (basic) [71.762908] Starting subtest: basic [71.767296] Subtest basic: SUCCESS (0.004s) [71.895526] [035/171] (931s left) gem_mmap (basic) [72.016851] Starting subtest: basic [72.025656] Subtest basic: SUCCESS (0.000s) [72.085824] [036/171] (931s left) gem_mmap_gtt (basic) [72.143054] Starting subtest: basic [72.144755] Subtest basic: SUCCESS (0.000s) [72.194498] [037/171] (931s left) gem_render_linear_blits (basic) [72.252169] Starting subtest: basic [72.269715] Subtest basic: SUCCESS (0.019s) [72.309517] [038/171] (931s left) gem_render_tiled_blits (basic) [72.369623] Starting subtest: basic [72.392162] Subtest basic: SUCCESS (0.022s) [72.447720] [039/171] (931s left) gem_ringfill (basic-all) [72.675616] Starting subtest: basic-all [73.822280] Subtest basic-all: SUCCESS (1.148s) [73.941664] [040/171] (929s left) gem_softpin (allocator-basic) [73.996700] Starting subtest: allocator-basic [74.054830] Subtest allocator-basic: SUCCESS (0.059s) [74.160639] [041/171] (929s left) gem_softpin (allocator-basic-reserve) [74.226136] Starting subtest: allocator-basic-reserve [74.284365] Subtest allocator-basic-reserve: SUCCESS (0.059s) [74.408109] [042/171] (929s left) gem_softpin (safe-alignment) [74.465867] Starting subtest: safe-alignment [74.472674] Subtest safe-alignment: SUCCESS (0.007s) [74.596478] [043/171] (929s left) gem_sync (basic-all) [74.700759] Starting subtest: basic-all [76.887814] Subtest basic-all: SUCCESS (2.195s) [77.067081] [044/171] (926s left) gem_sync (basic-each) [77.134675] Starting subtest: basic-each [79.194812] Subtest basic-each: SUCCESS (2.068s) [79.409582] [045/171] (924s left) gem_tiled_blits (basic) [79.554977] Starting subtest: basic [79.567194] Subtest basic: SUCCESS (0.012s) [79.707636] [046/171] (924s left) gem_tiled_fence_blits (basic) [79.917698] Starting subtest: basic [79.924731] Subtest basic: SUCCESS (0.007s) [80.061933] [047/171] (923s left) gem_tiled_pread_basic [80.374613] [048/171] (923s left) gem_wait (busy@all-engines) [80.449608] Starting subtest: busy [80.451238] Starting dynamic subtest: all-engines [80.963776] Dynamic subtest all-engines: SUCCESS (0.514s) [80.965365] Subtest busy: SUCCESS (0.514s) [81.143651] [049/171] (922s left) gem_wait (wait@all-engines) [81.206261] Starting subtest: wait [81.207919] Starting dynamic subtest: all-engines [82.251048] Dynamic subtest all-engines: SUCCESS (1.045s) [82.253710] Subtest wait: SUCCESS (1.046s) [82.442054] [050/171] (921s left) i915_getparams_basic (basic-eu-total) [82.494186] Starting subtest: basic-eu-total [82.497601] Subtest basic-eu-total: SUCCESS (0.000s) [82.550616] [051/171] (921s left) i915_getparams_basic (basic-subslice-total) [82.606715] Starting subtest: basic-subslice-total [82.609933] Subtest basic-subslice-total: SUCCESS (0.000s) [82.670678] [052/171] (921s left) i915_hangman (error-state-basic) [82.759162] Starting subtest: error-state-basic [82.763784] Subtest error-state-basic: SUCCESS (0.004s) [82.851313] [053/171] (921s left) i915_pciid [83.015853] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier) [83.088203] Starting subtest: addfb25-bad-modifier [83.090159] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [83.214840] [055/171] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [83.268068] Starting subtest: addfb25-framebuffer-vs-set-tiling [83.269732] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [83.381570] [056/171] (920s left) kms_addfb_basic (addfb25-modifier-no-flag) [83.435234] Starting subtest: addfb25-modifier-no-flag [83.436788] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [83.564610] [057/171] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy) [83.619207] Starting subtest: addfb25-x-tiled-legacy [83.620771] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [83.748136] [058/171] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [83.807787] Starting subtest: addfb25-x-tiled-mismatch-legacy [83.809265] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [83.931224] [059/171] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [84.033167] Starting subtest: addfb25-yf-tiled-legacy [84.034644] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [84.114272] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [84.223113] Starting subtest: addfb25-y-tiled-legacy [84.224679] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [84.297859] [061/171] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [84.404250] Starting subtest: addfb25-y-tiled-small-legacy [84.405786] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [84.481250] [062/171] (919s left) kms_addfb_basic (bad-pitch-0) [84.537469] Starting subtest: bad-pitch-0 [84.539043] Subtest bad-pitch-0: SUCCESS (0.000s) [84.647799] [063/171] (919s left) kms_addfb_basic (bad-pitch-1024) [84.700218] Starting subtest: bad-pitch-1024 [84.701909] Subtest bad-pitch-1024: SUCCESS (0.000s) [84.814603] [064/171] (919s left) kms_addfb_basic (bad-pitch-128) [84.869521] Starting subtest: bad-pitch-128 [84.871478] Subtest bad-pitch-128: SUCCESS (0.000s) [84.997910] [065/171] (919s left) kms_addfb_basic (bad-pitch-256) [85.057319] Starting subtest: bad-pitch-256 [85.059831] Subtest bad-pitch-256: SUCCESS (0.000s) [85.198009] [066/171] (919s left) kms_addfb_basic (bad-pitch-32) [85.250758] Starting subtest: bad-pitch-32 [85.252305] Subtest bad-pitch-32: SUCCESS (0.000s) [85.381262] [067/171] (918s left) kms_addfb_basic (bad-pitch-63) [85.442599] Starting subtest: bad-pitch-63 [85.444269] Subtest bad-pitch-63: SUCCESS (0.000s) [85.564477] [068/171] (918s left) kms_addfb_basic (bad-pitch-65536) [85.617565] Starting subtest: bad-pitch-65536 [85.619171] Subtest bad-pitch-65536: SUCCESS (0.000s) [85.748378] [069/171] (918s left) kms_addfb_basic (bad-pitch-999) [85.802392] Starting subtest: bad-pitch-999 [85.803959] Subtest bad-pitch-999: SUCCESS (0.000s) [85.914656] [070/171] (918s left) kms_addfb_basic (basic) [85.967168] Starting subtest: basic [85.968610] Subtest basic: SUCCESS (0.000s) [86.098317] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [86.150994] Starting subtest: basic-x-tiled-legacy [86.152630] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [86.264605] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [86.321065] Starting subtest: basic-y-tiled-legacy [86.322856] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [86.448577] [073/171] (917s left) kms_addfb_basic (bo-too-small) [86.548873] Starting subtest: bo-too-small [86.550334] Subtest bo-too-small: SUCCESS (0.000s) [86.631290] [074/171] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [86.732199] Starting subtest: bo-too-small-due-to-tiling [86.733653] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [86.815361] [075/171] (917s left) kms_addfb_basic (clobberred-modifier) [86.869302] Starting subtest: clobberred-modifier [86.870902] Subtest clobberred-modifier: SUCCESS (0.000s) [86.997936] [076/171] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling) [87.050402] Starting subtest: framebuffer-vs-set-tiling [87.051990] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [87.164622] [077/171] (917s left) kms_addfb_basic (invalid-get-prop) [87.217234] Starting subtest: invalid-get-prop [87.218592] Subtest invalid-get-prop: SUCCESS (0.000s) [87.347843] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any) [87.406886] Starting subtest: invalid-get-prop-any [87.408234] Subtest invalid-get-prop-any: SUCCESS (0.000s) [87.531318] [079/171] (916s left) kms_addfb_basic (invalid-set-prop) [87.583757] Starting subtest: invalid-set-prop [87.585175] Subtest invalid-set-prop: SUCCESS (0.000s) [87.697609] [080/171] (916s left) kms_addfb_basic (invalid-set-prop-any) [87.750290] Starting subtest: invalid-set-prop-any [87.751844] Subtest invalid-set-prop-any: SUCCESS (0.000s) [87.881341] [081/171] (916s left) kms_addfb_basic (no-handle) [87.933625] Starting subtest: no-handle [87.934976] Subtest no-handle: SUCCESS (0.000s) [88.047685] [082/171] (916s left) kms_addfb_basic (size-max) [88.147281] Starting subtest: size-max [88.148562] Subtest size-max: SUCCESS (0.000s) [88.214998] [083/171] (916s left) kms_addfb_basic (small-bo) [88.315245] Starting subtest: small-bo [88.316628] Subtest small-bo: SUCCESS (0.000s) [88.381297] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch) [88.434118] Starting subtest: tile-pitch-mismatch [88.435569] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [88.565616] [085/171] (915s left) kms_addfb_basic (too-high) [88.678454] Starting subtest: too-high [88.679859] Subtest too-high: SUCCESS (0.001s) [88.763995] [086/171] (915s left) kms_addfb_basic (too-wide) [88.870688] Starting subtest: too-wide [88.872556] Subtest too-wide: SUCCESS (0.000s) [88.947857] [087/171] (915s left) kms_addfb_basic (unused-handle) [88.999867] Starting subtest: unused-handle [89.001208] Subtest unused-handle: SUCCESS (0.000s) [89.131073] [088/171] (915s left) kms_addfb_basic (unused-modifier) [89.183383] Starting subtest: unused-modifier [89.184720] Subtest unused-modifier: SUCCESS (0.000s) [89.297878] [089/171] (915s left) kms_addfb_basic (unused-offsets) [89.349844] Starting subtest: unused-offsets [89.351338] Subtest unused-offsets: SUCCESS (0.000s) [89.481269] [090/171] (915s left) kms_addfb_basic (unused-pitches) [89.533675] Starting subtest: unused-pitches [89.535175] Subtest unused-pitches: SUCCESS (0.000s) [89.664274] [091/171] (914s left) kms_busy (basic) [89.767398] Starting subtest: basic [89.768770] Starting dynamic subtest: flip [90.307325] Dynamic subtest flip: SUCCESS (0.539s) [90.315222] Starting dynamic subtest: modeset [90.698196] Dynamic subtest modeset: SUCCESS (0.391s) [90.699708] Subtest basic: SUCCESS (0.931s) [90.812814] [092/171] (913s left) kms_chamelium_hpd (dp-hpd-fast) [90.938402] Subtest dp-hpd-fast: SKIP (0.000s) [90.986798] [093/171] (913s left) kms_chamelium_edid (dp-edid-read) [91.116788] Subtest dp-edid-read: SKIP (0.000s) [91.164668] [094/171] (913s left) kms_chamelium_frames (dp-crc-fast) [91.292690] Subtest dp-crc-fast: SKIP (0.000s) [91.340395] [095/171] (913s left) kms_chamelium_hpd (hdmi-hpd-fast) [91.468661] Subtest hdmi-hpd-fast: SKIP (0.000s) [91.516856] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read) [91.646606] Subtest hdmi-edid-read: SKIP (0.000s) [91.693819] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast) [91.823567] Subtest hdmi-crc-fast: SKIP (0.000s) [91.870979] [098/171] (912s left) kms_chamelium_hpd (vga-hpd-fast) [91.999878] Subtest vga-hpd-fast: SKIP (0.000s) [92.048981] [099/171] (912s left) kms_chamelium_edid (vga-edid-read) [92.177816] Subtest vga-edid-read: SKIP (0.000s) [92.226365] [100/171] (912s left) kms_prop_blob (basic) [92.280198] Starting subtest: basic [92.281782] Subtest basic: SUCCESS (0.000s) [92.329221] [101/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [92.432285] Starting subtest: basic-busy-flip-before-cursor-atomic [92.435328] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [92.495681] [102/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [92.598331] Starting subtest: basic-busy-flip-before-cursor-legacy [92.601198] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [92.645685] [103/171] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [92.748109] Starting subtest: basic-flip-after-cursor-atomic [93.653092] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.905s) [93.760207] [104/171] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [93.862113] Starting subtest: basic-flip-after-cursor-legacy [94.766692] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.904s) [94.874306] [105/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [94.976411] Starting subtest: basic-flip-after-cursor-varying-size [95.898832] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s) [96.008112] [106/171] (908s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [96.109195] Starting subtest: basic-flip-before-cursor-atomic [97.017648] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.908s) [97.124183] [107/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [97.224511] Starting subtest: basic-flip-before-cursor-legacy [98.148745] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.923s) [98.249911] [108/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [98.350394] Starting subtest: basic-flip-before-cursor-varying-size [99.257702] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.906s) [99.361356] [109/171] (905s left) kms_flip (basic-flip-vs-dpms) [99.452104] Starting subtest: basic-flip-vs-dpms [99.453527] Starting dynamic subtest: A-HDMI-A1 [100.305996] Dynamic subtest A-HDMI-A1: SUCCESS (0.852s) [100.312620] Starting dynamic subtest: B-HDMI-A1 [101.121296] Dynamic subtest B-HDMI-A1: SUCCESS (0.814s) [101.127962] Starting dynamic subtest: C-HDMI-A1 [101.948363] Dynamic subtest C-HDMI-A1: SUCCESS (0.827s) [101.949695] Subtest basic-flip-vs-dpms: SUCCESS (2.499s) [102.067211] [110/171] (902s left) kms_flip (basic-flip-vs-modeset) [102.161568] Starting subtest: basic-flip-vs-modeset [102.162998] Starting dynamic subtest: A-HDMI-A1 [102.976802] Dynamic subtest A-HDMI-A1: SUCCESS (0.812s) [102.983562] Starting dynamic subtest: B-HDMI-A1 [103.751851] Dynamic subtest B-HDMI-A1: SUCCESS (0.774s) [103.758520] Starting dynamic subtest: C-HDMI-A1 [104.529538] Dynamic subtest C-HDMI-A1: SUCCESS (0.777s) [104.531132] Subtest basic-flip-vs-modeset: SUCCESS (2.369s) [104.618733] [111/171] (900s left) kms_flip (basic-flip-vs-wf_vblank) [104.713149] Starting subtest: basic-flip-vs-wf_vblank [104.714752] Starting dynamic subtest: A-HDMI-A1 [105.811681] Dynamic subtest A-HDMI-A1: SUCCESS (1.097s) [105.818224] Starting dynamic subtest: B-HDMI-A1 [106.884568] Dynamic subtest B-HDMI-A1: SUCCESS (1.072s) [106.891156] Starting dynamic subtest: C-HDMI-A1 [107.957418] Dynamic subtest C-HDMI-A1: SUCCESS (1.072s) [107.960652] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.248s) [108.091467] [112/171] (896s left) kms_flip (basic-plain-flip) [108.184917] Starting subtest: basic-plain-flip [108.186675] Starting dynamic subtest: A-HDMI-A1 [109.000740] Dynamic subtest A-HDMI-A1: SUCCESS (0.816s) [109.008231] Starting dynamic subtest: B-HDMI-A1 [109.788953] Dynamic subtest B-HDMI-A1: SUCCESS (0.788s) [109.795692] Starting dynamic subtest: C-HDMI-A1 [110.576730] Dynamic subtest C-HDMI-A1: SUCCESS (0.787s) [110.578323] Subtest basic-plain-flip: SUCCESS (2.396s) [110.695364] [113/171] (894s left) kms_force_connector_basic (force-connector-state) [110.847700] Starting subtest: force-connector-state [111.202936] Subtest force-connector-state: SUCCESS (0.354s) [111.623351] [114/171] (893s left) kms_force_connector_basic (force-edid) [111.774774] Starting subtest: force-edid [111.911446] Subtest force-edid: SUCCESS (0.136s) [112.106467] [115/171] (892s left) kms_force_connector_basic (force-load-detect) [112.256715] Starting subtest: force-load-detect [112.259702] Subtest force-load-detect: SKIP (0.000s) [112.456457] [116/171] (892s left) kms_force_connector_basic (prune-stale-modes) [112.605919] Starting subtest: prune-stale-modes [112.739503] Subtest prune-stale-modes: SUCCESS (0.135s) [112.939903] [117/171] (892s left) kms_frontbuffer_tracking (basic) [113.049196] Starting subtest: basic [115.408788] Subtest basic: SUCCESS (2.363s) [115.492262] [118/171] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [115.598495] Starting subtest: compare-crc-sanitycheck-xr24 [115.600149] Starting dynamic subtest: pipe-A-HDMI-A-1 [115.948772] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.351s) [115.957425] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.288574] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.337s) [116.300550] Starting dynamic subtest: pipe-C-HDMI-A-1 [116.646440] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.356s) [116.647805] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.049s) [116.739658] [119/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [116.842972] Starting subtest: compare-crc-sanitycheck-nv12 [116.844504] Starting dynamic subtest: pipe-A-HDMI-A-1 [117.232031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.388s) [117.241231] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.615791] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.380s) [117.624895] Starting dynamic subtest: pipe-C-HDMI-A-1 [117.627802] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [117.629273] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.774s) [117.719128] [120/171] (887s left) kms_pipe_crc_basic (hang-read-crc) [117.822489] Starting subtest: hang-read-crc [117.823831] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.629648] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.806s) [118.637841] Starting dynamic subtest: pipe-B-HDMI-A-1 [119.461433] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.831s) [119.468161] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.357801] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.895s) [120.359393] Subtest hang-read-crc: SUCCESS (2.536s) [120.437502] [121/171] (884s left) kms_pipe_crc_basic (nonblocking-crc) [120.541483] Starting subtest: nonblocking-crc [120.542950] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.028717] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.486s) [121.036276] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.507517] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.478s) [121.514809] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.020600] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.512s) [122.022112] Subtest nonblocking-crc: SUCCESS (1.479s) [122.099724] [122/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.200367] Starting subtest: nonblocking-crc-frame-sequence [122.201926] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.709759] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.507s) [122.718160] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.190721] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.479s) [123.197406] Starting dynamic subtest: pipe-C-HDMI-A-1 [123.706350] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.514s) [123.707898] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.504s) [123.785959] [123/171] (881s left) kms_pipe_crc_basic (read-crc) [123.889068] Starting subtest: read-crc [123.890567] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.308625] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [124.316154] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.736638] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.428s) [124.745502] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.188508] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.449s) [125.189965] Subtest read-crc: SUCCESS (1.299s) [125.268325] [124/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.369625] Starting subtest: read-crc-frame-sequence [125.371150] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.793766] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.421s) [125.802215] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.204450] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.409s) [126.211226] Starting dynamic subtest: pipe-C-HDMI-A-1 [126.651762] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.446s) [126.653171] Subtest read-crc-frame-sequence: SUCCESS (1.280s) [126.730953] [125/171] (878s left) kms_psr (primary_page_flip) [126.786067] Subtest primary_page_flip: SKIP (0.000s) [126.810041] [126/171] (878s left) kms_psr (cursor_plane_move) [126.864839] Subtest cursor_plane_move: SKIP (0.000s) [126.891550] [127/171] (878s left) kms_psr (sprite_plane_onoff) [126.956459] Subtest sprite_plane_onoff: SKIP (0.000s) [126.975993] [128/171] (878s left) kms_psr (primary_mmap_gtt) [127.038070] Subtest primary_mmap_gtt: SKIP (0.000s) [127.059538] [129/171] (878s left) kms_setmode (basic-clone-single-crtc) [127.114938] Starting subtest: basic-clone-single-crtc [127.119501] Subtest basic-clone-single-crtc: SKIP (0.000s) [127.167754] [130/171] (878s left) i915_pm_backlight (basic-brightness) [127.290651] Subtest basic-brightness: SKIP (0.000s) [127.309467] [131/171] (877s left) i915_pm_rpm (basic-pci-d3-state) [128.711685] Starting subtest: basic-pci-d3-state [139.579439] Subtest basic-pci-d3-state: FAIL (10.843s) [139.853818] [132/171] (865s left) i915_pm_rpm (basic-rte) [139.911186] Starting subtest: basic-rte [152.101876] Subtest basic-rte: FAIL (12.048s) [163.128689] [133/171] (842s left) i915_pm_rps (basic-api) [163.188858] Starting subtest: basic-api [163.192128] Subtest basic-api: SUCCESS (0.002s) [163.248156] [134/171] (842s left) prime_self_import (basic-llseek-bad) [163.318315] Starting subtest: basic-llseek-bad [163.321134] Subtest basic-llseek-bad: SUCCESS (0.001s) [163.409399] [135/171] (841s left) prime_self_import (basic-llseek-size) [163.496147] Starting subtest: basic-llseek-size [163.498927] Subtest basic-llseek-size: SUCCESS (0.002s) [163.565895] [136/171] (841s left) prime_self_import (basic-with_fd_dup) [163.620502] Starting subtest: basic-with_fd_dup [163.623370] Subtest basic-with_fd_dup: SUCCESS (0.002s) [163.707981] [137/171] (841s left) prime_self_import (basic-with_one_bo) [163.794317] Starting subtest: basic-with_one_bo [163.797126] Subtest basic-with_one_bo: SUCCESS (0.002s) [163.841155] [138/171] (841s left) prime_self_import (basic-with_one_bo_two_files) [163.901943] Starting subtest: basic-with_one_bo_two_files [163.904731] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [163.972639] [139/171] (841s left) prime_self_import (basic-with_two_bos) [164.053417] Starting subtest: basic-with_two_bos [164.056542] Subtest basic-with_two_bos: SUCCESS (0.001s) [164.134187] [140/171] (841s left) prime_vgem (basic-fence-flip) [164.204055] Starting subtest: basic-fence-flip [164.599231] Subtest basic-fence-flip: SUCCESS (0.396s) [164.704155] [141/171] (840s left) prime_vgem (basic-fence-mmap) [164.770782] Starting subtest: basic-fence-mmap [164.785583] Subtest basic-fence-mmap: SUCCESS (0.016s) [164.884178] [142/171] (840s left) prime_vgem (basic-fence-read) [164.993369] Starting subtest: basic-fence-read [165.018095] Subtest basic-fence-read: SUCCESS (0.025s) [165.095799] [143/171] (840s left) prime_vgem (basic-gtt) [165.208469] Starting subtest: basic-gtt [165.215933] Subtest basic-gtt: SUCCESS (0.007s) [165.312815] [144/171] (840s left) prime_vgem (basic-read) [165.387518] Starting subtest: basic-read [165.397346] Subtest basic-read: SUCCESS (0.011s) [165.500156] [145/171] (840s left) prime_vgem (basic-write) [165.570786] Starting subtest: basic-write [165.581937] Subtest basic-write: SUCCESS (0.013s) [165.653442] [146/171] (839s left) vgem_basic (setversion) [165.717343] Starting subtest: setversion [165.720513] Subtest setversion: SUCCESS (0.000s) [165.766279] [147/171] (839s left) vgem_basic (create) [165.850952] Starting subtest: create [165.853372] Subtest create: SUCCESS (0.000s) [165.934988] [148/171] (839s left) vgem_basic (debugfs) [166.034500] Starting subtest: debugfs [166.036240] Subtest debugfs: SUCCESS (0.000s) [166.081291] [149/171] (839s left) vgem_basic (dmabuf-export) [166.167602] Starting subtest: dmabuf-export [166.184585] Subtest dmabuf-export: SUCCESS (0.018s) [166.312947] [150/171] (839s left) vgem_basic (dmabuf-fence) [166.384242] Starting subtest: dmabuf-fence [166.386036] Subtest dmabuf-fence: SUCCESS (0.000s) [166.431756] [151/171] (839s left) vgem_basic (dmabuf-fence-before) [166.500805] Starting subtest: dmabuf-fence-before [166.502596] Subtest dmabuf-fence-before: SUCCESS (0.000s) [166.547775] [152/171] (839s left) vgem_basic (dmabuf-mmap) [166.617366] Starting subtest: dmabuf-mmap [166.624891] Subtest dmabuf-mmap: SUCCESS (0.009s) [166.662347] [153/171] (839s left) vgem_basic (mmap) [166.734325] Starting subtest: mmap [166.738556] Subtest mmap: SUCCESS (0.006s) [166.780847] [154/171] (838s left) vgem_basic (second-client) [166.851766] Starting subtest: second-client [166.884128] Subtest second-client: SUCCESS (0.033s) [166.943350] [155/171] (838s left) vgem_basic (sysfs) [167.000779] Starting subtest: sysfs [167.002197] Subtest sysfs: SUCCESS (0.000s) [167.046759] [156/171] (838s left) core_hotunplug (unbind-rebind) [167.152638] Starting subtest: unbind-rebind [168.096815] Subtest unbind-rebind: SUCCESS (0.945s) [168.116477] [157/171] (837s left) vgem_basic (unload) [168.171910] Starting subtest: unload [197.044841] Subtest unload: SUCCESS (28.873s) [197.130235] [158/171] (808s left) i915_module_load (reload) [197.182098] Starting subtest: reload [199.074659] Subtest reload: SUCCESS (1.894s) [199.095705] [159/171] (806s left) gem_lmem_swapping (basic) [199.169808] Subtest basic: SKIP (0.000s) [199.200836] [160/171] (806s left) gem_lmem_swapping (parallel-random-engines) [199.256521] Subtest parallel-random-engines: SKIP (0.000s) [199.282562] [161/171] (806s left) gem_lmem_swapping (random-engines) [199.337857] Subtest random-engines: SKIP (0.000s) [199.366193] [162/171] (806s left) gem_lmem_swapping (verify-random) [199.426553] Subtest verify-random: SKIP (0.000s) [199.449687] [163/171] (806s left) i915_pm_rpm (module-reload) [201.133646] Starting subtest: module-reload [220.694214] Subtest module-reload: FAIL (19.331s) [220.798316] [164/171] (785s left) i915_selftest (live) [221.643098] Starting subtest: live [221.645628] Starting dynamic subtest: sanitycheck [222.120116] Dynamic subtest sanitycheck: SUCCESS (0.477s) [222.125693] Starting dynamic subtest: uncore [222.635037] Dynamic subtest uncore: SUCCESS (0.514s) [222.641288] Starting dynamic subtest: workarounds [223.325103] Dynamic subtest workarounds: SUCCESS (0.689s) [223.331190] Starting dynamic subtest: gt_engines [224.299162] Dynamic subtest gt_engines: SUCCESS (0.973s) [224.304937] Starting dynamic subtest: gt_timelines [230.262077] Dynamic subtest gt_timelines: SUCCESS (5.962s) [230.267844] Starting dynamic subtest: gt_contexts [230.861135] Dynamic subtest gt_contexts: SUCCESS (0.598s) [230.866791] Starting dynamic subtest: gt_lrc [233.663194] Dynamic subtest gt_lrc: SUCCESS (2.801s) [233.668980] Starting dynamic subtest: gt_mocs [234.223169] Dynamic subtest gt_mocs: SUCCESS (0.559s) [234.228947] Starting dynamic subtest: gt_pm [236.603124] Dynamic subtest gt_pm: SUCCESS (2.379s) [236.610298] Starting dynamic subtest: gt_heartbeat [237.202074] Dynamic subtest gt_heartbeat: SUCCESS (0.598s) [237.207816] Starting dynamic subtest: gt_tlb [238.578357] Dynamic subtest gt_tlb: SUCCESS (1.372s) [238.583931] Starting dynamic subtest: requests [245.303777] Dynamic subtest requests: SUCCESS (6.717s) [245.309465] Starting dynamic subtest: migrate [248.684543] Dynamic subtest migrate: SUCCESS (3.373s) [248.716351] Starting dynamic subtest: active [249.175794] Dynamic subtest active: SUCCESS (0.482s) [249.207544] Starting dynamic subtest: objects [250.161278] Dynamic subtest objects: SUCCESS (0.982s) [250.192468] Starting dynamic subtest: mman [253.989843] Dynamic subtest mman: SUCCESS (3.851s) [253.995299] Starting dynamic subtest: dmabuf [254.518115] Dynamic subtest dmabuf: SUCCESS (0.525s) [254.524049] Starting dynamic subtest: vma [255.035330] Dynamic subtest vma: SUCCESS (0.520s) [255.041029] Starting dynamic subtest: coherency [256.794302] Dynamic subtest coherency: SUCCESS (1.761s) [256.799988] Starting dynamic subtest: gtt [264.841272] Dynamic subtest gtt: SUCCESS (8.046s) [264.847526] Starting dynamic subtest: gem [265.448091] Dynamic subtest gem: SUCCESS (0.606s) [265.454876] Starting dynamic subtest: evict [266.721312] Dynamic subtest evict: SUCCESS (1.266s) [266.727595] Starting dynamic subtest: hugepages [273.152994] Dynamic subtest hugepages: SUCCESS (6.437s) [273.158132] Starting dynamic subtest: gem_contexts [285.222287] Dynamic subtest gem_contexts: SUCCESS (12.068s) [285.228401] Starting dynamic subtest: client [285.755062] Dynamic subtest client: SUCCESS (0.532s) [285.760749] Starting dynamic subtest: gem_migrate [286.273123] Dynamic subtest gem_migrate: SUCCESS (0.517s) [286.278661] Starting dynamic subtest: reset [287.113233] Dynamic subtest reset: SUCCESS (0.839s) [287.119107] Starting dynamic subtest: memory_region [287.613365] Dynamic subtest memory_region: SUCCESS (0.499s) [287.619266] Starting dynamic subtest: hangcheck [311.129214] Dynamic subtest hangcheck: SUCCESS (23.515s) [311.134957] Starting dynamic subtest: execlists [319.410017] Dynamic subtest execlists: SUCCESS (8.280s) [319.415422] Starting dynamic subtest: ring_submission [319.892223] Dynamic subtest ring_submission: SUCCESS (0.481s) [319.898329] Starting dynamic subtest: perf [320.480218] Dynamic subtest perf: SUCCESS (0.587s) [320.486010] Starting dynamic subtest: slpc [320.962166] Dynamic subtest slpc: SUCCESS (0.481s) [320.968304] Starting dynamic subtest: guc [321.430225] Dynamic subtest guc: SUCCESS (0.467s) [321.435970] Starting dynamic subtest: guc_multi_lrc [321.929213] Dynamic subtest guc_multi_lrc: SUCCESS (0.498s) [321.935047] Starting dynamic subtest: guc_hang [322.432076] Dynamic subtest guc_hang: SUCCESS (0.502s) [322.437920] Starting dynamic subtest: late_gt_pm [322.949961] Dynamic subtest late_gt_pm: SUCCESS (0.517s) [322.951651] Subtest live: SUCCESS (101.309s) [323.156642] [165/171] (682s left) dmabuf (all-tests) [323.212976] Starting subtest: all-tests [323.215946] Starting dynamic subtest: sanitycheck [323.286874] Dynamic subtest sanitycheck: SUCCESS (0.074s) [323.297539] Starting dynamic subtest: dma_fence [323.467023] Dynamic subtest dma_fence: SUCCESS (0.179s) [323.477474] Starting dynamic subtest: dma_fence_chain [334.031703] Dynamic subtest dma_fence_chain: SUCCESS (10.564s) [334.040662] Starting dynamic subtest: dma_fence_unwrap [334.110785] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s) [334.130649] Starting dynamic subtest: dma_resv [334.198269] Dynamic subtest dma_resv: SUCCESS (0.084s) [334.200961] Subtest all-tests: SUCCESS (10.986s) [334.246159] [166/171] (671s left) i915_suspend (basic-s2idle-without-i915) [334.338284] Starting subtest: basic-s2idle-without-i915 [351.665515] Subtest basic-s2idle-without-i915: SUCCESS (1.991s) [357.805888] [167/171] (669s left) i915_suspend (basic-s3-without-i915) [357.862151] Starting subtest: basic-s3-without-i915 [375.713972] Subtest basic-s3-without-i915: SUCCESS (1.888s) [381.857679] [168/171] (667s left) gem_exec_suspend (basic-s0) [381.943211] Starting subtest: basic-S0 [381.944747] Starting dynamic subtest: smem [399.687794] Dynamic subtest smem: SUCCESS (1.679s) [399.689610] Subtest basic-S0: SUCCESS (1.680s) [405.198282] [169/171] (665s left) gem_exec_suspend (basic-s3) [405.258892] Starting subtest: basic-S3 [405.260590] Starting dynamic subtest: smem [422.753812] Dynamic subtest smem: SUCCESS (1.753s) [422.755739] Subtest basic-S3: SUCCESS (1.754s) [435.947478] [170/171] (663s left) kms_chamelium_hpd (common-hpd-after-suspend) [436.101250] Subtest common-hpd-after-suspend: SKIP (0.000s) [436.157411] [171/171] (663s left) kms_pipe_crc_basic (suspend-read-crc) [436.259753] Starting subtest: suspend-read-crc [436.261502] Starting dynamic subtest: pipe-A-HDMI-A-1 [454.816384] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.581s) [454.825822] Starting dynamic subtest: pipe-B-HDMI-A-1 [472.830853] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.617s) [472.839613] Starting dynamic subtest: pipe-C-HDMI-A-1 [490.836876] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.675s) [490.838690] Subtest suspend-read-crc: SUCCESS (4.877s) [494.887650] Closing watchdogs Done.