Uploaded image for project: 'AdMaxLocal'
  1. AdMaxLocal
  2. AML-1112

Cannot update deploy status on orders, failing order deploy

    Details

    • Type: Bug
    • Status: Closed
    • Priority: Blocker
    • Resolution: Fixed
    • Affects Version/s: None
    • Fix Version/s: 2.0.2
    • Component/s: None
    • Labels:
      None
    • Environment:

      QA Env
      SAPI 401
      UI 2.0.2 build 28
      Core 762
      BidMgr 787

    • Sprint:
      Sprint 2

      Description

      When I deploy and order, it deploys to google properly. There is a check that updates the order status in AML when the order is deployed at google that is failing trying to update the status in AML. Here is the log:

      2013-02-01 21:01:37,003-1226937 [order-update-timer-factory] DEBUG com.thesearchagency.sapi.services.order.DeploymentServiceHelper [] - Order 41141570-f50e-4664-a494-1d0318928fd2 has deployed. Will activate it.
      2013-02-01 21:01:37,003-1226937 [order-update-timer-factory] DEBUG com.thesearchagency.sapi.services.order.DeploymentServiceHelper [] - Activating deployment of order 41141570-f50e-4664-a494-1d0318928fd2
      2013-02-01 21:01:37,004-1226938 [order-update-timer-factory] DEBUG com.thesearchagency.sapi.services.order.DeploymentServiceHelper [] - Updating deployment of order 41141570-f50e-4664-a494-1d0318928fd2
      2013-02-01 21:01:37,004-1226938 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <core:getCampaignsByCustomerID xmlns:core="http://thesearchagency.com/smb/core"><customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID></core:getCampaignsByCustomerID>
      2013-02-01 21:01:37,040-1226974 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <?xml version="1.0" encoding="UTF-8"?><CampaignListResponse><customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID><domain>www.131test.com</domain><deploymentStatus>success</deploymentStatus><campaignList><campaignID>959</campaignID><businessAreaID>10002</businessAreaID><businessLocationID>2</businessLocationID><customLandingPage><destinationURL>http://www.131test.com</destinationURL><displayURL>www.131test.com</displayURL></customLandingPage><deploymentStatus>Success</deploymentStatus><campaignStatus>paused</campaignStatus></campaignList></CampaignListResponse>
      2013-02-01 21:01:37,076-1227010 [order-update-timer-factory] DEBUG com.thesearchagency.sapi.services.order.DeploymentServiceHelper [] - BA/BL pair 10002_2 will be set to ACTIVE
      2013-02-01 21:01:37,085-1227019 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <core:updateCampaignStatus xmlns:core="http://thesearchagency.com/smb/core">
      <updateCampaignStatusRequest>
      <header>
      <requestID>41141570-f50e-4664-a494-1d0318928fd2</requestID>
      </header>
      <customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID>
      <campaignStatusList>
      <campaignID>959</campaignID>
      <campaignStatus>active</campaignStatus>
      </campaignStatusList>
      </updateCampaignStatusRequest>
      </core:updateCampaignStatus>
      2013-02-01 21:01:40,259-1230193 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <?xml version="1.0" encoding="UTF-8"?><updateCampaignStatusResponse><header><requestID>41141570-f50e-4664-a494-1d0318928fd2</requestID></header><customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID><campaignResult><campaignID>959</campaignID><result><resultCode>success</resultCode><resultString>Information: [959_GM:SUCCEEDED] [959_GT:SUCCEEDED] [959_MO:SUCCEEDED] </resultString></result></campaignResult></updateCampaignStatusResponse>
      2013-02-01 21:01:40,269-1230203 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <core:updateCampaignBudgetAccrualStatus xmlns:core="http://thesearchagency.com/smb/core">
      <updateCampaignBudgetAccrualStatusRequest>
      <header>
      <requestID>41141570-f50e-4664-a494-1d0318928fd2</requestID>
      </header>
      <customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID>
      <campaignBudgetAccrualStatusList>
      <campaignID>959</campaignID>
      <campaignBudgetAccrualStatus>active</campaignBudgetAccrualStatus>
      </campaignBudgetAccrualStatusList>
      </updateCampaignBudgetAccrualStatusRequest>
      </core:updateCampaignBudgetAccrualStatus>
      2013-02-01 21:01:40,472-1230406 [order-update-timer-factory] DEBUG com.thesearchagency.core.common.service.clients.ads.ADSClientFactoryBean [] - <?xml version="1.0" encoding="UTF-8"?><updateCampaignBudgetAccrualStatusResponse><header><requestID>41141570-f50e-4664-a494-1d0318928fd2</requestID></header><customerID>8a87b44f-b9e6-457a-b2f6-6d0a5647aaff</customerID><campaignResult><campaignID>959</campaignID><result><resultCode>success</resultCode></result></campaignResult></updateCampaignBudgetAccrualStatusResponse>
      2013-02-01 21:01:40,474-1230408 [order-update-timer-factory] DEBUG com.thesearchagency.sapi.services.order.OrderService [] - Attempting to update order '41141570-f50e-4664-a494-1d0318928fd2' for principal 'null' in realm 'com.reseller1'.
      2013-02-01 21:01:40,480-1230414 [order-update-timer-factory] DEBUG com.thesearchagency.saas.core.services.content.internal.dao.HibernateContentDao [] - Attempting to find '41141570-f50e-4664-a494-1d0318928fd2' in 'com.reseller1'.
      2013-02-01 21:01:40,503-1230437 [order-update-timer-factory] DEBUG log4jdbc.debug [] - driver name is MySQL-AB JDBC Driver
      2013-02-01 21:01:40,522-1230456 [order-update-timer-factory] DEBUG com.thesearchagency.saas.core.services.content.internal.dao.HibernateContentDao [] - Found a content record for '41141570-f50e-4664-a494-1d0318928fd2' in 'com.reseller1'.
      2013-02-01 21:01:40,525-1230459 [order-update-timer-factory] DEBUG log4jdbc.debug [] - driver name is MySQL-AB JDBC Driver
      2013-02-01 21:01:40,539-1230473 [order-update-timer-factory] DEBUG com.thesearchagency.saas.core.services.content.internal.dao.HibernateContentDao [] - Content version is null.
      2013-02-01 21:01:40,539-1230473 [order-update-timer-factory] DEBUG com.thesearchagency.saas.core.services.content.internal.dao.HibernateContentDao [] - Content was evicted? true
      2013-02-01 21:01:40,570-1230504 [order-update-timer-factory] WARN org.hibernate.util.JDBCExceptionReporter [] - SQL Error: 1048, SQLState: 23000
      2013-02-01 21:01:40,571-1230505 [order-update-timer-factory] ERROR org.hibernate.util.JDBCExceptionReporter [] - Column 'last_modified_by' cannot be null
      2013-02-01 21:01:40,575-1230509 [order-update-timer-factory] WARN com.thesearchagency.sapi.services.order.OrderStatusUpdater [] - There was an issue attempting to update the status for orders[41141570-f50e-4664-a494-1d0318928fd2]!
      org.springframework.dao.DataIntegrityViolationException: Could not execute JDBC batch update; SQL [insert into content (`created_on`, `created_by`, `deleted_at`, `last_modified_on`, `last_modified_by`, name, `parent_id`, `version`, type, value, `id`, `realm_id`) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)]; constraint [null]; nested exception is org.hibernate.exception.ConstraintViolationException: Could not execute JDBC batch update
      at org.springframework.orm.hibernate3.SessionFactoryUtils.convertHibernateAccessException(SessionFactoryUtils.java:643) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.orm.hibernate3.HibernateAccessor.convertHibernateAccessException(HibernateAccessor.java:412) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.orm.hibernate3.HibernateTemplate.doExecute(HibernateTemplate.java:411) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.orm.hibernate3.HibernateTemplate.executeWithNativeSession(HibernateTemplate.java:374) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.orm.hibernate3.HibernateTemplate.flush(HibernateTemplate.java:881) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at com.thesearchagency.saas.core.services.content.internal.dao.HibernateContentDao.updateContent(HibernateContentDao.java:148) ~[saas-core-services-content-service-component-1.0.0-SNAPSHOT.jar:1.0.0-SNAPSHOT]
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_24]
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) ~[na:1.6.0_24]
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.6.0_24]
      at java.lang.reflect.Method.invoke(Method.java:616) ~[na:1.6.0_24]
      at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:319) ~[spring-aop-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) ~[spring-aop-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) ~[spring-aop-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:110) ~[spring-tx-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) ~[spring-aop-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202) ~[spring-aop-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at $Proxy73.updateContent(Unknown Source) ~[na:na]
      at com.thesearchagency.saas.core.services.content.internal.ContentServiceComponent.updateContent(ContentServiceComponent.java:139) ~[saas-core-services-content-service-component-1.0.0-SNAPSHOT.jar:1.0.0-SNAPSHOT]
      at com.thesearchagency.sapi.services.order.OrderService.updateOrder(OrderService.java:394) ~[OrderService.class:na]
      at com.thesearchagency.sapi.services.order.DeploymentServiceHelper.checkDeploymentState(DeploymentServiceHelper.java:147) ~[DeploymentServiceHelper.class:na]
      at com.thesearchagency.sapi.services.order.DeploymentServiceHelper.updateStatus(DeploymentServiceHelper.java:94) ~[DeploymentServiceHelper.class:na]
      at com.thesearchagency.sapi.services.order.OrderStatusUpdater.run(OrderStatusUpdater.java:40) ~[OrderStatusUpdater.class:na]
      at java.util.TimerThread.mainLoop(Timer.java:534) [na:1.6.0_24]
      at java.util.TimerThread.run(Timer.java:484) [na:1.6.0_24]
      Caused by: org.hibernate.exception.ConstraintViolationException: Could not execute JDBC batch update
      at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:96) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:66) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:275) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:268) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:184) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:321) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:51) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1216) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.springframework.orm.hibernate3.HibernateTemplate$28.doInHibernate(HibernateTemplate.java:883) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      at org.springframework.orm.hibernate3.HibernateTemplate.doExecute(HibernateTemplate.java:406) ~[spring-orm-3.1.2.RELEASE.jar:3.1.2.RELEASE]
      ... 21 common frames omitted
      Caused by: java.sql.BatchUpdateException: Column 'last_modified_by' cannot be null
      at com.mysql.jdbc.PreparedStatement.executeBatchSerially(PreparedStatement.java:2024) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.PreparedStatement.executeBatch(PreparedStatement.java:1449) ~[mysql-connector-java-5.1.17.jar:na]
      at org.apache.commons.dbcp.DelegatingStatement.executeBatch(DelegatingStatement.java:297) ~[commons-dbcp-1.4.jar:1.4]
      at org.apache.commons.dbcp.DelegatingStatement.executeBatch(DelegatingStatement.java:297) ~[commons-dbcp-1.4.jar:1.4]
      at net.sf.log4jdbc.StatementSpy.executeBatch(StatementSpy.java:523) ~[log4jdbc-remix-0.2.7.jar:na]
      at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:70) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:268) ~[hibernate-core-3.6.10.Final.jar:3.6.10.Final]
      ... 28 common frames omitted
      Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLIntegrityConstraintViolationException: Column 'last_modified_by' cannot be null
      at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[na:1.6.0_24]
      at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:57) ~[na:1.6.0_24]
      at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[na:1.6.0_24]
      at java.lang.reflect.Constructor.newInstance(Constructor.java:532) ~[na:1.6.0_24]
      at com.mysql.jdbc.Util.handleNewInstance(Util.java:411) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.Util.getInstance(Util.java:386) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1039) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3597) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3529) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1990) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2151) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2625) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:2119) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:2415) ~[mysql-connector-java-5.1.17.jar:na]
      at com.mysql.jdbc.PreparedStatement.executeBatchSerially(PreparedStatement.java:1976) ~[mysql-connector-java-5.1.17.jar:na]
      ... 34 common frames omitted

        Attachments

          Activity

            People

            • Assignee:
              todd.orr Todd Orr (Inactive)
              Reporter:
              jeff.brown Jeff Brown (Inactive)
            • Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved: