Dependency Graph

Dependency Graph
related to related to child of child of duplicate of duplicate of

View Issue Details

IDProjectCategoryView StatusLast Update
0004542SOGoGUIpublic2018-09-14 17:33
Reporterardichoke Assigned Tofrancis  
PrioritynormalSeveritymajorReproducibilityalways
Status resolvedResolutionfixed 
Platform[Server] LinuxOSDebianOS Version8 (Jessie)
Product Version4.0.2 
Summary0004542: Unable to Log In After Upgrade
Description

I upgraded my sogo install from the most current v3 nightly in the Debian repositories to the latest v4 nightly build from the Debian repositories. Post-upgrade, I ran the upgrade script to upgrade the database. When trying to log in I get an "Unhandled error response" in the web interface. The sogo logs on the server have the following on each login attempt:

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName
:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVe
rsion:]): cannot insert content : <PostgreSQL72Exception: 0x5592038338b0> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (c
hannel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR
: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x5592033e23f0[SOGoAppointmentObject]:340gln5itbaojcjtt65s1jalci@google.com.ics> write fa
iled: <PostgreSQL72Exception: 0x5592038338b0> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[Pos
tgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target co
lumns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName
:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVe
rsion:]): cannot insert content : <PostgreSQL72Exception: 0x55920398fb60> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (c
hannel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR
: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x5592038bc390[SOGoAppointmentObject]:1bjcj7fqu4pg32h4mtmtt4rekb@google.com.ics> write fa
iled: <PostgreSQL72Exception: 0x55920398fb60> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[Pos
tgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target co
lumns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName
:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVe
rsion:]): cannot insert content : <PostgreSQL72Exception: 0x5592033eb320> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x55920350bd00[SOGoAppointmentObject]:7kukuqrfedlm2f9tpvqd0e47ijteh3nmrotb19ibt388ho6qsf8rp0dspaob3t2hg19g.ics> write failed: <PostgreSQL72Exception: 0x5592033eb320> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVersion:]): cannot insert content : <PostgreSQL72Exception: 0x5592033bdb90> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x55920396f0c0[SOGoAppointmentObject]:7kukuqrfedlm2f9tdllbfg58f2eb5os27ksa50eiui1sgnidr44411am8s0diovlo2kg.ics> write failed: <PostgreSQL72Exception: 0x5592033bdb90> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVersion:]): cannot insert content : <PostgreSQL72Exception: 0x559203c695b0> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x559203c88c90[SOGoAppointmentObject]:7kukuqrfedlm2f9tu8f8tpm80alckn984jn0qkqbbsfipbk39f9p5ebrdpdfd4fbhj80.ics> write failed: <PostgreSQL72Exception: 0x559203c695b0> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^

Sep 13 17:54:59 sogod [12585]: [ERROR] <0x0x559203621e60[GCSFolder]> -[GCSFolder _generateInsertStatementForRow:adaptor:tableName:]: no type found for column name c_folder_id
Sep 13 17:54:59 sogod [12585]: <0x0x559203621e60[GCSFolder]> ERROR(-[GCSFolder writeContent:fromComponent:container:toName:baseVersion:]): cannot insert content : <PostgreSQL72Exception: 0x55920397aa20> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...
^
Sep 13 17:54:59 sogod [12585]: [ERROR] <0x5592036d8d60[SOGoAppointmentObject]:6k5vqb2433uva292fq37i5g0l4@google.com.ics> write failed: <PostgreSQL72Exception: 0x55920397aa20> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x559202eb9000[PostgreSQL72Channel]: connection=<0x0x559202bf69d0[PGConnection]: connection=0x0x559202dd23a0>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...

This leads me to believe there was a schema change for the sogo_quick_appointment table which was missed in the upgrade script, but I'm unsure of what the missing change is.

Steps To Reproduce

Upgrade an existing nightly sogo debian host with data from 3.10 -> 4

TagsNo tags attached.

Relationships

has duplicate 0004544 resolvedfrancis enable to create new contacts list after upgrading from 3.2.10 to 4.0.2 
has duplicate 0004545 resolvedfrancis unable to create an event after upgrade 3.2.10 to 4.0.2 
has duplicate 0004543 resolvedfrancis Cannot create event with Mysql backend 

Activities

ardichoke

ardichoke

2018-09-13 22:30

reporter   ~0013025

After further digging, I was able to get logins to work by going into the database and removing some remote calendars the account in question was subscribed to. However, Attempting to create calendar events under that account still produces the same error about INSERT having more target columns than expressions.

ludovic

ludovic

2018-09-14 00:12

administrator   ~0013026

Try the upcoming nightly build.

ardichoke

ardichoke

2018-09-14 12:44

reporter   ~0013028

Upgraded to the latest nightly build this morning, but the issues persists. Attempting to create calendar event fails and results in the following error in the sogo logs:

Sep 14 08:41:15 sogod [2889]: [ERROR] <0x55c9f6e32c80[SOGoAppointmentObject]:B4A-5B9BAC80-1-1C7A5900.ics> write failed: <PostgreSQL72Exception: 0x55c9f6e95eb0> NAME:PostgreSQL72FatalError REASON:fatal pgsql error (channel=<0x0x55c9f6e77080[PostgreSQL72Channel]: connection=<0x0x55c9f6e77750[PGConnection]: connection=0x0x55c9f6e77960>>): ERROR: INSERT has more target columns than expressions
LINE 1: ..._component, c_partstates, c_location, c_isopaque, c_enddate)...

jisse44

jisse44

2018-09-14 13:55

reporter   ~0013031

Last edited: 2018-09-14 13:57

As I said here: https://sogo.nu/bugs/view.php?id=4545#c13030,
problem is not the upgrade.
With August 31 nightly it works well, but since at least September 13 nightly it's broken.

When I put back August 31 nighly libs in /usr/lib/sogo/ it works again

francis

francis

2018-09-14 17:29

administrator   ~0013032

https://github.com/inverse-inc/sogo/commit/d05e1fed5de900640a7383f269c9d29e87b3b278

Issue History

Date Modified Username Field Change
2018-09-13 22:12 ardichoke New Issue
2018-09-13 22:30 ardichoke Note Added: 0013025
2018-09-14 00:12 ludovic Note Added: 0013026
2018-09-14 12:44 ardichoke Note Added: 0013028
2018-09-14 13:30 francis Relationship added has duplicate 0004544
2018-09-14 13:30 francis Relationship added has duplicate 0004545
2018-09-14 13:55 jisse44 Note Added: 0013031
2018-09-14 13:57 jisse44 Note Edited: 0013031
2018-09-14 17:29 francis Note Added: 0013032
2018-09-14 17:29 francis Status new => resolved
2018-09-14 17:29 francis Resolution open => fixed
2018-09-14 17:29 francis Assigned To => francis
2018-09-14 17:33 francis Relationship added has duplicate 0004543