don't know how to build these paths: /nix/store/wxxsrps0prwqj7y217iffajzi93l0x51-container-test-run-matrix-synapse.drv warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/sjrxfr15ii3gp76zx05as5a8lpgx54hy-unit-suid-sgid-wrappers.service-disabled.drv' on nix-store.geninf.io:50051 unit-suid-sgid-wrappers.service-disabled> attached to the build already running on this worker unit-suid-sgid-wrappers.service-disabled> build01: building sjrxfr15ii3gp76zx05as5a8lpgx54hy-unit-suid-sgid-wrappers.service-disabled.drv 87r393liq99ad7d5ybfv207v2yh0xbrk-firewall-start.drv: build01: not scheduled here: 87r393liq99ad7d5ybfv207v2yh0xbrk-firewall-start.drv, asking the scheduler again building '/nix/store/1dirzarzgf6kmnbns0qqgjc6w1k9qva8-unit-99-ethernet-default-dhcp.network.drv' on nix-store.geninf.io:50051 unit-99-ethernet-default-dhcp.network> build01: building 1dirzarzgf6kmnbns0qqgjc6w1k9qva8-unit-99-ethernet-default-dhcp.network.drv q81la62jls0xps5wrxsz899bip677nxl-unit-NetworkManager-wait-online.service-disabled.drv: build01: not scheduled here: q81la62jls0xps5wrxsz899bip677nxl-unit-NetworkManager-wait-online.service-disabled.drv, asking the scheduler again bpbzjcvmp688zaccclr1lg6i5lwvic5b-extra-hosts.drv: build01: not scheduled here: bpbzjcvmp688zaccclr1lg6i5lwvic5b-extra-hosts.drv, asking the scheduler again building '/nix/store/zywrfchlkmlhnl7vm5bj33dv40hxvv32-generator-state-version.drv' on nix-store.geninf.io:50051 generator-state-version> attached to the build already running on this worker building '/nix/store/q81la62jls0xps5wrxsz899bip677nxl-unit-NetworkManager-wait-online.service-disabled.drv' on nix-store.geninf.io:50051 unit-NetworkManager-wait-online.service-disabled> build01: building q81la62jls0xps5wrxsz899bip677nxl-unit-NetworkManager-wait-online.service-disabled.drv building '/nix/store/s5lvsbqnadxd04d5pm17cc3f5sqvzpg0-unit-systemd-networkd-wait-online.service-disabled.drv' on nix-store.geninf.io:50051 unit-systemd-networkd-wait-online.service-disabled> attached to the build already running on this worker unit-systemd-networkd-wait-online.service-disabled> build01: building s5lvsbqnadxd04d5pm17cc3f5sqvzpg0-unit-systemd-networkd-wait-online.service-disabled.drv generator-state-version> build01: building zywrfchlkmlhnl7vm5bj33dv40hxvv32-generator-state-version.drv building '/nix/store/ny5dwnwhqb4p74vwknbcvhif5phy0bfw-unit-acme-account-f9eabe74c37cd39fa8e7.target.drv' on nix-store.geninf.io:50051 unit-acme-account-f9eabe74c37cd39fa8e7.target> build01: building ny5dwnwhqb4p74vwknbcvhif5phy0bfw-unit-acme-account-f9eabe74c37cd39fa8e7.target.drv b0d3aczdgcpv9lz4vvgfwzmwvpmgvbkn-unit-backdoor.service-disabled.drv: build01: not scheduled here: b0d3aczdgcpv9lz4vvgfwzmwvpmgvbkn-unit-backdoor.service-disabled.drv, asking the scheduler again building '/nix/store/59jn0h8vfj6gx4lqj241rnv9rsw7z7x9-etc-ssh-ssh_config.drv' on nix-store.geninf.io:50051 etc-ssh-ssh_config> attached to the build already running on this worker vk2n8n64bbnwm3ac45jhxpg8rpil8l9h-unit-script-postgresql-post-start.drv: build01: not scheduled here: vk2n8n64bbnwm3ac45jhxpg8rpil8l9h-unit-script-postgresql-post-start.drv, asking the scheduler again building '/nix/store/xldssgx81h9lmaaimbwwg0rqm0cicrrs-unit-99-wireless-client-dhcp.network.drv' on nix-store.geninf.io:50051 unit-99-wireless-client-dhcp.network> attached to the build already running on this worker unit-99-wireless-client-dhcp.network> build01: building xldssgx81h9lmaaimbwwg0rqm0cicrrs-unit-99-wireless-client-dhcp.network.drv 55zpgzcisvcb2r7177nms09c4vrkwyyx-nixos-version.drv: build01: not scheduled here: 55zpgzcisvcb2r7177nms09c4vrkwyyx-nixos-version.drv, asking the scheduler again p7l0s4blzl01kdyv2avv67mq6laq8k9h-unit-resolvconf.service-disabled.drv: build01: not scheduled here: p7l0s4blzl01kdyv2avv67mq6laq8k9h-unit-resolvconf.service-disabled.drv, asking the scheduler again 1z18y4jx8yasrifsvyhp5b18a47hazsy-testScript.drv: build01: not scheduled here: 1z18y4jx8yasrifsvyhp5b18a47hazsy-testScript.drv, asking the scheduler again etc-ssh-ssh_config> build01: building 59jn0h8vfj6gx4lqj241rnv9rsw7z7x9-etc-ssh-ssh_config.drv 7vrljzkrvhdixc04hras3s9f1dvx9ywi-string-hosts.drv: build01: not scheduled here: 7vrljzkrvhdixc04hras3s9f1dvx9ywi-string-hosts.drv, asking the scheduler again xk3c06jd3s80zzvrq8ww191chabb9dc0-etc-os-release.drv: build01: not scheduled here: xk3c06jd3s80zzvrq8ww191chabb9dc0-etc-os-release.drv, asking the scheduler again xzakk5xldal0ii42j63argi84m3wa6qx-acme-postrun.drv: build01: not scheduled here: xzakk5xldal0ii42j63argi84m3wa6qx-acme-postrun.drv, asking the scheduler again hn32b8n37hzcx78ql54wwdf52vsyd077-unit-acme-renew-clan.test.timer.drv: build01: not scheduled here: hn32b8n37hzcx78ql54wwdf52vsyd077-unit-acme-renew-clan.test.timer.drv, asking the scheduler again 9jgm9f0i3hjicz5g5s88mx8jrg9hvwky-etc-fstab.drv: build01: not scheduled here: 9jgm9f0i3hjicz5g5s88mx8jrg9hvwky-etc-fstab.drv, asking the scheduler again i8qycj3xh2wi2nghd69v1dvmcxfdm8hi-acme-setup-privileged.drv: build01: not scheduled here: i8qycj3xh2wi2nghd69v1dvmcxfdm8hi-acme-setup-privileged.drv, asking the scheduler again pinx77ihh6790qmnz9hdl95r6n9rkq8p-postgresql.conf.drv: build01: not scheduled here: pinx77ihh6790qmnz9hdl95r6n9rkq8p-postgresql.conf.drv, asking the scheduler again a0milp439lhf9cb7781drqrlw6kfanhh-generator-matrix-synapse.drv: build01: not scheduled here: a0milp439lhf9cb7781drqrlw6kfanhh-generator-matrix-synapse.drv, asking the scheduler again 6s2dw8311a4g1n1jcxg12p4ms8l46wb8-perl-5.42.3-env.drv: build01: not scheduled here: 6s2dw8311a4g1n1jcxg12p4ms8l46wb8-perl-5.42.3-env.drv, asking the scheduler again gvcmyp8n89j40hl2gdl6zy9hgh26zzis-generator-matrix-password-someuser.drv: build01: not scheduled here: gvcmyp8n89j40hl2gdl6zy9hgh26zzis-generator-matrix-password-someuser.drv, asking the scheduler again 0w4kyjnq2cx8lkfg7bd4zj9lpj891frw-users-groups.json.drv: build01: not scheduled here: 0w4kyjnq2cx8lkfg7bd4zj9lpj891frw-users-groups.json.drv, asking the scheduler again 6rs729sziar4d1lhjmi8hl3n3h2hwsx4-matrix-synapse-create-users.drv: build01: not scheduled here: 6rs729sziar4d1lhjmi8hl3n3h2hwsx4-matrix-synapse-create-users.drv, asking the scheduler again mmzbkv3brvlhhf42g80mj28wy2ax34fl-postgres-db-restore-command-matrix-synapse.drv: build01: not scheduled here: mmzbkv3brvlhhf42g80mj28wy2ax34fl-postgres-db-restore-command-matrix-synapse.drv, asking the scheduler again 87r393liq99ad7d5ybfv207v2yh0xbrk-firewall-start.drv: build01: not scheduled here: 87r393liq99ad7d5ybfv207v2yh0xbrk-firewall-start.drv, asking the scheduler again sf07wpdpr877dczi0h9pa338v4dlppc4-nix.conf.drv: build01: not scheduled here: sf07wpdpr877dczi0h9pa338v4dlppc4-nix.conf.drv, asking the scheduler again building '/nix/store/y7s301zjnrxk5nklq12av1dxlsbidmrb-etc-bashrc.drv' on nix-store.geninf.io:50051 etc-bashrc> attached to the build already running on this worker etc-bashrc> build01: building y7s301zjnrxk5nklq12av1dxlsbidmrb-etc-bashrc.drv building '/nix/store/bpbzjcvmp688zaccclr1lg6i5lwvic5b-extra-hosts.drv' on nix-store.geninf.io:50051 extra-hosts> attached to the build already running on this worker extra-hosts> build01: building bpbzjcvmp688zaccclr1lg6i5lwvic5b-extra-hosts.drv building '/nix/store/7vrljzkrvhdixc04hras3s9f1dvx9ywi-string-hosts.drv' on nix-store.geninf.io:50051 string-hosts> attached to the build already running on this worker building '/nix/store/pinx77ihh6790qmnz9hdl95r6n9rkq8p-postgresql.conf.drv' on nix-store.geninf.io:50051 postgresql.conf> attached to the build already running on this worker postgresql.conf> build01: building pinx77ihh6790qmnz9hdl95r6n9rkq8p-postgresql.conf.drv string-hosts> build01: building 7vrljzkrvhdixc04hras3s9f1dvx9ywi-string-hosts.drv building '/nix/store/vk2n8n64bbnwm3ac45jhxpg8rpil8l9h-unit-script-postgresql-post-start.drv' on nix-store.geninf.io:50051 unit-script-postgresql-post-start> build01: building vk2n8n64bbnwm3ac45jhxpg8rpil8l9h-unit-script-postgresql-post-start.drv 8b6d208gs8awrkmzhvmb2h1r6nq6c6vv-generator-matrix-password-admin.drv: build01: not scheduled here: 8b6d208gs8awrkmzhvmb2h1r6nq6c6vv-generator-matrix-password-admin.drv, asking the scheduler again building '/nix/store/xzakk5xldal0ii42j63argi84m3wa6qx-acme-postrun.drv' on nix-store.geninf.io:50051 acme-postrun> build01: building xzakk5xldal0ii42j63argi84m3wa6qx-acme-postrun.drv building '/nix/store/1z18y4jx8yasrifsvyhp5b18a47hazsy-testScript.drv' on nix-store.geninf.io:50051 testScript> build01: building 1z18y4jx8yasrifsvyhp5b18a47hazsy-testScript.drv v327jl8mxmgg31hsc9r1milzw6qswr6s-unit-script-acme-clan.test-start.drv: build01: not scheduled here: v327jl8mxmgg31hsc9r1milzw6qswr6s-unit-script-acme-clan.test-start.drv, asking the scheduler again kx7i73w1xs1ry1fp4ayqv2jqzj1pr4dw-stage-2-init.sh.drv: build01: not scheduled here: kx7i73w1xs1ry1fp4ayqv2jqzj1pr4dw-stage-2-init.sh.drv, asking the scheduler again building '/nix/store/hn32b8n37hzcx78ql54wwdf52vsyd077-unit-acme-renew-clan.test.timer.drv' on nix-store.geninf.io:50051 unit-acme-renew-clan.test.timer> build01: building hn32b8n37hzcx78ql54wwdf52vsyd077-unit-acme-renew-clan.test.timer.drv s0wjfk4qv660jl8gwg5cvjrdcrmlsqmg-X-Reload-Triggers-systemd-networkd.drv: build01: not scheduled here: s0wjfk4qv660jl8gwg5cvjrdcrmlsqmg-X-Reload-Triggers-systemd-networkd.drv, asking the scheduler again 76q1mdfaj105ygzj5sjxm8ki0q9cc2sw-unit-nginx-config-reload.service.drv: build01: not scheduled here: 76q1mdfaj105ygzj5sjxm8ki0q9cc2sw-unit-nginx-config-reload.service.drv, asking the scheduler again ylhcqjzai8ic8sijv6n02fx31dlzchj7-mount-secret-fs.drv: build01: not scheduled here: ylhcqjzai8ic8sijv6n02fx31dlzchj7-mount-secret-fs.drv, asking the scheduler again ws9iqnyhfxaxyx58n5r442lg4f9rg7zc-tmpfiles.d.drv: build01: not scheduled here: ws9iqnyhfxaxyx58n5r442lg4f9rg7zc-tmpfiles.d.drv, asking the scheduler again y70z2qq12hyvn2y5j6qrlcvix77i3q1m-unit-network-local-commands.service.drv: build01: not scheduled here: y70z2qq12hyvn2y5j6qrlcvix77i3q1m-unit-network-local-commands.service.drv, asking the scheduler again ik1b4pq76hgpbz9a17mxw36kjgk3ri78-unit-script-acme-order-renew-clan.test-start.drv: build01: not scheduled here: ik1b4pq76hgpbz9a17mxw36kjgk3ri78-unit-script-acme-order-renew-clan.test-start.drv, asking the scheduler again building '/nix/store/i8qycj3xh2wi2nghd69v1dvmcxfdm8hi-acme-setup-privileged.drv' on nix-store.geninf.io:50051 acme-setup-privileged> build01: building i8qycj3xh2wi2nghd69v1dvmcxfdm8hi-acme-setup-privileged.drv hpl2ynj3sfx7mip5f5ic2xmxi6w3mq11-state-commands.drv: build01: not scheduled here: hpl2ynj3sfx7mip5f5ic2xmxi6w3mq11-state-commands.drv, asking the scheduler again wbjnjd86z7cwq01knpyr3595dbccj962-X-Restart-Triggers-acme-clan.test.drv: build01: not scheduled here: wbjnjd86z7cwq01knpyr3595dbccj962-X-Restart-Triggers-acme-clan.test.drv, asking the scheduler again building '/nix/store/a0milp439lhf9cb7781drqrlw6kfanhh-generator-matrix-synapse.drv' on nix-store.geninf.io:50051 generator-matrix-synapse> build01: building a0milp439lhf9cb7781drqrlw6kfanhh-generator-matrix-synapse.drv building '/nix/store/gvcmyp8n89j40hl2gdl6zy9hgh26zzis-generator-matrix-password-someuser.drv' on nix-store.geninf.io:50051 generator-matrix-password-someuser> build01: building gvcmyp8n89j40hl2gdl6zy9hgh26zzis-generator-matrix-password-someuser.drv building '/nix/store/0w4kyjnq2cx8lkfg7bd4zj9lpj891frw-users-groups.json.drv' on nix-store.geninf.io:50051 users-groups.json> build01: building 0w4kyjnq2cx8lkfg7bd4zj9lpj891frw-users-groups.json.drv building '/nix/store/mmzbkv3brvlhhf42g80mj28wy2ax34fl-postgres-db-restore-command-matrix-synapse.drv' on nix-store.geninf.io:50051 postgres-db-restore-command-matrix-synapse> build01: building mmzbkv3brvlhhf42g80mj28wy2ax34fl-postgres-db-restore-command-matrix-synapse.drv building '/nix/store/6rs729sziar4d1lhjmi8hl3n3h2hwsx4-matrix-synapse-create-users.drv' on nix-store.geninf.io:50051 matrix-synapse-create-users> build01: building 6rs729sziar4d1lhjmi8hl3n3h2hwsx4-matrix-synapse-create-users.drv qm6jbx3ja7qqj650zv7sv2jplvp8xkwb-shutdown-ramfs-contents.json.drv: build01: not scheduled here: qm6jbx3ja7qqj650zv7sv2jplvp8xkwb-shutdown-ramfs-contents.json.drv, asking the scheduler again zma00xbq38a11fgy8zvr9rcjbcfh1c30-element-web-with-config.drv: build01: not scheduled here: zma00xbq38a11fgy8zvr9rcjbcfh1c30-element-web-with-config.drv, asking the scheduler again building '/nix/store/0g5hwj7y8xv8sdr8jgldc3j8qmy023i6-hosts.drv' on nix-store.geninf.io:50051 hosts> build01: building 0g5hwj7y8xv8sdr8jgldc3j8qmy023i6-hosts.drv 4i42wfv5b49r782fgjl40f7q53q1b42q-firewall-reload.drv: build01: not scheduled here: 4i42wfv5b49r782fgjl40f7q53q1b42q-firewall-reload.drv, asking the scheduler again building '/nix/store/8b6d208gs8awrkmzhvmb2h1r6nq6c6vv-generator-matrix-password-admin.drv' on nix-store.geninf.io:50051 generator-matrix-password-admin> build01: building 8b6d208gs8awrkmzhvmb2h1r6nq6c6vv-generator-matrix-password-admin.drv z5idnjhajb6hrq23izvmkav6i36gbhvq-python3.13-nixos-test-lib-1.0.0.drv: build01: not scheduled here: z5idnjhajb6hrq23izvmkav6i36gbhvq-python3.13-nixos-test-lib-1.0.0.drv, asking the scheduler again building '/nix/store/v327jl8mxmgg31hsc9r1milzw6qswr6s-unit-script-acme-clan.test-start.drv' on nix-store.geninf.io:50051 unit-script-acme-clan.test-start> build01: building v327jl8mxmgg31hsc9r1milzw6qswr6s-unit-script-acme-clan.test-start.drv 9adgydnh07zp815cksvc8k5w91w0c6ma-homeserver.yaml.drv: build01: not scheduled here: 9adgydnh07zp815cksvc8k5w91w0c6ma-homeserver.yaml.drv, asking the scheduler again 1v7hdfipfx5jx34dgbmyzl81k39sywcc-unit-script-postgresql-pre-start.drv: build01: not scheduled here: 1v7hdfipfx5jx34dgbmyzl81k39sywcc-unit-script-postgresql-pre-start.drv, asking the scheduler again qk2id8wxxxqfca7y4zp8plcrn4vr6dmh-postgresql-configfile-check.drv: build01: not scheduled here: qk2id8wxxxqfca7y4zp8plcrn4vr6dmh-postgresql-configfile-check.drv, asking the scheduler again building '/nix/store/ahwky2imndrhg86zbs119ldh71fs54x8-X-Restart-Triggers-nix-daemon.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-nix-daemon> attached to the build already running on this worker X-Restart-Triggers-nix-daemon> build01: building ahwky2imndrhg86zbs119ldh71fs54x8-X-Restart-Triggers-nix-daemon.drv building '/nix/store/76q1mdfaj105ygzj5sjxm8ki0q9cc2sw-unit-nginx-config-reload.service.drv' on nix-store.geninf.io:50051 unit-nginx-config-reload.service> build01: building 76q1mdfaj105ygzj5sjxm8ki0q9cc2sw-unit-nginx-config-reload.service.drv building '/nix/store/ws9iqnyhfxaxyx58n5r442lg4f9rg7zc-tmpfiles.d.drv' on nix-store.geninf.io:50051 tmpfiles.d> build01: building ws9iqnyhfxaxyx58n5r442lg4f9rg7zc-tmpfiles.d.drv building '/nix/store/wbjnjd86z7cwq01knpyr3595dbccj962-X-Restart-Triggers-acme-clan.test.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-acme-clan.test> build01: building wbjnjd86z7cwq01knpyr3595dbccj962-X-Restart-Triggers-acme-clan.test.drv building '/nix/store/ik1b4pq76hgpbz9a17mxw36kjgk3ri78-unit-script-acme-order-renew-clan.test-start.drv' on nix-store.geninf.io:50051 unit-script-acme-order-renew-clan.test-start> build01: building ik1b4pq76hgpbz9a17mxw36kjgk3ri78-unit-script-acme-order-renew-clan.test-start.drv building '/nix/store/hpl2ynj3sfx7mip5f5ic2xmxi6w3mq11-state-commands.drv' on nix-store.geninf.io:50051 state-commands> build01: building hpl2ynj3sfx7mip5f5ic2xmxi6w3mq11-state-commands.drv building '/nix/store/zma00xbq38a11fgy8zvr9rcjbcfh1c30-element-web-with-config.drv' on nix-store.geninf.io:50051 element-web-with-config> build01: building zma00xbq38a11fgy8zvr9rcjbcfh1c30-element-web-with-config.drv building '/nix/store/4i42wfv5b49r782fgjl40f7q53q1b42q-firewall-reload.drv' on nix-store.geninf.io:50051 firewall-reload> attached to the build already running on this worker firewall-reload> build01: building 4i42wfv5b49r782fgjl40f7q53q1b42q-firewall-reload.drv building '/nix/store/qk2id8wxxxqfca7y4zp8plcrn4vr6dmh-postgresql-configfile-check.drv' on nix-store.geninf.io:50051 postgresql-configfile-check> attached to the build already running on this worker building '/nix/store/9adgydnh07zp815cksvc8k5w91w0c6ma-homeserver.yaml.drv' on nix-store.geninf.io:50051 homeserver.yaml> build01: building 9adgydnh07zp815cksvc8k5w91w0c6ma-homeserver.yaml.drv homeserver.yaml> structuredAttrs is enabled postgresql-configfile-check> build01: building qk2id8wxxxqfca7y4zp8plcrn4vr6dmh-postgresql-configfile-check.drv postgresql-configfile-check> 2026-10-07 15:16:33.775 GMT [5] LOG: skipping missing configuration file "/nix/store/p06x0nhwly0bg5wdz32p10myx08xpkf5-postgresql.conf/postgresql.auto.conf" amyxa33r1wybp97471y119mskcnjsw79-unit-systemd-networkd.service.drv: build01: not scheduled here: amyxa33r1wybp97471y119mskcnjsw79-unit-systemd-networkd.service.drv, asking the scheduler again d1h1hxqcpbrrgi0vqfy0hxjy6xjhr7ml-unit-generate-shutdown-ramfs.service.drv: build01: not scheduled here: d1h1hxqcpbrrgi0vqfy0hxjy6xjhr7ml-unit-generate-shutdown-ramfs.service.drv, asking the scheduler again 2vkvkfqamcs8yylj24vxir2rg9rrb0rv-decrypt-age-secrets.drv: build01: not scheduled here: 2vkvkfqamcs8yylj24vxir2rg9rrb0rv-decrypt-age-secrets.drv, asking the scheduler again dlp0j6m4s0fj061jjbj7js5kki2q7mn9-unit-acme-setup.service.drv: build01: not scheduled here: dlp0j6m4s0fj061jjbj7js5kki2q7mn9-unit-acme-setup.service.drv, asking the scheduler again ylcl14srad7wmgm4s4j3x3mrx8x6qhmg-test-driver-0.0.1.drv: build01: not scheduled here: ylcl14srad7wmgm4s4j3x3mrx8x6qhmg-test-driver-0.0.1.drv, asking the scheduler again 8zwfnxd8p02k1wvx0jrkhcs0kygr38bx-vars-check-matrix-synapse.drv: build01: not scheduled here: 8zwfnxd8p02k1wvx0jrkhcs0kygr38bx-vars-check-matrix-synapse.drv, asking the scheduler again 5h3kimag6l6pljvnx39jphmb08pva54g-unit-nix-daemon.service.drv: build01: not scheduled here: 5h3kimag6l6pljvnx39jphmb08pva54g-unit-nix-daemon.service.drv, asking the scheduler again 7ycih7m7z7kaj4rrdzvfs4ysyd9sh0wk-X-Restart-Triggers-systemd-tmpfiles-resetup.drv: build01: not scheduled here: 7ycih7m7z7kaj4rrdzvfs4ysyd9sh0wk-X-Restart-Triggers-systemd-tmpfiles-resetup.drv, asking the scheduler again vda2irkb2dm1m2507rkibvk9xpai1r6z-unit-postgresql.service.drv: build01: not scheduled here: vda2irkb2dm1m2507rkibvk9xpai1r6z-unit-postgresql.service.drv, asking the scheduler again yra0afh21y5wvggdbi41k1lrlnyfsl5r-unit-acme-clan.test.service.drv: build01: not scheduled here: yra0afh21y5wvggdbi41k1lrlnyfsl5r-unit-acme-clan.test.service.drv, asking the scheduler again cvbyrwpw64v1d3m3vmj930v9kf8dchmm-unit-acme-order-renew-clan.test.service.drv: build01: not scheduled here: cvbyrwpw64v1d3m3vmj930v9kf8dchmm-unit-acme-order-renew-clan.test.service.drv, asking the scheduler again bfaz9n16ppnrajlhkffd16w8nca97ji3-nginx.conf.drv: build01: not scheduled here: bfaz9n16ppnrajlhkffd16w8nca97ji3-nginx.conf.drv, asking the scheduler again building '/nix/store/4l734z9gqdz9fgfys803knc0gwsgndyg-unit-firewall.service.drv' on nix-store.geninf.io:50051 unit-firewall.service> build01: building 4l734z9gqdz9fgfys803knc0gwsgndyg-unit-firewall.service.drv building '/nix/store/2vkvkfqamcs8yylj24vxir2rg9rrb0rv-decrypt-age-secrets.drv' on nix-store.geninf.io:50051 decrypt-age-secrets> build01: building 2vkvkfqamcs8yylj24vxir2rg9rrb0rv-decrypt-age-secrets.drv building '/nix/store/dlp0j6m4s0fj061jjbj7js5kki2q7mn9-unit-acme-setup.service.drv' on nix-store.geninf.io:50051 unit-acme-setup.service> build01: building dlp0j6m4s0fj061jjbj7js5kki2q7mn9-unit-acme-setup.service.drv building '/nix/store/8zwfnxd8p02k1wvx0jrkhcs0kygr38bx-vars-check-matrix-synapse.drv' on nix-store.geninf.io:50051 vars-check-matrix-synapse> build01: building 8zwfnxd8p02k1wvx0jrkhcs0kygr38bx-vars-check-matrix-synapse.drv vars-check-matrix-synapse> Running vars check using Nix-based executor... vars-check-matrix-synapse> Processing machine: machine vars-check-matrix-synapse> Generator execution order: matrix-password-admin -> matrix-password-someuser -> matrix-synapse -> state-version vars-check-matrix-synapse> Executing generator: matrix-password-admin vars-check-matrix-synapse> + set -euo pipefail vars-check-matrix-synapse> + PATH=/nix/store/bqvjxkjy0mb26x4yw0phdfyi607mfmhy-python3.13-xkcdpass-1.30.0/bin:/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin vars-check-matrix-synapse> + [[ ! -d /etc ]] vars-check-matrix-synapse> + mkdir -p /etc vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -u vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> + xkcdpass -n 6 -d - vars-check-matrix-synapse> ✓ Generated file: matrix-password-admin/matrix-password-admin vars-check-matrix-synapse> ✓ Generator matrix-password-admin completed vars-check-matrix-synapse> Executing generator: matrix-password-someuser vars-check-matrix-synapse> + set -euo pipefail vars-check-matrix-synapse> + PATH=/nix/store/bqvjxkjy0mb26x4yw0phdfyi607mfmhy-python3.13-xkcdpass-1.30.0/bin:/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin vars-check-matrix-synapse> + [[ ! -d /etc ]] vars-check-matrix-synapse> + mkdir -p /etc vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -u vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> + xkcdpass -n 6 -d - vars-check-matrix-synapse> ✓ Generated file: matrix-password-someuser/matrix-password-someuser vars-check-matrix-synapse> ✓ Generator matrix-password-someuser completed vars-check-matrix-synapse> Executing generator: matrix-synapse vars-check-matrix-synapse> + set -euo pipefail vars-check-matrix-synapse> + PATH=/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin:/nix/store/vxjmypc4i6mdj2kxa3ilm8k990f8zzw3-pwgen-2.08/bin:/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin vars-check-matrix-synapse> + [[ ! -d /etc ]] vars-check-matrix-synapse> + mkdir -p /etc vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -u vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ pwgen -s 32 1 vars-check-matrix-synapse> + echo -n e4Q7e2HkZo0Wtch0MVEV1o8o5Et9VgU3 vars-check-matrix-synapse> ✓ Generated file: matrix-synapse/synapse-registration_shared_secret vars-check-matrix-synapse> ✓ Generator matrix-synapse completed vars-check-matrix-synapse> Executing generator: state-version vars-check-matrix-synapse> + set -euo pipefail vars-check-matrix-synapse> + PATH=/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin vars-check-matrix-synapse> + [[ ! -d /etc ]] vars-check-matrix-synapse> + mkdir -p /etc vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> ++ id -u vars-check-matrix-synapse> ++ id -g vars-check-matrix-synapse> + cat vars-check-matrix-synapse> + echo -n 26.05 vars-check-matrix-synapse> ✓ Generated file: state-version/version vars-check-matrix-synapse> ✓ Generator state-version completed vars-check-matrix-synapse> ✓ Machine machine completed vars-check-matrix-synapse> ✓ All vars checks completed successfully building '/nix/store/7ycih7m7z7kaj4rrdzvfs4ysyd9sh0wk-X-Restart-Triggers-systemd-tmpfiles-resetup.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-systemd-tmpfiles-resetup> attached to the build already running on this worker X-Restart-Triggers-systemd-tmpfiles-resetup> build01: building 7ycih7m7z7kaj4rrdzvfs4ysyd9sh0wk-X-Restart-Triggers-systemd-tmpfiles-resetup.drv building '/nix/store/vda2irkb2dm1m2507rkibvk9xpai1r6z-unit-postgresql.service.drv' on nix-store.geninf.io:50051 unit-postgresql.service> build01: building vda2irkb2dm1m2507rkibvk9xpai1r6z-unit-postgresql.service.drv building '/nix/store/yra0afh21y5wvggdbi41k1lrlnyfsl5r-unit-acme-clan.test.service.drv' on nix-store.geninf.io:50051 unit-acme-clan.test.service> build01: building yra0afh21y5wvggdbi41k1lrlnyfsl5r-unit-acme-clan.test.service.drv building '/nix/store/cvbyrwpw64v1d3m3vmj930v9kf8dchmm-unit-acme-order-renew-clan.test.service.drv' on nix-store.geninf.io:50051 unit-acme-order-renew-clan.test.service> build01: building cvbyrwpw64v1d3m3vmj930v9kf8dchmm-unit-acme-order-renew-clan.test.service.drv v96s2xvbgk3yxyvxccbflr74yjfc5s5i-unit-script-matrix-synapse-pre-start.drv: build01: not scheduled here: v96s2xvbgk3yxyvxccbflr74yjfc5s5i-unit-script-matrix-synapse-pre-start.drv, asking the scheduler again ij55bb8xk4syxpzz207vfbrabq8a6k5b-matrix-synapse-register_new_matrix_user.drv: build01: not scheduled here: ij55bb8xk4syxpzz207vfbrabq8a6k5b-matrix-synapse-register_new_matrix_user.drv, asking the scheduler again building '/nix/store/bfaz9n16ppnrajlhkffd16w8nca97ji3-nginx.conf.drv' on nix-store.geninf.io:50051 nginx.conf> build01: building bfaz9n16ppnrajlhkffd16w8nca97ji3-nginx.conf.drv nginx.conf> nginx.conf> ==================== Results =================== nginx.conf> No issues found. nginx.conf> nginx.conf> ==================== Summary =================== nginx.conf> Total issues: nginx.conf> Unspecified: 0 nginx.conf> Low: 0 nginx.conf> Medium: 0 nginx.conf> High: 0 nginx.conf> building '/nix/store/a5g0m5hgy62854vx46v9cs1bpcfvsbs9-dry-activate.drv' on nix-store.geninf.io:50051 dry-activate> build01: building a5g0m5hgy62854vx46v9cs1bpcfvsbs9-dry-activate.drv building '/nix/store/v96s2xvbgk3yxyvxccbflr74yjfc5s5i-unit-script-matrix-synapse-pre-start.drv' on nix-store.geninf.io:50051 unit-script-matrix-synapse-pre-start> build01: building v96s2xvbgk3yxyvxccbflr74yjfc5s5i-unit-script-matrix-synapse-pre-start.drv building '/nix/store/ij55bb8xk4syxpzz207vfbrabq8a6k5b-matrix-synapse-register_new_matrix_user.drv' on nix-store.geninf.io:50051 matrix-synapse-register_new_matrix_user> build01: building ij55bb8xk4syxpzz207vfbrabq8a6k5b-matrix-synapse-register_new_matrix_user.drv s0i1wqmia43ydk0mklymfga28pkhqqnr-unit-systemd-tmpfiles-resetup.service.drv: build01: not scheduled here: s0i1wqmia43ydk0mklymfga28pkhqqnr-unit-systemd-tmpfiles-resetup.service.drv, asking the scheduler again building '/nix/store/s0i1wqmia43ydk0mklymfga28pkhqqnr-unit-systemd-tmpfiles-resetup.service.drv' on nix-store.geninf.io:50051 unit-systemd-tmpfiles-resetup.service> attached to the build already running on this worker unit-systemd-tmpfiles-resetup.service> build01: building s0i1wqmia43ydk0mklymfga28pkhqqnr-unit-systemd-tmpfiles-resetup.service.drv 32pkkqswmlmws0y6pjjgbfl0ryc4bwp9-unit-script-nginx-pre-start.drv: build01: not scheduled here: 32pkkqswmlmws0y6pjjgbfl0ryc4bwp9-unit-script-nginx-pre-start.drv, asking the scheduler again building '/nix/store/32pkkqswmlmws0y6pjjgbfl0ryc4bwp9-unit-script-nginx-pre-start.drv' on nix-store.geninf.io:50051 unit-script-nginx-pre-start> build01: building 32pkkqswmlmws0y6pjjgbfl0ryc4bwp9-unit-script-nginx-pre-start.drv yn2vy3sivmzisqxyb3v581xm6zfaxhi7-unit-matrix-synapse.service.drv: build01: not scheduled here: yn2vy3sivmzisqxyb3v581xm6zfaxhi7-unit-matrix-synapse.service.drv, asking the scheduler again building '/nix/store/yn2vy3sivmzisqxyb3v581xm6zfaxhi7-unit-matrix-synapse.service.drv' on nix-store.geninf.io:50051 unit-matrix-synapse.service> build01: building yn2vy3sivmzisqxyb3v581xm6zfaxhi7-unit-matrix-synapse.service.drv 4y56hvjyyypjdn1cbiw1r4vx5sg6vh4f-system-path.drv: build01: not scheduled here: 4y56hvjyyypjdn1cbiw1r4vx5sg6vh4f-system-path.drv, asking the scheduler again building '/nix/store/4y56hvjyyypjdn1cbiw1r4vx5sg6vh4f-system-path.drv' on nix-store.geninf.io:50051 system-path> build01: building 4y56hvjyyypjdn1cbiw1r4vx5sg6vh4f-system-path.drv system-path> structuredAttrs is enabled system-path> created 1942 symlinks in user environment kf744lv4f831cjqni4fpqa221yn0b1wp-unit-nginx.service.drv: build01: not scheduled here: kf744lv4f831cjqni4fpqa221yn0b1wp-unit-nginx.service.drv, asking the scheduler again building '/nix/store/kf744lv4f831cjqni4fpqa221yn0b1wp-unit-nginx.service.drv' on nix-store.geninf.io:50051 unit-nginx.service> build01: building kf744lv4f831cjqni4fpqa221yn0b1wp-unit-nginx.service.drv building '/nix/store/xv6yhg5flwcrdcm37r25nb6y6bxkw46s-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> build01: building xv6yhg5flwcrdcm37r25nb6y6bxkw46s-dbus-1.drv 0w8vi5f1la3sia4pl9dlvn312q1i9i0j-X-Restart-Triggers-dbus-broker.drv: build01: not scheduled here: 0w8vi5f1la3sia4pl9dlvn312q1i9i0j-X-Restart-Triggers-dbus-broker.drv, asking the scheduler again building '/nix/store/0w8vi5f1la3sia4pl9dlvn312q1i9i0j-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> build01: building 0w8vi5f1la3sia4pl9dlvn312q1i9i0j-X-Restart-Triggers-dbus-broker.drv building '/nix/store/zzsdj2n3415s5h0pyayv0xvjkkk4fjgb-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build01: building zzsdj2n3415s5h0pyayv0xvjkkk4fjgb-unit-dbus-broker.service.drv building '/nix/store/8nv044ld9pil1bmwg5q4j52szymxwzxi-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build01: building 8nv044ld9pil1bmwg5q4j52szymxwzxi-unit-dbus-broker.service.drv 33bgc6ga69j154dwwxr332f9chfpdjdp-user-units.drv: build01: not scheduled here: 33bgc6ga69j154dwwxr332f9chfpdjdp-user-units.drv, asking the scheduler again v2afbjgx4rgfw38lfdzfppw8h214yfv3-system-units.drv: build01: not scheduled here: v2afbjgx4rgfw38lfdzfppw8h214yfv3-system-units.drv, asking the scheduler again building '/nix/store/33bgc6ga69j154dwwxr332f9chfpdjdp-user-units.drv' on nix-store.geninf.io:50051 user-units> build01: building 33bgc6ga69j154dwwxr332f9chfpdjdp-user-units.drv building '/nix/store/v2afbjgx4rgfw38lfdzfppw8h214yfv3-system-units.drv' on nix-store.geninf.io:50051 system-units> build01: building v2afbjgx4rgfw38lfdzfppw8h214yfv3-system-units.drv dm7s5maiv82bkx69g92vliqvz509m5gh-etc.drv: build01: not scheduled here: dm7s5maiv82bkx69g92vliqvz509m5gh-etc.drv, asking the scheduler again building '/nix/store/dm7s5maiv82bkx69g92vliqvz509m5gh-etc.drv' on nix-store.geninf.io:50051 etc> build01: building dm7s5maiv82bkx69g92vliqvz509m5gh-etc.drv 0plm9mkk01l5wfl9hrc52xsylgqs878g-activate.drv: build01: not scheduled here: 0plm9mkk01l5wfl9hrc52xsylgqs878g-activate.drv, asking the scheduler again building '/nix/store/0plm9mkk01l5wfl9hrc52xsylgqs878g-activate.drv' on nix-store.geninf.io:50051 activate> build01: building 0plm9mkk01l5wfl9hrc52xsylgqs878g-activate.drv 8ksqxl2m2d1hf31g8cm219vvd184c6ax-nixos-system-machine-test.drv: build01: not scheduled here: 8ksqxl2m2d1hf31g8cm219vvd184c6ax-nixos-system-machine-test.drv, asking the scheduler again building '/nix/store/8ksqxl2m2d1hf31g8cm219vvd184c6ax-nixos-system-machine-test.drv' on nix-store.geninf.io:50051 nixos-system-machine-test> build01: building 8ksqxl2m2d1hf31g8cm219vvd184c6ax-nixos-system-machine-test.drv nixos-system-machine-test> structuredAttrs is enabled building '/nix/store/00gpm1ya0dpnwfhziswr5vc69yifnsl7-closure-info.drv' on nix-store.geninf.io:50051 closure-info> build01: building 00gpm1ya0dpnwfhziswr5vc69yifnsl7-closure-info.drv closure-info> structuredAttrs is enabled building '/nix/store/vicw7wminbmj0h0kxvdk4a2xh4kc488w-nixos-test-driver-matrix-synapse.drv' on nix-store.geninf.io:50051 nixos-test-driver-matrix-synapse> build01: building vicw7wminbmj0h0kxvdk4a2xh4kc488w-nixos-test-driver-matrix-synapse.drv nixos-test-driver-matrix-synapse> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-matrix-synapse> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-matrix-synapse> Success: no issues found in 1 source file building '/nix/store/wxxsrps0prwqj7y217iffajzi93l0x51-container-test-run-matrix-synapse.drv' on nix-store.geninf.io:50051 container-test-run-matrix-synapse> build01: building wxxsrps0prwqj7y217iffajzi93l0x51-container-test-run-matrix-synapse.drv container-test-run-matrix-synapse> additionally exposed symbols: container-test-run-matrix-synapse> machine, container-test-run-matrix-synapse> start_all, machines, driver, Machine, wait_for_signal container-test-run-matrix-synapse> Starting machine container-test-run-matrix-synapse> container-test-run-matrix-synapse> container-test-run-matrix-synapse> <<< NixOS Stage 2 >>> container-test-run-matrix-synapse> container-test-run-matrix-synapse> booting system configuration /nix/store/hh6jf45l3v86bn9pl0i91djyzqcz2w6m-nixos-system-machine-test container-test-run-matrix-synapse> running activation script... container-test-run-matrix-synapse> setting up /etc... container-test-run-matrix-synapse> 2: host0@if3: mtu 1500 qdisc noop state DOWN mode DEFAULT group default qlen 1000 container-test-run-matrix-synapse> link/ether 0e:74:26:22:81:c2 brd ff:ff:ff:ff:ff:ff link-netnsid 0 container-test-run-matrix-synapse> setting up age secrets... container-test-run-matrix-synapse> starting systemd... container-test-run-matrix-synapse> systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) container-test-run-matrix-synapse> Detected virtualization systemd-nspawn. container-test-run-matrix-synapse> Detected architecture arm64. container-test-run-matrix-synapse> Detected first boot. container-test-run-matrix-synapse> Initializing machine ID from container UUID. container-test-run-matrix-synapse> Applying preset policy. container-test-run-matrix-synapse> Populated /etc with preset unit settings. container-test-run-matrix-synapse> Queued start job for default target Multi-User System. container-test-run-matrix-synapse> container-test-run-matrix-synapse> container-test-run-matrix-synapse> container-test-run-matrix-synapse> <<< Welcome to NixOS test (aarch64) - console >>> container-test-run-matrix-synapse> + systemd-run /bin/sh -c '/nix/store/3l7ygqcc6v0rbi9d4j1m6phi6sz86j98-coreutils-9.11/bin/sleep 999999999 && echo 2c5c9290-0117-4e3a-9242-b78098d10303' container-test-run-matrix-synapse> Running as unit: run-p481-i35962436.service; invocation ID: c9097961e28e4d2a913cbb9f54b0f00c container-test-run-matrix-synapse> To attach to container machine run on the same machine that runs the test: container-test-run-matrix-synapse> sudo nsenter --user --target $(\pgrep -f '^/bin/sh.*2c5c9290-0117-4e3a-9242-b78098d10303') --mount --uts --ipc --net --pid --cgroup /bin/sh -c bash container-test-run-matrix-synapse> container-test-run-matrix-synapse> To inject external network and continue test, run: container-test-run-matrix-synapse> sudo /nix/store/q1khrhbn506imjxx7kiqcbihycawa6kl-python3-3.13.15/bin/python3.13 /nix/store/qq5ppp119nyp6wdn1gi4pr1xkmgs2ny1-test-driver-0.0.1/lib/python3.13/site-packages/test_driver/inject_network.py 2c5c9290-0117-4e3a-9242-b78098d10303 container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + nc -z -v ::1 8008 container-test-run-matrix-synapse> Connection to ::1 8008 port [tcp/http-alt] succeeded! container-test-run-matrix-synapse> machine: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test' container-test-run-matrix-synapse> + curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test' container-test-run-matrix-synapse> (finished: waiting for success: curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test', in 0.02 seconds) container-test-run-matrix-synapse> + systemctl restart matrix-synapse container-test-run-matrix-synapse> + journalctl -u matrix-synapse --no-pager container-test-run-matrix-synapse> Oct 07 15:43:16 machine systemd[1]: Starting Synapse Matrix homeserver... container-test-run-matrix-synapse> Oct 07 15:43:19 machine matrix-synapse-pre-start[476]: Generating signing key file /var/lib/matrix-synapse/homeserver.signing.key container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: This server is configured to use 'matrix.org' as its trusted key server via the container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: server since it is long-lived, stable and trusted. However, some admins may container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: wish to use another server for this purpose. container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: To suppress this warning and continue using 'matrix.org', admins should set container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: 'suppress_key_server_warning' to 'true' in homeserver.yaml. container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse_homeserver[491]: -------------------------------------------------------------------------------- container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] ***** STARTING SERVER ***** container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Server /nix/store/928l52anrm0pvcn6k9haijzhbygjrjs5-matrix-synapse-1.162.0/bin/synapse_homeserver version 1.162.0 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Server hostname: clan.test container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Public Base URL: https://clan.test/ container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Instance name: master container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.config.logger: [main] Twisted reactor: EPollReactor container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.app.homeserver: [main] Setting up server container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.server: [main] Setting up. container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases: [main] [database config 'master']: Checking database server container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state'] container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] ['main', 'state']: Initialising new database container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v73 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/01event_failed_pull_attempts.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/02add_pusher_enabled.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/02room_id_indexes_for_purging.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/03pusher_device_id.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/03users_approved_column.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/04partial_join_details.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/04pending_device_list_updates.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/05old_push_actions.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/06thread_notifications_thread_id_idx.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/08thread_receipts_non_null.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/09partial_joined_via_destination.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/09threads_table.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 73/10_update_sqlite_fts4_tokenizer.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/10login_tokens.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/11event_search_room_id_n_distinct.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/12refactor_device_list_outbound_pokes.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/13add_device_lists_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/20_un_partial_stated_room_stream.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/21_un_partial_stated_room_stream_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/22_rebuild_user_dir_stats.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/22_un_partial_stated_event_stream.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/23_fix_thread_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 73/23_un_partial_stated_room_stream_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/24_events_jump_to_date_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 73/25drop_presence.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v74 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 74/01_user_directory_stale_remote_users.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 74/02_set_device_id_for_pushers_bg_update.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/03_membership_tables_event_stream_ordering.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 74/03_room_membership_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 74/04_delete_e2e_backup_keys_for_deactivated_users.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 74/04_membership_tables_event_stream_ordering_triggers.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 74/05_events_txn_id_device_id.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 74/90COMMENTS_destinations.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v75 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v76 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 76/01_add_profiles_full_user_id_column.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 76/02_add_user_filters_full_user_id_column.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 76/03_per_user_experimental_features.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 76/04_add_room_forgetter.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v77 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/01_add_profiles_not_valid_check.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/02_add_user_filters_not_valid_check.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 77/03bg_populate_full_user_id_profiles.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 77/04bg_populate_full_user_id_user_filters.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 77/05thread_notifications_backfill.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_actions_staging.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 77/06thread_notifications_not_null_event_push_summary.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 77/14bg_indices_event_stream_ordering.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v78 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 78/03event_extremities_constraints.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 78/04_add_full_user_id_index_user_filters.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v79 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/03_read_write_locks_triggers.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 79/04_mitigate_stream_ordering_update_race.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 79/05_read_write_locks_triggers.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v80 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 80/01_users_alter_locked.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/02_read_write_locks_unlogged.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 80/02_scheduled_tasks.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/03_read_write_locks_triggers.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 80/04_read_write_locks_deadlock.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v81 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v82 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 82/02_scheduled_tasks_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 82/04_add_indices_for_purging_rooms.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 82/05gaps.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v83 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 83/01_drop_old_tables.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 83/05_cross_signing_key_update_grant.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 83/06_event_push_summary_room.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v84 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/01_auth_links_stats.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 84/02_auth_links_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 84/03_auth_links_analyze.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 84/04_access_token_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v85 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 85/01_add_suspended.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 85/02_add_instance_names.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 85/03_new_sequences.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 85/04_cleanup_device_federation_outbox.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 85/05_add_instance_names_converted_pos.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 85/06_add_room_reports.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v86 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 86/01_authenticate_media.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 86/02_receipts_event_id_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v87 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 87/01_sliding_sync_memberships.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 87/02_per_connection_state.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 87/03_current_state_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v88 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/01_add_delayed_events.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/01_custom_profile_fields.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/02_fix_sliding_sync_membership_snapshots_forgotten_column.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/03_add_otk_ts_added_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/04_current_state_delta_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 88/05_drop_old_otks.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/05_sliding_sync_room_config_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 88/06_events_received_ts_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v89 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 89/01_sliding_sync_membership_snapshot_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 89/01_state_groups_deletion.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v90 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 90/01_add_column_participant_room_memberships_table.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 90/02_delete_unreferenced_state_groups.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 90/03_remove_old_deletion_bg_update.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v91 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 91/01_media_hash.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v92 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/01_remove_trigger.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/02_remove_populate_participant_bg_update.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/04_ss_membership_snapshot_idx.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/04_thread_subscriptions.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/04_thread_subscriptions_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/05_fixup_max_depth_cap.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/05_thread_subscriptions_comments.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/06_device_federation_inbox_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/06_threads_last_sent_stream_ordering_comments.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/07_add_user_reports.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/07_event_txn_id_device_id_txn_id2.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/08_room_ban_redactions.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/08_thread_subscriptions_seq_fixup.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 92/09_thread_subscriptions_update.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 92/09_thread_subscriptions_update.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v93 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 93/01_add_delayed_events.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 93/01_sticky_events.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 93/01_sticky_events_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 93/02_sliding_sync_members.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 93/03_sss_pos_last_used.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Running 93/04_make_delayed_event_content_text.py:run_create container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema deltas for v94 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/01_redactions_recheck.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/01_state_groups_persisting_inserted_ts.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/02_redactions_recheck_bg_update.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/03_device_lists_room_timestamp.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/03_quarantined_media_tracking.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/03_quarantined_media_tracking_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/03_state_dag_fwd_extrems.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/04_device_lists_changes_max_pruned.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/05_rerun_flag_existing_quarantined_media.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/06_sliding_sync_connections_last_used_ts_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/07_profile_updates.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying engine-specific schema 94/07_profile_updates_seq.sql.postgres container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/07_sliding_sync_lazy_members_position_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/08_device_lists_changes_in_room_unconverted_idx.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/09_e2e_cross_signing_signatures_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Applying schema 94/10_e2e_cross_signing_signatures_add_key_id_to_index.sql container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.prepare_database: [main] Schema now up to date container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.storage.databases: [main] [database config 'master']: prepared container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.server: [main] Finished setting up. container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: twisted: [main] Redirected stdout/stderr to logs container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.app.homeserver: [main] Running container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.app.homeserver: [main] Set file limit to: 524288 container-test-run-matrix-synapse> Oct 07 15:43:22 machine synapse[491]: synapse.push.pusher: [call_when_running] email enable notifs: False container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/health' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/client' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/.well-known' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/admin' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/pick_idp' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/pick_username' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/new_user_consent' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/sso_register' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/unsubscribe' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/media_upload_limit_exceeded' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/928l52anrm0pvcn6k9haijzhbygjrjs5-matrix-synapse-1.162.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/r0' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/v3' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/v1' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/federation' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/key' container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: twisted: [call_when_running] SynapseSite starting on 8008 container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008 container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.app._base: [call_when_running] garbage collector: Freezing all allocated objects in the hopes that (almost) everything currently allocated are things that will be used by the homeserver for the rest of time. Doing so means less work each GC (hopefully). container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.push.pusherpool: [start_pushers-0] Started pushers container-test-run-matrix-synapse> Oct 07 15:43:23 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[520]: Connection to ::1 8008 port [tcp/http-alt] succeeded! container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.002sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:23 machine synapse[491]: synapse.handlers.auth: [POST-1] Logging in user @admin:clan.test on device GVAINXRLLL container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.298sec/0.001sec ru=(0.260sec, 0.000sec) db=(0.004sec/0.029sec/12) 138B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:24 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[521]: Sending registration request... container-test-run-matrix-synapse> Oct 07 15:43:24 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[521]: Success! container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'threads_backfill' container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.storage.background_updates: [background_updates-0] Running background update 'threads_backfill'. Processed 0 items in 5ms. (total_rate=None/ms, current_rate=None/ms, total_updated=0, batch_size=100) container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.handlers.auth: [POST-3] Logging in user @someuser:clan.test on device VLCTGQCPLY container-test-run-matrix-synapse> Oct 07 15:43:24 machine synapse[491]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.307sec/0.001sec ru=(0.275sec, 0.000sec) db=(0.005sec/0.020sec/12) 145B 200 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:24 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[528]: Sending registration request... container-test-run-matrix-synapse> Oct 07 15:43:24 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[528]: Success! container-test-run-matrix-synapse> Oct 07 15:43:24 machine systemd[1]: Started Synapse Matrix homeserver. container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.access.http.8008: [GET-4] ::1 - 8008 - {None} Processed request: 0.001sec/-0.000sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 10145B 200 "GET /_matrix/static/ HTTP/1.1" "curl/8.22.0" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:25 machine systemd[1]: Stopping Synapse Matrix homeserver... container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: twisted: [sentinel] Received SIGTERM, shutting down. container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropping held locks due to shutdown container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.storage.databases.main.lock: [LockStore._on_shutdown-0] Dropped locks due to shutdown container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Performing _on_shutdown. Persisting 0 unpersisted changes container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.handlers.presence: [PresenceHandler._on_shutdown-0] Finished _on_shutdown container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: synapse.app._base: [log_shutdown] Shutting down... container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: twisted: [sentinel] (TCP Port 8008 Closed) container-test-run-matrix-synapse> Oct 07 15:43:25 machine synapse[491]: twisted: [sentinel] Main loop terminated. container-test-run-matrix-synapse> Oct 07 15:43:25 machine systemd[1]: matrix-synapse.service: Deactivated successfully. container-test-run-matrix-synapse> Oct 07 15:43:25 machine systemd[1]: Stopped Synapse Matrix homeserver. container-test-run-matrix-synapse> Oct 07 15:43:25 machine systemd[1]: matrix-synapse.service: Consumed 7.918s CPU time over 8.612s wall clock time. container-test-run-matrix-synapse> Oct 07 15:43:25 machine systemd[1]: Starting Synapse Matrix homeserver... container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: This server is configured to use 'matrix.org' as its trusted key server via the container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: 'trusted_key_servers' config option. 'matrix.org' is a good choice for a key container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: server since it is long-lived, stable and trusted. However, some admins may container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: wish to use another server for this purpose. container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: To suppress this warning and continue using 'matrix.org', admins should set container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: 'suppress_key_server_warning' to 'true' in homeserver.yaml. container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse_homeserver[559]: -------------------------------------------------------------------------------- container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] ***** STARTING SERVER ***** container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Server /nix/store/928l52anrm0pvcn6k9haijzhbygjrjs5-matrix-synapse-1.162.0/bin/synapse_homeserver version 1.162.0 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Copyright (c) 2023 New Vector, Inc container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Licensed under the AGPL 3.0 license. Website: https://github.com/element-hq/synapse container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Server hostname: clan.test container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Public Base URL: https://clan.test/ container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Instance name: master container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.config.logger: [main] Twisted reactor: EPollReactor container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.app.homeserver: [main] Setting up server container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.server: [main] Setting up. container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases: [main] [database config 'master']: Checking database server container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases: [main] [database config 'master']: Preparing for databases ['main', 'state'] container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.prepare_database: [main] ['main', 'state']: Checking existing schema version container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.prepare_database: [main] ['main', 'state']: Existing schema is 94 (+16 deltas) container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases.main: [main] Checking database for consistency with configuration... container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.prepare_database: [main] Applying schema deltas for v94 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.prepare_database: [main] Schema now up to date container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases: [main] [database config 'master']: Starting 'main' database container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for push_rules_enable(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 month ago container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 month ago: it's 0 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases.main.event_push_actions: [main] Searching for stream ordering 1 day ago container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases.main.event_push_actions: [main] Found stream ordering 1 day ago: it's 0 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for access_tokens(id): 3 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for refresh_tokens(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for event_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for room_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.util.id_generators: [main] Initialising stream generator for user_reports(id): 1 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases: [main] [database config 'master']: Starting 'state' database container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.databases: [main] [database config 'master']: prepared container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.server: [main] Finished setting up. container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: twisted: [main] Redirected stdout/stderr to logs container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.app.homeserver: [main] Running container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.app.homeserver: [main] Set file limit to: 524288 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.push.pusher: [call_when_running] email enable notifs: False container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'profile' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.device_list_update' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.caches.lrucache: [call_when_running] Expiring LRU caches after 1800 seconds container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.presence' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.typing' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'directory' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.handlers.deactivate_account: [user_parter_loop-0] Starting user parter container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.receipt' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.signing_key_update' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'org.matrix.signing_key_update' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation query handler for 'client_keys' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.federation.federation_server: [call_when_running] Registering federation EDU handler for 'm.direct_to_device' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/health' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/client' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/.well-known' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/admin' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/pick_idp' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/pick_username' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/new_user_consent' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/sso_register' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/unsubscribe' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_synapse/client/media_upload_limit_exceeded' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching FilePath('/nix/store/928l52anrm0pvcn6k9haijzhbygjrjs5-matrix-synapse-1.162.0/lib/python3.13/site-packages/synapse/static') to path b'/_matrix/static' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/r0' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/v3' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/media/v1' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/federation' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.util.httpresourcetree: [call_when_running] Attaching to path b'/_matrix/key' container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: twisted: [call_when_running] SynapseSite starting on 8008 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.app._base: [call_when_running] Synapse now listening on TCP port 8008 container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.app._base: [call_when_running] garbage collector: Freezing all allocated objects in the hopes that (almost) everything currently allocated are things that will be used by the homeserver for the rest of time. Doing so means less work each GC (hopefully). container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.storage.background_updates: [background_updates-0] Starting background schema updates for database master container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.handlers.deactivate_account: [user_parter_loop-0] User parter finished: stopping container-test-run-matrix-synapse> Oct 07 15:43:31 machine synapse[559]: synapse.push.pusherpool: [start_pushers-0] Started pushers container-test-run-matrix-synapse> Oct 07 15:43:31 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[584]: Connection to ::1 8008 port [tcp/http-alt] succeeded! container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.access.http.8008: [GET-0] ::1 - 8008 - {None} Processed request: 0.001sec/0.001sec ru=(0.001sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.http.server: [POST-1] SynapseError: 400 - User ID already taken. container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.access.http.8008: [POST-1] ::1 - 8008 - {None} Processed request: 0.245sec/0.000sec ru=(0.234sec, 0.003sec) db=(0.000sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:32 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[585]: Sending registration request... container-test-run-matrix-synapse> Oct 07 15:43:32 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[585]: User already exists. Skipping. container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.storage.background_updates: [background_updates-0] Starting update batch on background update 'device_lists_changes_in_room_by_room_index' container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.storage.background_updates: [background_updates-0] Adding index device_lists_changes_in_room_by_room_idx to device_lists_changes_in_room container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.storage.background_updates: [background_updates-0] Running background update 'device_lists_changes_in_room_by_room_index'. Processed 1 items in 7ms. (total_rate=0.14285714285714285/ms, current_rate=0.14285714285714285/ms, total_updated=1, batch_size=100) container-test-run-matrix-synapse> Oct 07 15:43:32 machine synapse[559]: synapse.access.http.8008: [GET-2] ::1 - 8008 - {None} Processed request: 0.000sec/0.001sec ru=(0.000sec, 0.000sec) db=(0.000sec/0.000sec/0) 140B 200 "GET /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:33 machine synapse[559]: synapse.http.server: [POST-3] SynapseError: 400 - User ID already taken. container-test-run-matrix-synapse> Oct 07 15:43:33 machine synapse[559]: synapse.access.http.8008: [POST-3] ::1 - 8008 - {None} Processed request: 0.235sec/0.000sec ru=(0.229sec, 0.000sec) db=(0.001sec/0.001sec/1) 60B 400 "POST /_synapse/admin/v1/register HTTP/1.1" "python-requests/2.33.1" [0 dbevts] container-test-run-matrix-synapse> Oct 07 15:43:33 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[591]: Sending registration request... container-test-run-matrix-synapse> Oct 07 15:43:33 machine jsq23kh2mhjk7vd6dbx3bss5lc5smnls-matrix-synapse-create-users[591]: User already exists. Skipping. container-test-run-matrix-synapse> Oct 07 15:43:33 machine systemd[1]: Started Synapse Matrix homeserver. container-test-run-matrix-synapse> + systemctl --no-pager show matrix-synapse container-test-run-matrix-synapse> + nc -z -v ::1 8008 container-test-run-matrix-synapse> Connection to ::1 8008 port [tcp/http-alt] succeeded! container-test-run-matrix-synapse> + curl -Ssf -L http://localhost/_matrix/static/ -H 'Host: matrix.clan.test' container-test-run-matrix-synapse>