function storeContent(spaceNode, filename, content, props) {
        var startTime = new Date().getTime();
        logger.log("starting storeContent(" + startTime + ")" );
        var file = spaceNode.childByNamePath(filename);
        if(file == null) {
                logger.log("file does not exist, creating");
                var upload = spaceNode.createFile(filename);
                upload.content = content;
                upload.addAspect("ir:inforuptcyMetadata", props);
                upload.save();
        } else {
                logger.log("file exists, updating");

                var startTime1 = new Date().getTime();
                logger.log("calling file.content(" + startTime1 + ")" );
                file.content = content;
                var endTime1 = new Date().getTime();
                logger.log("finishing file.content(" + endTime1 + ")" );

                var startTime2 = new Date().getTime();
                logger.log("calling file.addAspect(" + startTime2 + ")" );
                file.addAspect("ir:inforuptcyMetadata", props);
                var endTime2 = new Date().getTime();
                logger.log("finishing file.addAspect(" + endTime2 + ")" );

                var startTime3 = new Date().getTime();
                logger.log("calling file.save(" + startTime3 + ")" );
                file.save();
                var endTime3 = new Date().getTime();
                logger.log("finishing file.save(" + endTime3 + ")" );
        }
        var endTime = new Date().getTime();
        logger.log("finishing storeContent(" + endTime + ")" );
}


Execution times:

1:04:02,158 DEBUG [org.alfresco.repo.jscript.ScriptLogger] starting storeContent(1306519442158)
11:04:02,158 DEBUG [org.alfresco.repo.jscript.ScriptLogger] file exists, updating
11:04:02,158 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.content(1306519442158)
11:04:02,198 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.content(1306519442198)
11:04:02,198 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.addAspect(1306519442198)
11:04:02,198 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.addAspect(1306519442198)
11:04:02,198 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.save(1306519442198)
11:04:02,208 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.save(1306519442208)
11:04:02,208 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing storeContent(1306519442208)
11:04:02,208 DEBUG [org.alfresco.repo.jscript.ScriptLogger] SUCCESS : dummy_55555_247_0.txt successfully stored in items/dockets
11:04:02,218 DEBUG [org.alfresco.repo.jscript.ScriptLogger] starting storeContent(1306519442218)
11:04:02,218 DEBUG [org.alfresco.repo.jscript.ScriptLogger] file exists, updating
11:04:02,218 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.content(1306519442218)
11:04:02,258 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.content(1306519442258)
11:04:02,258 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.addAspect(1306519442258)
11:04:02,258 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.addAspect(1306519442258)
11:04:02,258 DEBUG [org.alfresco.repo.jscript.ScriptLogger] calling file.save(1306519442258)
11:04:02,268 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing file.save(1306519442268)
11:04:02,268 DEBUG [org.alfresco.repo.jscript.ScriptLogger] finishing storeContent(1306519442268)
11:04:02,268 DEBUG [org.alfresco.repo.jscript.ScriptLogger] SUCCESS : dummy_55555_248_0.txt successfully stored in items/dockets